builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1465554101.4 results: success (0) buildid: 20160610004052 builduid: adb64b7d3b8d4f8ebce81960937b206b revision: 4253296f212b3cca52992ec5f6cd824b13153abd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:41.397149) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:41.397661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:41.397944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:41.413663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:41.414092) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465554100.695869-470040231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 03:21:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.4M=0s 2016-06-10 03:21:41 (83.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120707 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:41.550871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:41.551423) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465554100.695869-470040231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018004 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:41.601692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 03:21:41.602099) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4253296f212b3cca52992ec5f6cd824b13153abd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4253296f212b3cca52992ec5f6cd824b13153abd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465554100.695869-470040231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 03:21:41,597 truncating revision to first 12 chars 2016-06-10 03:21:41,598 Setting DEBUG logging. 2016-06-10 03:21:41,598 attempt 1/10 2016-06-10 03:21:41,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4253296f212b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 03:21:42,994 unpacking tar archive at: mozilla-aurora-4253296f212b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.725605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 03:21:43.342897) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:43.343372) ========= script_repo_revision: 4253296f212b3cca52992ec5f6cd824b13153abd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:43.343940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:43.344332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 03:21:43.355372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-10 03:21:43.355782) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465554100.695869-470040231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:43 INFO - MultiFileLogger online at 20160610 03:21:43 in /builds/slave/test 03:21:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:21:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:43 INFO - {'append_to_log': False, 03:21:43 INFO - 'base_work_dir': '/builds/slave/test', 03:21:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:43 INFO - 'branch': 'Mozilla-Aurora', 03:21:43 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:43 INFO - 'config_files': ('talos/linux_config.py',), 03:21:43 INFO - 'default_actions': ('clobber', 03:21:43 INFO - 'read-buildbot-config', 03:21:43 INFO - 'download-and-extract', 03:21:43 INFO - 'populate-webroot', 03:21:43 INFO - 'create-virtualenv', 03:21:43 INFO - 'install', 03:21:43 INFO - 'run-tests'), 03:21:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:43 INFO - 'download_minidump_stackwalk': True, 03:21:43 INFO - 'download_symbols': 'ondemand', 03:21:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:43 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:43 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:43 INFO - 'installer_path': 'installer.exe', 03:21:43 INFO - 'log_level': 'info', 03:21:43 INFO - 'log_name': 'talos', 03:21:43 INFO - 'log_to_console': True, 03:21:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:43 INFO - 'opt_config_files': (), 03:21:43 INFO - 'pip_index': False, 03:21:43 INFO - 'sps_profile': False, 03:21:43 INFO - 'sps_profile_interval': 0, 03:21:43 INFO - 'suite': 'dromaeojs', 03:21:43 INFO - 'system_bits': '32', 03:21:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:43 INFO - 'title': 'talos-linux64-ix-016', 03:21:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:43 INFO - 'use_talos_json': True, 03:21:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:43 INFO - 'work_dir': 'build'} 03:21:43 INFO - ##### 03:21:43 INFO - ##### Running clobber step. 03:21:43 INFO - ##### 03:21:43 INFO - Running pre-action listener: _resource_record_pre_action 03:21:43 INFO - Running main action method: clobber 03:21:43 INFO - rmtree: /builds/slave/test/build 03:21:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:43 INFO - Running post-action listener: _resource_record_post_action 03:21:43 INFO - ##### 03:21:43 INFO - ##### Finished clobber step (success) 03:21:43 INFO - ##### 03:21:43 INFO - ##### 03:21:43 INFO - ##### Running read-buildbot-config step. 03:21:43 INFO - ##### 03:21:43 INFO - Running pre-action listener: _resource_record_pre_action 03:21:43 INFO - Running main action method: read_buildbot_config 03:21:43 INFO - Using buildbot properties: 03:21:43 INFO - { 03:21:43 INFO - "project": "", 03:21:43 INFO - "product": "firefox", 03:21:43 INFO - "script_repo_revision": "production", 03:21:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:21:43 INFO - "repository": "", 03:21:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:21:43 INFO - "buildid": "20160610004052", 03:21:43 INFO - "stage_platform": "linux64-pgo", 03:21:43 INFO - "basedir": "/builds/slave/test", 03:21:43 INFO - "nightly_build": "True", 03:21:43 INFO - "buildnumber": 383, 03:21:43 INFO - "slavename": "talos-linux64-ix-016", 03:21:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:21:43 INFO - "platform": "ubuntu64_hw", 03:21:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:21:43 INFO - "branch": "mozilla-aurora", 03:21:43 INFO - "repo_path": "releases/mozilla-aurora", 03:21:43 INFO - "revision": "4253296f212b3cca52992ec5f6cd824b13153abd", 03:21:43 INFO - "pgo_build": "True", 03:21:43 INFO - "builduid": "adb64b7d3b8d4f8ebce81960937b206b", 03:21:43 INFO - "slavebuilddir": "test" 03:21:43 INFO - } 03:21:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:21:43 INFO - Running post-action listener: _resource_record_post_action 03:21:43 INFO - ##### 03:21:43 INFO - ##### Finished read-buildbot-config step (success) 03:21:43 INFO - ##### 03:21:43 INFO - ##### 03:21:43 INFO - ##### Running download-and-extract step. 03:21:43 INFO - ##### 03:21:43 INFO - Running pre-action listener: _resource_record_pre_action 03:21:43 INFO - Running main action method: download_and_extract 03:21:43 INFO - mkdir: /builds/slave/test/build/tests 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:43 INFO - https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:21:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:21:44 INFO - Downloaded 1361 bytes. 03:21:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:21:44 INFO - Using the following test package requirements: 03:21:44 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:44 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:21:44 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:21:44 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:44 INFO - u'jsshell-linux-x86_64.zip'], 03:21:44 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:21:44 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:44 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:21:44 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:21:44 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:21:44 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:21:44 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:44 INFO - https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:21:45 INFO - Downloaded 24473984 bytes. 03:21:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:21:46 INFO - Return code: 0 03:21:46 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:46 INFO - https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:21:48 INFO - Downloaded 24473984 bytes. 03:21:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:21:49 INFO - Return code: 0 03:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:49 INFO - https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:21:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:21:50 INFO - Downloaded 10833369 bytes. 03:21:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:21:50 INFO - Return code: 0 03:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:50 INFO - https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:21:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:21:52 INFO - Downloaded 63534333 bytes. 03:21:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:52 INFO - mkdir: /builds/slave/test/properties 03:21:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:52 INFO - Contents: 03:21:52 INFO - build_url:https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:21:52 INFO - Running post-action listener: _resource_record_post_action 03:21:52 INFO - Running post-action listener: set_extra_try_arguments 03:21:52 INFO - ##### 03:21:52 INFO - ##### Finished download-and-extract step (success) 03:21:52 INFO - ##### 03:21:52 INFO - ##### 03:21:52 INFO - ##### Running populate-webroot step. 03:21:52 INFO - ##### 03:21:52 INFO - Running pre-action listener: _resource_record_pre_action 03:21:52 INFO - Running main action method: populate_webroot 03:21:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:52 INFO - '--tppagecycles', 03:21:52 INFO - '7'], 03:21:52 INFO - 'tests': ['tsvgm']}}, 03:21:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:52 INFO - 'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:52 INFO - 'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['damp', 'tps']}, 03:21:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:52 INFO - 'tests': ['damp', 'tps']}, 03:21:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['dromaeo_dom']}, 03:21:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['a11yr', 03:21:52 INFO - 'ts_paint', 03:21:52 INFO - 'tpaint', 03:21:52 INFO - 'sessionrestore', 03:21:52 INFO - 'sessionrestore_no_auto_restore', 03:21:52 INFO - 'tabpaint']}, 03:21:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:52 INFO - 'ts_paint', 03:21:52 INFO - 'tpaint', 03:21:52 INFO - 'sessionrestore', 03:21:52 INFO - 'sessionrestore_no_auto_restore', 03:21:52 INFO - 'tabpaint']}, 03:21:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:52 INFO - 'ts_paint', 03:21:52 INFO - 'tpaint', 03:21:52 INFO - 'sessionrestore', 03:21:52 INFO - 'sessionrestore_no_auto_restore', 03:21:52 INFO - 'tabpaint']}, 03:21:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:52 INFO - 'ts_paint', 03:21:52 INFO - 'tpaint', 03:21:52 INFO - 'sessionrestore', 03:21:52 INFO - 'sessionrestore_no_auto_restore', 03:21:52 INFO - 'tabpaint']}, 03:21:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['a11yr', 03:21:52 INFO - 'ts_paint', 03:21:52 INFO - 'tpaint', 03:21:52 INFO - 'sessionrestore', 03:21:52 INFO - 'sessionrestore_no_auto_restore', 03:21:52 INFO - 'tabpaint']}, 03:21:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['a11yr', 03:21:52 INFO - 'ts_paint', 03:21:52 INFO - 'tpaint', 03:21:52 INFO - 'sessionrestore', 03:21:52 INFO - 'sessionrestore_no_auto_restore', 03:21:52 INFO - 'tabpaint']}, 03:21:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['tsvgx', 03:21:52 INFO - 'tsvgr_opacity', 03:21:52 INFO - 'tart', 03:21:52 INFO - 'tscrollx', 03:21:52 INFO - 'cart']}, 03:21:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:52 INFO - 'tsvgr_opacity', 03:21:52 INFO - 'tart', 03:21:52 INFO - 'tscrollx', 03:21:52 INFO - 'cart']}, 03:21:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:52 INFO - 'talos_options': ['--disable-e10s'], 03:21:52 INFO - 'tests': ['tp5o']}, 03:21:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:52 INFO - 'tests': ['tp5o']}, 03:21:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:52 INFO - 'talos_options': ['--disable-e10s', 03:21:52 INFO - '--xperf_path', 03:21:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:52 INFO - 'tests': ['tp5n']}, 03:21:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:52 INFO - 'talos_options': ['--xperf_path', 03:21:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:52 INFO - 'tests': ['tp5n']}}, 03:21:52 INFO - 'talos.zip': {'path': '', 03:21:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:52 INFO - Running post-action listener: _resource_record_post_action 03:21:52 INFO - ##### 03:21:52 INFO - ##### Finished populate-webroot step (success) 03:21:52 INFO - ##### 03:21:52 INFO - ##### 03:21:52 INFO - ##### Running create-virtualenv step. 03:21:52 INFO - ##### 03:21:52 INFO - Running pre-action listener: _resource_record_pre_action 03:21:52 INFO - Running main action method: create_virtualenv 03:21:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:21:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:52 INFO - Using real prefix '/usr' 03:21:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:55 INFO - Installing pip.................done. 03:21:55 INFO - Return code: 0 03:21:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:21:55 INFO - Using env: {'DISPLAY': ':0', 03:21:55 INFO - 'HOME': '/home/cltbld', 03:21:55 INFO - 'LANG': 'en_US.UTF-8', 03:21:55 INFO - 'LANGUAGE': 'en_US:en', 03:21:55 INFO - 'LOGNAME': 'cltbld', 03:21:55 INFO - 'MAIL': '/var/mail/cltbld', 03:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:55 INFO - 'MOZ_NO_REMOTE': '1', 03:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:55 INFO - 'NO_EM_RESTART': '1', 03:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:55 INFO - 'PWD': '/builds/slave/test', 03:21:55 INFO - 'SHELL': '/bin/bash', 03:21:55 INFO - 'SHLVL': '1', 03:21:55 INFO - 'TERM': 'linux', 03:21:55 INFO - 'TMOUT': '86400', 03:21:55 INFO - 'USER': 'cltbld', 03:21:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:55 INFO - '_': '/tools/buildbot/bin/python'} 03:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:21:55 INFO - Cleaning up... 03:21:55 INFO - Return code: 0 03:21:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:21:55 INFO - Using env: {'DISPLAY': ':0', 03:21:55 INFO - 'HOME': '/home/cltbld', 03:21:55 INFO - 'LANG': 'en_US.UTF-8', 03:21:55 INFO - 'LANGUAGE': 'en_US:en', 03:21:55 INFO - 'LOGNAME': 'cltbld', 03:21:55 INFO - 'MAIL': '/var/mail/cltbld', 03:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:55 INFO - 'MOZ_NO_REMOTE': '1', 03:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:55 INFO - 'NO_EM_RESTART': '1', 03:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:55 INFO - 'PWD': '/builds/slave/test', 03:21:55 INFO - 'SHELL': '/bin/bash', 03:21:55 INFO - 'SHLVL': '1', 03:21:55 INFO - 'TERM': 'linux', 03:21:55 INFO - 'TMOUT': '86400', 03:21:55 INFO - 'USER': 'cltbld', 03:21:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:55 INFO - '_': '/tools/buildbot/bin/python'} 03:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:55 INFO - Downloading/unpacking psutil>=3.1.1 03:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:57 INFO - Installing collected packages: psutil 03:21:57 INFO - Running setup.py install for psutil 03:21:57 INFO - building 'psutil._psutil_linux' extension 03:21:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:21:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:21:58 INFO - building 'psutil._psutil_posix' extension 03:21:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:21:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:21:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:58 INFO - Successfully installed psutil 03:21:58 INFO - Cleaning up... 03:21:58 INFO - Return code: 0 03:21:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:21:58 INFO - Using env: {'DISPLAY': ':0', 03:21:58 INFO - 'HOME': '/home/cltbld', 03:21:58 INFO - 'LANG': 'en_US.UTF-8', 03:21:58 INFO - 'LANGUAGE': 'en_US:en', 03:21:58 INFO - 'LOGNAME': 'cltbld', 03:21:58 INFO - 'MAIL': '/var/mail/cltbld', 03:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:58 INFO - 'MOZ_NO_REMOTE': '1', 03:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:58 INFO - 'NO_EM_RESTART': '1', 03:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:58 INFO - 'PWD': '/builds/slave/test', 03:21:58 INFO - 'SHELL': '/bin/bash', 03:21:58 INFO - 'SHLVL': '1', 03:21:58 INFO - 'TERM': 'linux', 03:21:58 INFO - 'TMOUT': '86400', 03:21:58 INFO - 'USER': 'cltbld', 03:21:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:58 INFO - '_': '/tools/buildbot/bin/python'} 03:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:22:00 INFO - Installing collected packages: mozsystemmonitor 03:22:00 INFO - Running setup.py install for mozsystemmonitor 03:22:00 INFO - Successfully installed mozsystemmonitor 03:22:00 INFO - Cleaning up... 03:22:00 INFO - Return code: 0 03:22:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:22:00 INFO - Using env: {'DISPLAY': ':0', 03:22:00 INFO - 'HOME': '/home/cltbld', 03:22:00 INFO - 'LANG': 'en_US.UTF-8', 03:22:00 INFO - 'LANGUAGE': 'en_US:en', 03:22:00 INFO - 'LOGNAME': 'cltbld', 03:22:00 INFO - 'MAIL': '/var/mail/cltbld', 03:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:00 INFO - 'MOZ_NO_REMOTE': '1', 03:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:00 INFO - 'NO_EM_RESTART': '1', 03:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:00 INFO - 'PWD': '/builds/slave/test', 03:22:00 INFO - 'SHELL': '/bin/bash', 03:22:00 INFO - 'SHLVL': '1', 03:22:00 INFO - 'TERM': 'linux', 03:22:00 INFO - 'TMOUT': '86400', 03:22:00 INFO - 'USER': 'cltbld', 03:22:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:00 INFO - '_': '/tools/buildbot/bin/python'} 03:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:00 INFO - Downloading/unpacking jsonschema==2.5.1 03:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:03 INFO - warning: no files found matching '*.txt' 03:22:03 INFO - no previously-included directories found matching 'build' 03:22:03 INFO - no previously-included directories found matching 'dist' 03:22:03 INFO - no previously-included directories found matching '.git*' 03:22:03 INFO - Installing collected packages: jsonschema, functools32 03:22:03 INFO - Running setup.py install for functools32 03:22:03 INFO - warning: no files found matching '*.txt' 03:22:03 INFO - no previously-included directories found matching 'build' 03:22:03 INFO - no previously-included directories found matching 'dist' 03:22:03 INFO - no previously-included directories found matching '.git*' 03:22:03 INFO - Successfully installed jsonschema functools32 03:22:03 INFO - Cleaning up... 03:22:03 INFO - Return code: 0 03:22:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:22:03 INFO - Using env: {'DISPLAY': ':0', 03:22:03 INFO - 'HOME': '/home/cltbld', 03:22:03 INFO - 'LANG': 'en_US.UTF-8', 03:22:03 INFO - 'LANGUAGE': 'en_US:en', 03:22:03 INFO - 'LOGNAME': 'cltbld', 03:22:03 INFO - 'MAIL': '/var/mail/cltbld', 03:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:03 INFO - 'MOZ_NO_REMOTE': '1', 03:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:03 INFO - 'NO_EM_RESTART': '1', 03:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:03 INFO - 'PWD': '/builds/slave/test', 03:22:03 INFO - 'SHELL': '/bin/bash', 03:22:03 INFO - 'SHLVL': '1', 03:22:03 INFO - 'TERM': 'linux', 03:22:03 INFO - 'TMOUT': '86400', 03:22:03 INFO - 'USER': 'cltbld', 03:22:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:03 INFO - '_': '/tools/buildbot/bin/python'} 03:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:06 INFO - Downloading docopt-0.6.1.tar.gz 03:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:06 INFO - Running setup.py install for blobuploader 03:22:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:06 INFO - Running setup.py install for requests 03:22:06 INFO - Running setup.py install for docopt 03:22:06 INFO - Successfully installed blobuploader requests docopt 03:22:06 INFO - Cleaning up... 03:22:06 INFO - Return code: 0 03:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:22:06 INFO - Using env: {'DISPLAY': ':0', 03:22:06 INFO - 'HOME': '/home/cltbld', 03:22:06 INFO - 'LANG': 'en_US.UTF-8', 03:22:06 INFO - 'LANGUAGE': 'en_US:en', 03:22:06 INFO - 'LOGNAME': 'cltbld', 03:22:06 INFO - 'MAIL': '/var/mail/cltbld', 03:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:06 INFO - 'MOZ_NO_REMOTE': '1', 03:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:06 INFO - 'NO_EM_RESTART': '1', 03:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:06 INFO - 'PWD': '/builds/slave/test', 03:22:06 INFO - 'SHELL': '/bin/bash', 03:22:06 INFO - 'SHLVL': '1', 03:22:06 INFO - 'TERM': 'linux', 03:22:06 INFO - 'TMOUT': '86400', 03:22:06 INFO - 'USER': 'cltbld', 03:22:06 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:06 INFO - '_': '/tools/buildbot/bin/python'} 03:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:07 INFO - Running setup.py (path:/tmp/pip-op5b9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:07 INFO - Running setup.py (path:/tmp/pip-Ikpisb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:07 INFO - Running setup.py (path:/tmp/pip-lkOyaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:07 INFO - Running setup.py (path:/tmp/pip-NatvOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:07 INFO - Running setup.py (path:/tmp/pip-tmsERs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:07 INFO - Running setup.py (path:/tmp/pip-gIHuMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:07 INFO - Running setup.py (path:/tmp/pip-pRCnNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:07 INFO - Running setup.py (path:/tmp/pip-gIiCA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:07 INFO - Running setup.py (path:/tmp/pip-O8phPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:07 INFO - Running setup.py (path:/tmp/pip-DEp6oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:07 INFO - Running setup.py (path:/tmp/pip-MidG6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:07 INFO - Running setup.py (path:/tmp/pip-SD1ZV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:07 INFO - Running setup.py (path:/tmp/pip-QCsyTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:07 INFO - Running setup.py (path:/tmp/pip-MbTNoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:08 INFO - Running setup.py (path:/tmp/pip-UYwkMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:08 INFO - Running setup.py (path:/tmp/pip-qYaIZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:08 INFO - Running setup.py (path:/tmp/pip-4wIs6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:08 INFO - Running setup.py install for manifestparser 03:22:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:08 INFO - Running setup.py install for mozcrash 03:22:08 INFO - Running setup.py install for mozdebug 03:22:08 INFO - Running setup.py install for mozdevice 03:22:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:08 INFO - Running setup.py install for mozfile 03:22:08 INFO - Running setup.py install for mozhttpd 03:22:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:08 INFO - Running setup.py install for mozinfo 03:22:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:08 INFO - Running setup.py install for mozInstall 03:22:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Running setup.py install for mozleak 03:22:09 INFO - Running setup.py install for mozlog 03:22:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Running setup.py install for moznetwork 03:22:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Running setup.py install for mozprocess 03:22:09 INFO - Running setup.py install for mozprofile 03:22:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Running setup.py install for mozrunner 03:22:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:22:09 INFO - Running setup.py install for mozscreenshot 03:22:09 INFO - Running setup.py install for moztest 03:22:09 INFO - Running setup.py install for mozversion 03:22:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:22:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:10 INFO - Cleaning up... 03:22:10 INFO - Return code: 0 03:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:22:10 INFO - Using env: {'DISPLAY': ':0', 03:22:10 INFO - 'HOME': '/home/cltbld', 03:22:10 INFO - 'LANG': 'en_US.UTF-8', 03:22:10 INFO - 'LANGUAGE': 'en_US:en', 03:22:10 INFO - 'LOGNAME': 'cltbld', 03:22:10 INFO - 'MAIL': '/var/mail/cltbld', 03:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:10 INFO - 'MOZ_NO_REMOTE': '1', 03:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:10 INFO - 'NO_EM_RESTART': '1', 03:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:10 INFO - 'PWD': '/builds/slave/test', 03:22:10 INFO - 'SHELL': '/bin/bash', 03:22:10 INFO - 'SHLVL': '1', 03:22:10 INFO - 'TERM': 'linux', 03:22:10 INFO - 'TMOUT': '86400', 03:22:10 INFO - 'USER': 'cltbld', 03:22:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:10 INFO - '_': '/tools/buildbot/bin/python'} 03:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:10 INFO - Running setup.py (path:/tmp/pip-GTD_P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:10 INFO - Running setup.py (path:/tmp/pip-cM1qHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:10 INFO - Running setup.py (path:/tmp/pip-ajuONa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:10 INFO - Running setup.py (path:/tmp/pip-U1YbKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:10 INFO - Running setup.py (path:/tmp/pip-5mgHv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:10 INFO - Running setup.py (path:/tmp/pip-gVUU0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:10 INFO - Running setup.py (path:/tmp/pip-K8zJLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:10 INFO - Running setup.py (path:/tmp/pip-zngPwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:10 INFO - Running setup.py (path:/tmp/pip-tNYje5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:10 INFO - Running setup.py (path:/tmp/pip-uhdsX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:10 INFO - Running setup.py (path:/tmp/pip-_WDWV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:11 INFO - Running setup.py (path:/tmp/pip-DsTC5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:11 INFO - Running setup.py (path:/tmp/pip-yrikqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:11 INFO - Running setup.py (path:/tmp/pip-atlJiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:11 INFO - Running setup.py (path:/tmp/pip-XH4GtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:11 INFO - Running setup.py (path:/tmp/pip-mNS2fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:11 INFO - Running setup.py (path:/tmp/pip-910Nlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:22:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:13 INFO - Downloading blessings-1.6.tar.gz 03:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:13 INFO - Installing collected packages: blessings 03:22:13 INFO - Running setup.py install for blessings 03:22:13 INFO - Successfully installed blessings 03:22:13 INFO - Cleaning up... 03:22:13 INFO - Return code: 0 03:22:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:13 INFO - Reading from file tmpfile_stdout 03:22:13 INFO - Current package versions: 03:22:13 INFO - argparse == 1.2.1 03:22:13 INFO - blessings == 1.6 03:22:13 INFO - blobuploader == 1.2.4 03:22:13 INFO - docopt == 0.6.1 03:22:13 INFO - functools32 == 3.2.3-2 03:22:13 INFO - jsonschema == 2.5.1 03:22:13 INFO - manifestparser == 1.1 03:22:13 INFO - mozInstall == 1.12 03:22:13 INFO - mozcrash == 0.17 03:22:13 INFO - mozdebug == 0.1 03:22:13 INFO - mozdevice == 0.48 03:22:13 INFO - mozfile == 1.2 03:22:13 INFO - mozhttpd == 0.7 03:22:13 INFO - mozinfo == 0.9 03:22:13 INFO - mozleak == 0.1 03:22:13 INFO - mozlog == 3.2 03:22:13 INFO - moznetwork == 0.27 03:22:13 INFO - mozprocess == 0.22 03:22:13 INFO - mozprofile == 0.28 03:22:13 INFO - mozrunner == 6.11 03:22:13 INFO - mozscreenshot == 0.1 03:22:13 INFO - mozsystemmonitor == 0.3 03:22:13 INFO - moztest == 0.7 03:22:13 INFO - mozversion == 1.4 03:22:13 INFO - psutil == 3.1.1 03:22:13 INFO - requests == 1.2.3 03:22:13 INFO - wsgiref == 0.1.2 03:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:22:13 INFO - Using env: {'DISPLAY': ':0', 03:22:13 INFO - 'HOME': '/home/cltbld', 03:22:13 INFO - 'LANG': 'en_US.UTF-8', 03:22:13 INFO - 'LANGUAGE': 'en_US:en', 03:22:13 INFO - 'LOGNAME': 'cltbld', 03:22:13 INFO - 'MAIL': '/var/mail/cltbld', 03:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:13 INFO - 'MOZ_NO_REMOTE': '1', 03:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:13 INFO - 'NO_EM_RESTART': '1', 03:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:13 INFO - 'PWD': '/builds/slave/test', 03:22:13 INFO - 'SHELL': '/bin/bash', 03:22:13 INFO - 'SHLVL': '1', 03:22:13 INFO - 'TERM': 'linux', 03:22:13 INFO - 'TMOUT': '86400', 03:22:13 INFO - 'USER': 'cltbld', 03:22:13 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:13 INFO - '_': '/tools/buildbot/bin/python'} 03:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:22:14 INFO - Cleaning up... 03:22:14 INFO - Return code: 0 03:22:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:22:14 INFO - Using env: {'DISPLAY': ':0', 03:22:14 INFO - 'HOME': '/home/cltbld', 03:22:14 INFO - 'LANG': 'en_US.UTF-8', 03:22:14 INFO - 'LANGUAGE': 'en_US:en', 03:22:14 INFO - 'LOGNAME': 'cltbld', 03:22:14 INFO - 'MAIL': '/var/mail/cltbld', 03:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:14 INFO - 'MOZ_NO_REMOTE': '1', 03:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:14 INFO - 'NO_EM_RESTART': '1', 03:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:14 INFO - 'PWD': '/builds/slave/test', 03:22:14 INFO - 'SHELL': '/bin/bash', 03:22:14 INFO - 'SHLVL': '1', 03:22:14 INFO - 'TERM': 'linux', 03:22:14 INFO - 'TMOUT': '86400', 03:22:14 INFO - 'USER': 'cltbld', 03:22:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:14 INFO - '_': '/tools/buildbot/bin/python'} 03:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:22:14 INFO - Cleaning up... 03:22:14 INFO - Return code: 0 03:22:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c760dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:22:14 INFO - Using env: {'DISPLAY': ':0', 03:22:14 INFO - 'HOME': '/home/cltbld', 03:22:14 INFO - 'LANG': 'en_US.UTF-8', 03:22:14 INFO - 'LANGUAGE': 'en_US:en', 03:22:14 INFO - 'LOGNAME': 'cltbld', 03:22:14 INFO - 'MAIL': '/var/mail/cltbld', 03:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:14 INFO - 'MOZ_NO_REMOTE': '1', 03:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:14 INFO - 'NO_EM_RESTART': '1', 03:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:14 INFO - 'PWD': '/builds/slave/test', 03:22:14 INFO - 'SHELL': '/bin/bash', 03:22:14 INFO - 'SHLVL': '1', 03:22:14 INFO - 'TERM': 'linux', 03:22:14 INFO - 'TMOUT': '86400', 03:22:14 INFO - 'USER': 'cltbld', 03:22:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:14 INFO - '_': '/tools/buildbot/bin/python'} 03:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:14 INFO - Downloading/unpacking flake8 03:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:22:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:22:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:17 INFO - no previously-included directories found matching 'docs/_build' 03:22:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:22:17 INFO - Running setup.py install for pep8 03:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:17 INFO - no previously-included directories found matching 'docs/_build' 03:22:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:22:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:22:17 INFO - Cleaning up... 03:22:17 INFO - Return code: 0 03:22:17 INFO - Running post-action listener: _resource_record_post_action 03:22:17 INFO - Running post-action listener: _start_resource_monitoring 03:22:17 INFO - Starting resource monitoring. 03:22:17 INFO - ##### 03:22:17 INFO - ##### Finished create-virtualenv step (success) 03:22:17 INFO - ##### 03:22:17 INFO - ##### 03:22:17 INFO - ##### Running install step. 03:22:17 INFO - ##### 03:22:17 INFO - Running pre-action listener: _resource_record_pre_action 03:22:17 INFO - Running main action method: install 03:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:17 INFO - Reading from file tmpfile_stdout 03:22:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:17 INFO - Reading from file tmpfile_stdout 03:22:17 INFO - Output received: 03:22:17 INFO - Usage: mozinstall [options] installer 03:22:17 INFO - Options: 03:22:17 INFO - -h, --help show this help message and exit 03:22:17 INFO - -d DEST, --destination=DEST 03:22:17 INFO - Directory to install application into. [default: 03:22:17 INFO - "/builds/slave/test"] 03:22:17 INFO - --app=APP Application being installed. [default: firefox] 03:22:17 INFO - mkdir: /builds/slave/test/build/application 03:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:22:33 INFO - Reading from file tmpfile_stdout 03:22:33 INFO - Output received: 03:22:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:22:33 INFO - Running post-action listener: _resource_record_post_action 03:22:33 INFO - ##### 03:22:33 INFO - ##### Finished install step (success) 03:22:33 INFO - ##### 03:22:33 INFO - ##### 03:22:33 INFO - ##### Running run-tests step. 03:22:33 INFO - ##### 03:22:33 INFO - Running pre-action listener: _resource_record_pre_action 03:22:33 INFO - Running main action method: run_tests 03:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:33 INFO - Python 2.7.3 03:22:33 INFO - Return code: 0 03:22:33 INFO - grabbing minidump binary from tooltool 03:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:22:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:22:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:22:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:33 INFO - Return code: 0 03:22:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:22:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:22:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:22:34 INFO - Return code: 0 03:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:22:34 INFO - Using env: {'DISPLAY': ':0', 03:22:34 INFO - 'HOME': '/home/cltbld', 03:22:34 INFO - 'LANG': 'en_US.UTF-8', 03:22:34 INFO - 'LANGUAGE': 'en_US:en', 03:22:34 INFO - 'LOGNAME': 'cltbld', 03:22:34 INFO - 'MAIL': '/var/mail/cltbld', 03:22:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:34 INFO - 'MOZ_NO_REMOTE': '1', 03:22:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:34 INFO - 'NO_EM_RESTART': '1', 03:22:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:34 INFO - 'PWD': '/builds/slave/test', 03:22:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:34 INFO - 'SHELL': '/bin/bash', 03:22:34 INFO - 'SHLVL': '1', 03:22:34 INFO - 'TERM': 'linux', 03:22:34 INFO - 'TMOUT': '86400', 03:22:34 INFO - 'USER': 'cltbld', 03:22:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465554100.695869-470040231', 03:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:34 INFO - '_': '/tools/buildbot/bin/python'} 03:22:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:22:34 INFO - mozversion application_buildid: 20160610004052 03:22:34 INFO - mozversion application_changeset: 4253296f212b3cca52992ec5f6cd824b13153abd 03:22:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:22:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:34 INFO - mozversion application_name: Firefox 03:22:34 INFO - mozversion application_remotingname: firefox-dev 03:22:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:34 INFO - mozversion application_vendor: Mozilla 03:22:34 INFO - mozversion application_version: 49.0a2 03:22:34 INFO - mozversion platform_buildid: 20160610004052 03:22:34 INFO - mozversion platform_changeset: 4253296f212b3cca52992ec5f6cd824b13153abd 03:22:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:34 INFO - mozversion platform_version: 49.0a2 03:22:34 INFO - using testdate: 1465554154 03:22:34 INFO - actual date: 1465554154 03:22:34 INFO - starting webserver on 'localhost:40050' 03:22:34 INFO - SUITE-START | Running 2 tests 03:22:34 INFO - TEST-START | dromaeo_css 03:22:34 INFO - operating with platform_type : linux_ 03:22:34 INFO - Initialising browser for dromaeo_css test... 03:22:34 INFO - TEST-INFO | started process 4874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiStkqG/profile http://localhost:40050/getInfo.html) 03:22:38 INFO - PROCESS | 4874 | __metrics Screen width/height:1600/1200 03:22:38 INFO - PROCESS | 4874 | colorDepth:24 03:22:38 INFO - PROCESS | 4874 | Browser inner width/height: 1024/697 03:22:38 INFO - PROCESS | 4874 | __metrics 03:22:39 ERROR - PROCESS | 4874 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:22:39 INFO - PROCESS | 4874 | console.error: PushService: 03:22:39 INFO - PROCESS | 4874 | stateChangeProcessEnqueue: Error transitioning state 03:22:39 INFO - PROCESS | 4874 | UnknownError 03:22:40 INFO - TEST-INFO | 4874: exit 0 03:22:40 INFO - Browser initialized. 03:22:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:40 INFO - TEST-INFO | started process 4962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiStkqG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:52 INFO - PROCESS | 4962 | RSS: Main: 145330176 03:22:52 INFO - PROCESS | 4962 | 03:23:43 INFO - PROCESS | 4962 | 1465554223176 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:25:51 INFO - PROCESS | 4962 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40050/tests/dromaeo/cssquery-ext.html) 03:25:52 INFO - PROCESS | 4962 | RSS: Main: 234852352 03:25:52 INFO - PROCESS | 4962 | 03:28:55 INFO - PROCESS | 4962 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-ext.html (next: http://localhost:40050/tests/dromaeo/cssquery-jquery.html) 03:28:55 INFO - PROCESS | 4962 | RSS: Main: 225546240 03:28:55 INFO - PROCESS | 4962 | 03:31:57 INFO - PROCESS | 4962 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40050/tests/dromaeo/cssquery-mootools.html) 03:31:58 INFO - PROCESS | 4962 | RSS: Main: 222445568 03:31:58 INFO - PROCESS | 4962 | 03:34:59 INFO - PROCESS | 4962 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40050/tests/dromaeo/cssquery-prototype.html) 03:35:00 INFO - PROCESS | 4962 | RSS: Main: 220037120 03:35:00 INFO - PROCESS | 4962 | 03:38:03 INFO - PROCESS | 4962 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40050/tests/dromaeo/cssquery-yui.html) 03:38:03 INFO - PROCESS | 4962 | RSS: Main: 216821760 03:38:03 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | Cycle 1(1): loaded http://localhost:40050/tests/dromaeo/cssquery-yui.html (next: http://localhost:40050/tests/dromaeo/cssquery-dojo.html) 03:41:06 INFO - PROCESS | 4962 | RSS: Main: 259391488 03:41:06 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | __start_tp_report 03:41:06 INFO - PROCESS | 4962 | _x_x_mozilla_page_load 03:41:06 INFO - PROCESS | 4962 | _x_x_mozilla_page_load_details 03:41:06 INFO - PROCESS | 4962 | |i|pagename|runs| 03:41:06 INFO - PROCESS | 4962 | |0;dojo.html;3341.5154802553625;3368.2084710093122;3372.2749608834097;3384.373890830198;3428.725701943845;5546.750396232169;5592;5625.80309689161;5626.943730562693;5652;5511.421300763423;5552.555795536357;5563.860903477415;5576.442355764421;5604.775808967636;4989.57588604969;4998.075356059123;5028.7988480460735;5042.042012017723;5082.949170508285;4941.431735350427;4979.103761322978;5035.521625445577;5134.922976155361;5135.9743201283945;5089.796408143669;5101.51535604117;5114.105031619451;5123.487651234884;5124;5106.540411362995;5128.000039992222;5133.794648214067;5136.871578210537;5157.226416037587;4893.290472881412;4926.5812405945535;4959.107360675077;5027.994401119754;5045.117104506697;5445.101558242885;5465;5490.505854473116;5522.66863988162;5597.552195824324;5958.314793798725;5999.370066143036;6049.48579370754;6057.636541807506;6061.454469097758;5854.912176317359;5857.70711464425;5898.616589921641;6056.636601803906;6096.542759293026;5528.226048353234;5533.501984821385;5555.2778138842505;5569.526590239794;5571.9442805572235;6092;6125.974972785665;6131.785387511416;6138.78514252008;6140.969295153495;5612.579056570774;5717.085266357446;5720.68536230503;5767.913481297784;5900.7049647518315;5931.6441013539325;5933.525317974551;5941.970290148522;5942.435468630473;5960.7019649017375;5877.52979761618;5879.617824841372;5896.056630939029;5898.970505147533;5900.76396944126;5750.367459579443;5853.88292234153;5857.062869940789;5900.76396944126;5944.970275148597;4553.658475614276;4554.111948170142;4556.179887620194;4556.612687921497;4587.518310577408;4018.9196216075516;4026.1947610478023;4096.692748043909;4103.630673239423;4127.277726397869;5511.063119269654;5558.221848941152;5560.193771903132;5565.638233514808;5605.299337582802;5914.349421563625;5919.4080591940465;5927.555433342516;5929.318128415288;5993.160957465958;5398.514133727984;5486.341639003345;5513.145462453326;5529.4470552944385;5567.498925096761;4927.940492794067;4944.357233559686;4944.53026962438;4947.826826061142;4965.131102057126;6114.847128821815;6186.845328866724;6199.504039676815;6200.0699895015205;6203.751849926042;5775.768969241351;5856.531477481876;5884.411558844081;5922.644641321534;5986.820395388146;6147.846303842261;6160.642330537586;6197.287311959002;6208;6208.348123447154;5832.679202643895;5874.5887787854435;5882.058870580687;5884.264466941632;5915.37888521699;5770.769169233352;5923.4076592340425;5974.731137098754;5996.2504686914135;6066.029435290332;5888.882222355614;5908.763649453974;5909.261342332208;5917.349091600006;5917.378675239038;5610.13042978339;5838.299404071368;5881.705914704162;5894.970525147347;5896.557758168069;5452.154915988028;5667.744951477276;5673.631213971079;5711.086226203787;5736.827895163152;5830.038043722739;5860.0037993540345;5891.734871930687;5947.256592925884;5950.613210141327;5591.04952158126;5765.221695071112;5775.7400916957995;5775.740091695968;5777.306723193244 03:41:06 INFO - PROCESS | 4962 | |1;ext.html;599.2748773983479;645.4416929356107;649.0491430054974;658.496250368468;658.9736410543578;34701.13247168822;46562.068758624846;47734.283985740156;47856.282155767694;47875.04249915004;48560.75719621406;48965.51034489654;49060;49097.754511227395;49286.50713492873;8358.164183581654;8562;8562.61468233931;8670.696525621588;8829.823403531926;10739.087177589914;11065.170112241574;11079.50142243597;11396.316221026766;11397.430128493583;11045.171612129083;11157.218994670377;11165.106791456705;11166.832497512543;11170.944145279303;11075.612353567627;11178.720531986684;11179.161562882735;11182.944085279603;11183.720406989849;10987.560497580087;11072.723181920435;11085.778284434266;11096.833547496793;11102.333859968347;43975.120497590186;44035.33946990766;44254.55745442537;44307.77846110749;44415;3877.418387241908;3917.6474117329294;4085.5710150434074;4247.851325203603;4582.221022426195;34272.6572734272;34460.655393445995;34661;34928;35060;4492.842750503717;4589.380433641449;4624.329472226542;4642.234031384817;4718;253475.73262133755;253670;253680;253791;254597;34379.14052148716;65212.67393663096;65598;65815.34184658092;66030;40891.7955410227;41071.7946410272;41072.38391424131;41129.383059254134;41135.38296925549;15936.92031539858;16140.273687683848;16168.353265869233;16176.514704558882;16206.675866482605;12653.36733163338;12755.42600582976;12796.424160912782;12904.419301131471;13696;9037.186653201243;9043.909560904307;9044.81910361789;9094.272458203328;9108.316876234308;3452.102453362094;3519.4017017107153;3530.8587656493964;3546.946795798065;3549.414346632777;1015.5785349080197;1039.3971496531992;1125.8930401611833;1171.9648410547697;1232.0882546915218;33798.986030419124;33820.32359352848;34448.65551344505;34559.82720086384;34597.654023459945;1184.7156682396162;1214.3988725580894;1217.7807994561065;1220.9694757630953;1271.2944315904763;17652.646947060988;17953;18001.639967200583;18024.738268321093;18162;551300;557623;558152;558740;561386;61156.38843611596;62879;63067.68466157732;63105.684471578264;63189.68405158037;1373.6497193215866;1478.4603619678956;1480.4596322342268;1493.3727834309616;1523.1927078648555;32925.83537082299;33345.666543335225;34234.828825856704;34603.82698086594;35339.46990795089;63368.683156583924;64119.67940160269;64182.35817641764;64592.0311195323;64640.67679661571;511109;515563;516349;517123;517226;40751.38872916968;46891.76554117208;47083.529164707914;47453.52546474629;51301.23048154356;52581.211281831565;52611.73694131505;53122.73438632782;53778;54169.187462188886;45535.089298214516;46221.306680399146;46315.305270421646;46454.30318545292;47467.762661186476;44675.81307890501;45270.54729452663;45350.31974520319;45991.3101303474;47014.059718806115;44359.55640443554;44544.777276114706;45044.77477612591;45604.315935261664;45947.08105837931;39022;39982;40014.39978400268;40404.797976011105;40773;29771.85114074416;29824.552631710976;30012.399752005273;30048.098557043322;30120.397592048474 03:41:06 INFO - PROCESS | 4962 | |2;jquery.html;432.6690082087203;434.5741173649823;435.5100511924085;438.7358056062892;439.9120175964806;18715;20358.389248322535;20499.38501844947;21378.144874205052;21404.892975535102;19406.417807465765;19813.40559783205;20187;20365.389038328838;20371.28700495483;5710.172025056364;5957.344692083867;5989.401059893998;5989.8203053908455;5993.340732519441;5823.039198532237;5833.329167145769;5916.467517923386;5925.34821169671;5928.525717942576;5835.766569337221;5873.765049398019;5876.853078673046;5878.5003274721485;5887.764489420418;5810.302763668345;5897.4692277695;5903.321118071433;5912;5912.349641539448;5140.434552199255;5173.9741301293625;5330.653507521999;5331.786728530854;5335.973320133413;23693.88153059241;23870.641940370908;23917;23945.521089578284;24063.87968060166;2603.297109780349;2606.387498937748;2656.7077621461817;3010.9548356774667;3049.435854366927;14337.928310358486;14873.776893346609;14920.925395373062;15275.770863437057;15521.223938803014;2031.9593608127902;2068.88621125838;2076.356329537848;2162.318869556085;2231.52022315203;72693;74856.62571687161;75231.24768752298;76071.23928760752;86786.56606716989;11354.41038254645;11768.823467647991;11888.227265227733;11920.105992050458;11923.642290731292;16954;17091.48725538236;17093.82906170947;17113.828861711474;17156.39952601678;8776.824463510695;8974.28205743539;8986.415882967585;9020;9057.547122643842;8586.699465518677;8623.353248506388;8660.22058014769;8750;8791.252743516745;5067.87330316745;5111.539961403491;5143.794248230029;5171.92242116361;5230.843074707765;1786.6248087901686;1929.7491326127513;1998.3505360757522;2001.6497113005166;2004.6091012252762;1039.870016247969;1042.233414362648;1048.8059708953867;1110.2347267844166;1159.0611604600133;19092.80907190938;19366.322178723676;19471;19602.095702414153;19927.60144797096;1035.53400969564;1039.2309690828884;1079.767849912257;1095.6224991767883;1103.542030057533;11002.889971100347;11095.944520277348;11225.887741122484;11325.886741132648;11340.376279304552;464680;474930;476401;477760;479870;57150.7142464285;84017.57991210005;87228;88670;89073.10926890778;997.9850302245472;1010.6715317521835;1024.7489365105596;1030.5208078243652;1047.3506426015767;17152.742708859627;17798.37705680295;17805;17854.91072544629;17897.284108635507;37958.43062354122;39096;39602.15102083577;40737;40874.1825163501;53760;56280.43719562752;56697.14954275772;56752.432475674716;57250;7871.33093687043;8025.197480251928;8398.496090234605;8445.95777021111;8652.394332396672;13004.674883127998;13526;13569.796453053015;13724.588262352145;13964.930175349058;11983.940080299542;11986.340751258764;12072.215306005082;12230.633081007583;12545.686357841127;11866.644000679993;11971.281723096643;12005.519779208735;12194.939025304817;12234.388280585757;12063.879361206627;12302.753944920873;12564.183328083645;12598.622041338775;12939.223646581235;8193.180681931997;8350.749477515685;8356.247937685637;8457.873131902903;8535.402521823662;10490.318129321875;12172.756544868877;12193.756124877631;12455.564055258023;12692.555760548337 03:41:06 INFO - PROCESS | 4962 | |3;mootools.html;1427.5360507834955;1569.176182504185;1613.2740266879903;1799.9370022049222;1944.6888497840348;9040.593173307201;9383.43699378037;9408.905910940888;9660.710178694633;9670.709878703632;9322.580483878224;9506.524673766302;9508.572114254857;9514.42913425195;9516.619335226582;2503.0863734736827;2527.304991127436;2528.8482691038503;2529.6837895263093;2529.84820910745;2299.1608063056947;2330.650402439631;2332.3586013846243;2334.789868911806;2338.368640467081;2464.346948058766;2498.487809998946;2511.610700341441;2512.660790793247;2532.987335063322;2432.221689059502;2434.050720219116;2452.852828830267;2465.3836540864786;2482.6276058591175;2368.0882860098814;2369.4431808524982;2370;2373.169390713254;2376.964345534818;7947.284744372976;8974.641014359418;9403.57683904226;9453.196478299353;9463.763405914839;5519;5730.140478928152;5738;5743.425657434265;5746.683932383718;3429.554157959474;3546.804925729084;3562.091666624994;3621.3300539400293;3623.800690961996;1159.6521043686944;1178.834963105166;1203.0796440722854;1209.1113031921532;1224.1920332580455;12781.61655150347;12812.935935320356;12817.102802803807;12901.870981290162;12935.935320323339;4758.619310455155;4800.237930008936;4880.511948805162;4904.754762261872;4911.8280860169725;11199.216054876244;11201.775964480665;11208.495617697223;11226.045786108272;11228.943855280671;5616.550675945915;5625.324961004706;5625.943740562624;5629.493345598916;5633.267675202197;5055.443901170868;5084.237364395296;5216.478352164829;5219.164933610604;5241.659292145999;4131.731437456556;4136.276151673445;4213.346931225665;4228.788560571959;4270.957290427056;1262;1268.7018550640591;1273.2933222061658;1277.591170825327;1292.4377895615437;876.4916348517971;1013.7921726046143;1015.761296095417;1015.9949200253951;1032.4785983078498;5944.821655350346;6021;6033.969830150909;6150.323464418911;6282.089097080898;948.8054948735493;960.6541645007792;1020.4846552490944;1034.632705389591;1046.6755305855208;4100.302948498763;4219.156168766259;4247.978760106242;4248.553901840324;4275.337322714984;11728.413579321;12068.939655301667;12196.390180491117;12245.755084898252;12262.386880655931;11997;12003.819942700866;12063.336516491501;12067.57763478274;12075.396230188631;8111.75664730059;8465.280451161598;8516.531590762568;8946.418482798597;9081.50051747147;6175.413335733098;6180.289266734383;6197.535184861244;6327.841803954938;6357.777477788255;10759.623413180501;10971;11017.338959662446;11122.054625356936;11173.217874748689;11183.161262905152;11231.66305010851;11353.432328383713;11392;11410.771784564427;8507.95746021266;8675.089115643019;8784.209421152127;8810.515421651871;8813.735587932373;9015.594298256725;9108.908910910806;9131.13254240846;9145.542722863696;9154.67958621445;7958.562279074475;8142.51144931306;8311.376646751396;8349.206825351583;8420.157984201776;8423.789405264917;8447.619857106567;8499;8538.829223415622;8616.181462761027;7756.767296981099;7802.063752349754;7817.96091019564;7828.569428681477;7837.921620783719;5450.5367043801725;5508.504234618904;5610.579206559442;5661.0093233684765;5696.772129114789;5444.564434845282;5471.878264955754;5476.561875050066;5480.561555075505;5522.696251706195 03:41:06 INFO - PROCESS | 4962 | |4;prototype.html;351.27461791400754;357.8711663801031;360.2758455504436;363.4130878631008;365.11095482500133;5478.945210547893;5566.610337276392;5573.721313934302;5587.38538760736;5604.327480702311;5526.723663816813;5548.805791797288;5561.304836895388;5567.137093750465;5572.442755724435;4214.536400995888;4305.870823875289;4343.174796788616;4345.826166953318;4381.277089280281;4297.634701050414;4311.655067594601;4313.633341166004;4316.093620339717;4344.956550434503;4305.698601097924;4324.632406245473;4329.978350108245;4332.65338772899;4333.176696427684;4186.832526698929;4292.678049146327;4304.289792184286;4326.935095973563;4357.891052723676;3770.472133901256;3783.0920579060826;3792;3806.467094606757;3831.578526362126;5366.6511676741275;5378.354597448331;5394.487523685283;5394.811181608664;5419.458054194589;4711.8350857719815;4962.950370496321;4977.228529577921;4981.252812078181;5008.29883816266;5724.398938111522;5735.397783232742;5821.515513544062;5859.2090067841145;5882.264716910387;4147.751134931884;4167.91664166718;4170.124273902484;4200.6219440250525;4202.9789851050855;5754.187430959234;5774.82675519735;5826.271716035496;6015.608985415934;6055.394460553954;4227.112306415687;4245.91508169841;4247.638950689165;4253.361995700608;4266.573342665771;4306.095719898856;4325.740455572675;4326.610605045561;4327.653787696977;4336.544662810423;4682.742449165328;4825.855224343275;4900.313956046157;4926.802927882916;4947.664130684695;5754.309482862;5775.740091695884;5792.478676919098;5799.333076696234;5801.767929282866;1476.1217075839859;1495.132822962679;1504.247876061969;1510.9168995705122;1510.9622259443381;934.9345545811727;954.71358592422;961.1541843177959;967.2552134856121;967.5824916497365;4901.313816065754;4966.826161084345;4968.850934471971;5002.974985125051;5009.248612708123;5301.416844147141;5313.8937221255355;5326.387465441524;5327.280817089721;5334.159714898354;4846.75766211688;4852.068066078748;5001.799928002839;5005.874853128701;5052.722100284446;2809.819875652231;2817.60553522507;2842.317843717493;2856.6859244747234;2866.8246019132057;5460.180972854024;5473.9452605474235;5477.20580515831;5478.342598888159;5494.835154945358;5032.823851165192;5481.835544933659;5487.6158668893595;5488.079172289747;5489.39616642169;5504.4495550444635;5509.862253443615;5520.585956053232;5525.502704756591;5528.834134975958;5073.467285934924;5131.384233891957;5274;5276.472352764693;5289.444608316071;5273.681579605099;5309.009121579407;5326.573874089986;5713.514351280021;5812.505936995233;6166.044263139221;6206.503479721521;6206.937930620817;6229.2524897010835;6241;4261.083866968616;4263.957360426356;4271.145770845906;4280.250956082611;4286.914261714811;5745.534888603546;5917.704114794157;5929.258842644669;5956.821295361146;6025.638461692312;5760.769569217185;5783.826485205451;5805.912911306418;5821.825345239649;5845.678487683218;5535.584831137761;5824.854378640568;5830.18377427169;5832.387599302182;5852.092925596539;5777.711114444345;5802.738876750472;5809.970950145223;5817.709114544171;5830.300363956352;5872.853178670567;5919.378465261258;5945.19739835134;5951;5968.791092311922;5511.614187006871;5729.512991395778;5733.627314224562;5748.856278593069;5804.5356371491025 03:41:06 INFO - PROCESS | 4962 | |5;yui.html;777.3975169243836;814.987775183372;820.9917900820993;833.899932008159;872.6291326186371;16463.753043704353;17255.654886902255;17259.309627614897;17556.385526506576;17568.912155439237;14970.401183952628;15188.088714677127;15194.696106077872;15394.076355418683;15524.767128493082;720.8089856188114;859.4843094143495;878.2315473960285;882.1443200095929;892.5225004622529;878.3807415771865;879.2833840420069;882.6778225947547;883.5493898111977;883.6642076011107;762.6225018615793;929.6513807322254;930.878985731854;931.6552875436098;931.9627214911395;896.4531635702249;915.9038300978401;916.3814425262955;923.7021984112333;924.5562130177552;682.8736683713479;683.7641013850214;684.260998122027;685.1196212866442;685.4584877946417;16323.10222937738;16367.099809510471;16422.589435264093;16466;16477.093759843203;13896.444142234299;13994;14050.43798248069;14274.3576539056;14522.927385363111;13833.930830345784;13989.090709103875;14022.43910243589;14183.007189496739;14330.49843255481;4668.509806470306;4678.719276843401;4681.812727490897;4687.88280292992;4711.411073615798;76356;77476.61261693711;78021.60989195075;78132;78648;12708.428120734588;12719.809202861965;12835.93582032084;12983.740325193443;13043.869561304455;23193.304200874;23319;23322.766772332398;23367.065317387114;23381;8753.080926502753;8970.327225458117;8993.640254389751;9089.954550227207;9100.271978241724;4640.6751527393435;4834.806607735722;5063.974680126576;5082.161443361804;5116.411612664591;3809.961900381016;3919.9608003919598;3921.6666583340734;3924;3942.113024569449;624.4005754475754;627.2723640576909;678.9219239787388;719.3525826755962;747.9364254038468;660.9140811694449;715.8153256360731;736.4660621049803;779.6959185917497;851.3104385447683;10819;11189.160812938899;11302.208845380908;11319.264247823865;11344.602938897264;790.8260182759784;800.4116974024088;801.2908575910245;813.4387272781762;834.9373796965131;5314.5748340132695;5316.73416329182;5413.593980451482;5433.456654334614;5441.5102640762525;72840;73055.63472182605;100871;113102;116024;62861.37138628555;83781.58109209414;95414.52292738631;97837.02162978279;102815;89666;90135.54932225429;91371.62942555867;91520.54239728893;93224;10296.279260451996;10588.735281618021;10787.460626968463;10794.460276986276;10875.782484350428;53931.73034134804;54559.45440545703;54966.17550736662;55423;55744.16383754166;71970;77472.2252777465;78805.60597196977;78838.6058069706;80610;13783.51757688476;13806.930965345511;13925.373358199107;14112.647183820487;14620.561383158521;14095.506657266946;15227.467038653594;15681.843181568038;15736.449224277096;16379.590510236863;13452.327383630975;13513.864861351261;13567.525136620567;13772.517961871286;15732.449364272195;15346.309416076527;15556.144412057445;15897.841021590099;16364.509064728078;16530;14599.197044162673;14999.325030373877;15080.54758357251;15577.065376077471;15610.219489025276;12191.939040305097;12661.74676506483;13070.738585228431;13159.93420032932;13317.933410332886;12103.318088645243;12833.294168820805;12970;13036.41336139857;13090 03:41:06 INFO - PROCESS | 4962 | __end_tp_report 03:41:06 INFO - PROCESS | 4962 | __start_cc_report 03:41:06 INFO - PROCESS | 4962 | _x_x_mozilla_cycle_collect,767 03:41:06 INFO - PROCESS | 4962 | __end_cc_report 03:41:06 INFO - PROCESS | 4962 | __startTimestamp1465555266421__endTimestamp 03:41:06 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | ------- Summary: start ------- 03:41:06 INFO - PROCESS | 4962 | Number of tests: 6 03:41:06 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | [#0] dojo.html Cycles:165 Average:5518.21 Median:5717.09 stddev:613.70 (10.7%) stddev-sans-first:591.35 03:41:06 INFO - PROCESS | 4962 | Values: 3341.5 3368.2 3372.3 3384.4 3428.7 5546.8 5592.0 5625.8 5626.9 5652.0 5511.4 5552.6 5563.9 5576.4 5604.8 4989.6 4998.1 5028.8 5042.0 5082.9 4941.4 4979.1 5035.5 5134.9 5136.0 5089.8 5101.5 5114.1 5123.5 5124.0 5106.5 5128.0 5133.8 5136.9 5157.2 4893.3 4926.6 4959.1 5028.0 5045.1 5445.1 5465.0 5490.5 5522.7 5597.6 5958.3 5999.4 6049.5 6057.6 6061.5 5854.9 5857.7 5898.6 6056.6 6096.5 5528.2 5533.5 5555.3 5569.5 5571.9 6092.0 6126.0 6131.8 6138.8 6141.0 5612.6 5717.1 5720.7 5767.9 5900.7 5931.6 5933.5 5942.0 5942.4 5960.7 5877.5 5879.6 5896.1 5899.0 5900.8 5750.4 5853.9 5857.1 5900.8 5945.0 4553.7 4554.1 4556.2 4556.6 4587.5 4018.9 4026.2 4096.7 4103.6 4127.3 5511.1 5558.2 5560.2 5565.6 5605.3 5914.3 5919.4 5927.6 5929.3 5993.2 5398.5 5486.3 5513.1 5529.4 5567.5 4927.9 4944.4 4944.5 4947.8 4965.1 6114.8 6186.8 6199.5 6200.1 6203.8 5775.8 5856.5 5884.4 5922.6 5986.8 6147.8 6160.6 6197.3 6208.0 6208.3 5832.7 5874.6 5882.1 5884.3 5915.4 5770.8 5923.4 5974.7 5996.3 6066.0 5888.9 5908.8 5909.3 5917.3 5917.4 5610.1 5838.3 5881.7 5895.0 5896.6 5452.2 5667.7 5673.6 5711.1 5736.8 5830.0 5860.0 5891.7 5947.3 5950.6 5591.0 5765.2 5775.7 5775.7 5777.3 03:41:06 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | [#1] ext.html Cycles:180 Average:61896.56 Median:22488.68 stddev:122998.25 (546.9%) stddev-sans-first:123257.19 03:41:06 INFO - PROCESS | 4962 | Values: 599.3 645.4 649.0 658.5 659.0 34701.1 46562.1 47734.3 47856.3 47875.0 48560.8 48965.5 49060.0 49097.8 49286.5 8358.2 8562.0 8562.6 8670.7 8829.8 10739.1 11065.2 11079.5 11396.3 11397.4 11045.2 11157.2 11165.1 11166.8 11170.9 11075.6 11178.7 11179.2 11182.9 11183.7 10987.6 11072.7 11085.8 11096.8 11102.3 43975.1 44035.3 44254.6 44307.8 44415.0 3877.4 3917.6 4085.6 4247.9 4582.2 34272.7 34460.7 34661.0 34928.0 35060.0 4492.8 4589.4 4624.3 4642.2 4718.0 253475.7 253670.0 253680.0 253791.0 254597.0 34379.1 65212.7 65598.0 65815.3 66030.0 40891.8 41071.8 41072.4 41129.4 41135.4 15936.9 16140.3 16168.4 16176.5 16206.7 12653.4 12755.4 12796.4 12904.4 13696.0 9037.2 9043.9 9044.8 9094.3 9108.3 3452.1 3519.4 3530.9 3546.9 3549.4 1015.6 1039.4 1125.9 1172.0 1232.1 33799.0 33820.3 34448.7 34559.8 34597.7 1184.7 1214.4 1217.8 1221.0 1271.3 17652.6 17953.0 18001.6 18024.7 18162.0 551300.0 557623.0 558152.0 558740.0 561386.0 61156.4 62879.0 63067.7 63105.7 63189.7 1373.6 1478.5 1480.5 1493.4 1523.2 32925.8 33345.7 34234.8 34603.8 35339.5 63368.7 64119.7 64182.4 64592.0 64640.7 511109.0 515563.0 516349.0 517123.0 517226.0 40751.4 46891.8 47083.5 47453.5 51301.2 52581.2 52611.7 53122.7 53778.0 54169.2 45535.1 46221.3 46315.3 46454.3 47467.8 44675.8 45270.5 45350.3 45991.3 47014.1 44359.6 44544.8 45044.8 45604.3 45947.1 39022.0 39982.0 40014.4 40404.8 40773.0 29771.9 29824.6 30012.4 30048.1 30120.4 03:41:06 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | [#2] jquery.html Cycles:180 Average:28514.43 Median:23893.82 stddev:77984.91 (326.4%) stddev-sans-first:78175.17 03:41:06 INFO - PROCESS | 4962 | Values: 432.7 434.6 435.5 438.7 439.9 18715.0 20358.4 20499.4 21378.1 21404.9 19406.4 19813.4 20187.0 20365.4 20371.3 5710.2 5957.3 5989.4 5989.8 5993.3 5823.0 5833.3 5916.5 5925.3 5928.5 5835.8 5873.8 5876.9 5878.5 5887.8 5810.3 5897.5 5903.3 5912.0 5912.3 5140.4 5174.0 5330.7 5331.8 5336.0 23693.9 23870.6 23917.0 23945.5 24063.9 2603.3 2606.4 2656.7 3011.0 3049.4 14337.9 14873.8 14920.9 15275.8 15521.2 2032.0 2068.9 2076.4 2162.3 2231.5 72693.0 74856.6 75231.2 76071.2 86786.6 11354.4 11768.8 11888.2 11920.1 11923.6 16954.0 17091.5 17093.8 17113.8 17156.4 8776.8 8974.3 8986.4 9020.0 9057.5 8586.7 8623.4 8660.2 8750.0 8791.3 5067.9 5111.5 5143.8 5171.9 5230.8 1786.6 1929.7 1998.4 2001.6 2004.6 1039.9 1042.2 1048.8 1110.2 1159.1 19092.8 19366.3 19471.0 19602.1 19927.6 1035.5 1039.2 1079.8 1095.6 1103.5 11002.9 11095.9 11225.9 11325.9 11340.4 464680.0 474930.0 476401.0 477760.0 479870.0 57150.7 84017.6 87228.0 88670.0 89073.1 998.0 1010.7 1024.7 1030.5 1047.4 17152.7 17798.4 17805.0 17854.9 17897.3 37958.4 39096.0 39602.2 40737.0 40874.2 53760.0 56280.4 56697.1 56752.4 57250.0 7871.3 8025.2 8398.5 8446.0 8652.4 13004.7 13526.0 13569.8 13724.6 13964.9 11983.9 11986.3 12072.2 12230.6 12545.7 11866.6 11971.3 12005.5 12194.9 12234.4 12063.9 12302.8 12564.2 12598.6 12939.2 8193.2 8350.7 8356.2 8457.9 8535.4 10490.3 12172.8 12193.8 12455.6 12692.6 03:41:06 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | [#3] mootools.html Cycles:180 Average:6236.29 Median:4273.15 stddev:3601.83 (84.3%) stddev-sans-first:3593.80 03:41:06 INFO - PROCESS | 4962 | Values: 1427.5 1569.2 1613.3 1799.9 1944.7 9040.6 9383.4 9408.9 9660.7 9670.7 9322.6 9506.5 9508.6 9514.4 9516.6 2503.1 2527.3 2528.8 2529.7 2529.8 2299.2 2330.7 2332.4 2334.8 2338.4 2464.3 2498.5 2511.6 2512.7 2533.0 2432.2 2434.1 2452.9 2465.4 2482.6 2368.1 2369.4 2370.0 2373.2 2377.0 7947.3 8974.6 9403.6 9453.2 9463.8 5519.0 5730.1 5738.0 5743.4 5746.7 3429.6 3546.8 3562.1 3621.3 3623.8 1159.7 1178.8 1203.1 1209.1 1224.2 12781.6 12812.9 12817.1 12901.9 12935.9 4758.6 4800.2 4880.5 4904.8 4911.8 11199.2 11201.8 11208.5 11226.0 11228.9 5616.6 5625.3 5625.9 5629.5 5633.3 5055.4 5084.2 5216.5 5219.2 5241.7 4131.7 4136.3 4213.3 4228.8 4271.0 1262.0 1268.7 1273.3 1277.6 1292.4 876.5 1013.8 1015.8 1016.0 1032.5 5944.8 6021.0 6034.0 6150.3 6282.1 948.8 960.7 1020.5 1034.6 1046.7 4100.3 4219.2 4248.0 4248.6 4275.3 11728.4 12068.9 12196.4 12245.8 12262.4 11997.0 12003.8 12063.3 12067.6 12075.4 8111.8 8465.3 8516.5 8946.4 9081.5 6175.4 6180.3 6197.5 6327.8 6357.8 10759.6 10971.0 11017.3 11122.1 11173.2 11183.2 11231.7 11353.4 11392.0 11410.8 8508.0 8675.1 8784.2 8810.5 8813.7 9015.6 9108.9 9131.1 9145.5 9154.7 7958.6 8142.5 8311.4 8349.2 8420.2 8423.8 8447.6 8499.0 8538.8 8616.2 7756.8 7802.1 7818.0 7828.6 7837.9 5450.5 5508.5 5610.6 5661.0 5696.8 5444.6 5471.9 5476.6 5480.6 5522.7 03:41:06 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | [#4] prototype.html Cycles:180 Average:4749.27 Median:5326.48 stddev:1375.62 (25.8%) stddev-sans-first:1339.29 03:41:06 INFO - PROCESS | 4962 | Values: 351.3 357.9 360.3 363.4 365.1 5478.9 5566.6 5573.7 5587.4 5604.3 5526.7 5548.8 5561.3 5567.1 5572.4 4214.5 4305.9 4343.2 4345.8 4381.3 4297.6 4311.7 4313.6 4316.1 4345.0 4305.7 4324.6 4330.0 4332.7 4333.2 4186.8 4292.7 4304.3 4326.9 4357.9 3770.5 3783.1 3792.0 3806.5 3831.6 5366.7 5378.4 5394.5 5394.8 5419.5 4711.8 4963.0 4977.2 4981.3 5008.3 5724.4 5735.4 5821.5 5859.2 5882.3 4147.8 4167.9 4170.1 4200.6 4203.0 5754.2 5774.8 5826.3 6015.6 6055.4 4227.1 4245.9 4247.6 4253.4 4266.6 4306.1 4325.7 4326.6 4327.7 4336.5 4682.7 4825.9 4900.3 4926.8 4947.7 5754.3 5775.7 5792.5 5799.3 5801.8 1476.1 1495.1 1504.2 1510.9 1511.0 934.9 954.7 961.2 967.3 967.6 4901.3 4966.8 4968.9 5003.0 5009.2 5301.4 5313.9 5326.4 5327.3 5334.2 4846.8 4852.1 5001.8 5005.9 5052.7 2809.8 2817.6 2842.3 2856.7 2866.8 5460.2 5473.9 5477.2 5478.3 5494.8 5032.8 5481.8 5487.6 5488.1 5489.4 5504.4 5509.9 5520.6 5525.5 5528.8 5073.5 5131.4 5274.0 5276.5 5289.4 5273.7 5309.0 5326.6 5713.5 5812.5 6166.0 6206.5 6206.9 6229.3 6241.0 4261.1 4264.0 4271.1 4280.3 4286.9 5745.5 5917.7 5929.3 5956.8 6025.6 5760.8 5783.8 5805.9 5821.8 5845.7 5535.6 5824.9 5830.2 5832.4 5852.1 5777.7 5802.7 5810.0 5817.7 5830.3 5872.9 5919.4 5945.2 5951.0 5968.8 5511.6 5729.5 5733.6 5748.9 5804.5 03:41:06 INFO - PROCESS | 4962 | 03:41:06 INFO - PROCESS | 4962 | [#5] yui.html Cycles:180 Average:20991.90 Median:4673.61 stddev:28343.87 (606.5%) stddev-sans-first:28382.73 03:41:06 INFO - PROCESS | 4962 | Values: 777.4 815.0 821.0 833.9 872.6 16463.8 17255.7 17259.3 17556.4 17568.9 14970.4 15188.1 15194.7 15394.1 15524.8 720.8 859.5 878.2 882.1 892.5 878.4 879.3 882.7 883.5 883.7 762.6 929.7 930.9 931.7 932.0 896.5 915.9 916.4 923.7 924.6 682.9 683.8 684.3 685.1 685.5 16323.1 16367.1 16422.6 16466.0 16477.1 13896.4 13994.0 14050.4 14274.4 14522.9 13833.9 13989.1 14022.4 14183.0 14330.5 4668.5 4678.7 4681.8 4687.9 4711.4 76356.0 77476.6 78021.6 78132.0 78648.0 12708.4 12719.8 12835.9 12983.7 13043.9 23193.3 23319.0 23322.8 23367.1 23381.0 8753.1 8970.3 8993.6 9090.0 9100.3 4640.7 4834.8 5064.0 5082.2 5116.4 3810.0 3920.0 3921.7 3924.0 3942.1 624.4 627.3 678.9 719.4 747.9 660.9 715.8 736.5 779.7 851.3 10819.0 11189.2 11302.2 11319.3 11344.6 790.8 800.4 801.3 813.4 834.9 5314.6 5316.7 5413.6 5433.5 5441.5 72840.0 73055.6 100871.0 113102.0 116024.0 62861.4 83781.6 95414.5 97837.0 102815.0 89666.0 90135.5 91371.6 91520.5 93224.0 10296.3 10588.7 10787.5 10794.5 10875.8 53931.7 54559.5 54966.2 55423.0 55744.2 71970.0 77472.2 78805.6 78838.6 80610.0 13783.5 13806.9 13925.4 14112.6 14620.6 14095.5 15227.5 15681.8 15736.4 16379.6 13452.3 13513.9 13567.5 13772.5 15732.4 15346.3 15556.1 15897.8 16364.5 16530.0 14599.2 14999.3 15080.5 15577.1 15610.2 12191.9 12661.7 13070.7 13159.9 13317.9 12103.3 12833.3 12970.0 13036.4 13090.0 03:41:06 INFO - PROCESS | 4962 | -------- Summary: end -------- 03:41:06 INFO - PROCESS | 4962 | 03:41:07 INFO - TEST-INFO | 4962: exit 0 03:41:07 INFO - TEST-OK | dromaeo_css | took 1112390ms 03:41:07 INFO - TEST-START | kraken 03:41:07 INFO - operating with platform_type : linux_ 03:41:07 INFO - Initialising browser for kraken test... 03:41:07 INFO - TEST-INFO | started process 5152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptocNOq/profile http://localhost:40050/getInfo.html) 03:41:10 INFO - PROCESS | 5152 | __metrics Screen width/height:1600/1200 03:41:10 INFO - PROCESS | 5152 | colorDepth:24 03:41:10 INFO - PROCESS | 5152 | Browser inner width/height: 1024/697 03:41:10 INFO - PROCESS | 5152 | __metrics 03:41:12 ERROR - PROCESS | 5152 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:41:12 INFO - PROCESS | 5152 | console.error: PushService: 03:41:12 INFO - PROCESS | 5152 | stateChangeProcessEnqueue: Error transitioning state 03:41:12 INFO - PROCESS | 5152 | UnknownError 03:41:12 INFO - TEST-INFO | 5152: exit 0 03:41:12 INFO - Browser initialized. 03:41:12 INFO - Running cycle 1/1 for kraken test... 03:41:12 INFO - TEST-INFO | started process 5245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptocNOq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:24 INFO - PROCESS | 5245 | RSS: Main: 145756160 03:41:24 INFO - PROCESS | 5245 | 03:41:27 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40050/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:27 INFO - PROCESS | 5245 | RSS: Main: 194482176 03:41:27 INFO - PROCESS | 5245 | 03:41:30 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40050/tests/kraken/driver.html?testName=audio-dft) 03:41:31 INFO - PROCESS | 5245 | RSS: Main: 192036864 03:41:31 INFO - PROCESS | 5245 | 03:41:34 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40050/tests/kraken/driver.html?testName=audio-fft) 03:41:34 INFO - PROCESS | 5245 | RSS: Main: 277430272 03:41:34 INFO - PROCESS | 5245 | 03:41:36 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40050/tests/kraken/driver.html?testName=audio-oscillator) 03:41:37 INFO - PROCESS | 5245 | RSS: Main: 186437632 03:41:37 INFO - PROCESS | 5245 | 03:41:39 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40050/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:40 INFO - PROCESS | 5245 | RSS: Main: 186482688 03:41:40 INFO - PROCESS | 5245 | 03:41:43 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40050/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:43 INFO - PROCESS | 5245 | RSS: Main: 220827648 03:41:43 INFO - PROCESS | 5245 | 03:41:47 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40050/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:47 INFO - PROCESS | 5245 | RSS: Main: 221696000 03:41:47 INFO - PROCESS | 5245 | 03:41:50 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40050/tests/kraken/driver.html?testName=json-parse-financial) 03:41:50 INFO - PROCESS | 5245 | RSS: Main: 221257728 03:41:50 INFO - PROCESS | 5245 | 03:41:52 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40050/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:53 INFO - PROCESS | 5245 | RSS: Main: 199852032 03:41:53 INFO - PROCESS | 5245 | 03:41:54 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:55 INFO - PROCESS | 5245 | RSS: Main: 201457664 03:41:55 INFO - PROCESS | 5245 | 03:41:57 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:58 INFO - PROCESS | 5245 | RSS: Main: 210685952 03:41:58 INFO - PROCESS | 5245 | 03:42:00 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:01 INFO - PROCESS | 5245 | RSS: Main: 214360064 03:42:01 INFO - PROCESS | 5245 | 03:42:03 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:04 INFO - PROCESS | 5245 | RSS: Main: 215064576 03:42:04 INFO - PROCESS | 5245 | 03:42:05 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:40050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40050/tests/kraken/driver.html?testName=ai-astar) 03:42:06 INFO - PROCESS | 5245 | RSS: Main: 257671168 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | __start_tp_report 03:42:06 INFO - PROCESS | 5245 | _x_x_mozilla_page_load 03:42:06 INFO - PROCESS | 5245 | _x_x_mozilla_page_load_details 03:42:06 INFO - PROCESS | 5245 | |i|pagename|runs| 03:42:06 INFO - PROCESS | 5245 | |0;ai-astar;110;105;111;111;109;109;110;109;109;108 03:42:06 INFO - PROCESS | 5245 | |1;audio-beat-detection;161;130;126;181;139;133;152;123;154;126 03:42:06 INFO - PROCESS | 5245 | |2;audio-dft;161;161;161;160;160;161;160;159;160;162 03:42:06 INFO - PROCESS | 5245 | |3;audio-fft;74;78;74;120;76;76;76;82;98;74 03:42:06 INFO - PROCESS | 5245 | |4;audio-oscillator;83;84;121;84;85;85;111;86;85;123 03:42:06 INFO - PROCESS | 5245 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 03:42:06 INFO - PROCESS | 5245 | |6;imaging-darkroom;145;145;146;146;146;146;145;146;145;146 03:42:06 INFO - PROCESS | 5245 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;94 03:42:06 INFO - PROCESS | 5245 | |8;json-parse-financial;52;51;53;52;52;52;54;52;51;52 03:42:06 INFO - PROCESS | 5245 | |9;json-stringify-tinderbox;62;60;60;60;62;61;61;61;61;61 03:42:06 INFO - PROCESS | 5245 | |10;stanford-crypto-aes;77;81;76;82;79;80;76;77;103;78 03:42:06 INFO - PROCESS | 5245 | |11;stanford-crypto-ccm;119;118;116;123;122;116;116;120;144;126 03:42:06 INFO - PROCESS | 5245 | |12;stanford-crypto-pbkdf2;154;153;153;153;158;156;156;157;153;149 03:42:06 INFO - PROCESS | 5245 | |13;stanford-crypto-sha256-iterative;60;64;61;62;62;63;60;60;59;60 03:42:06 INFO - PROCESS | 5245 | __end_tp_report 03:42:06 INFO - PROCESS | 5245 | __start_cc_report 03:42:06 INFO - PROCESS | 5245 | _x_x_mozilla_cycle_collect,1560 03:42:06 INFO - PROCESS | 5245 | __end_cc_report 03:42:06 INFO - PROCESS | 5245 | __startTimestamp1465555326190__endTimestamp 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | ------- Summary: start ------- 03:42:06 INFO - PROCESS | 5245 | Number of tests: 14 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:1.73 (1.6%) stddev-sans-first:1.80 03:42:06 INFO - PROCESS | 5245 | Values: 110.0 105.0 111.0 111.0 109.0 109.0 110.0 109.0 109.0 108.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:145.50 stddev:18.95 (13.0%) stddev-sans-first:18.88 03:42:06 INFO - PROCESS | 5245 | Values: 161.0 130.0 126.0 181.0 139.0 133.0 152.0 123.0 154.0 126.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 03:42:06 INFO - PROCESS | 5245 | Values: 161.0 161.0 161.0 160.0 160.0 161.0 160.0 159.0 160.0 162.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:14.94 (19.7%) stddev-sans-first:15.51 03:42:06 INFO - PROCESS | 5245 | Values: 74.0 78.0 74.0 120.0 76.0 76.0 76.0 82.0 98.0 74.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.50 stddev:16.61 (19.7%) stddev-sans-first:17.07 03:42:06 INFO - PROCESS | 5245 | Values: 83.0 84.0 121.0 84.0 85.0 85.0 111.0 86.0 85.0 123.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:42:06 INFO - PROCESS | 5245 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:42:06 INFO - PROCESS | 5245 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:42:06 INFO - PROCESS | 5245 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 03:42:06 INFO - PROCESS | 5245 | Values: 52.0 51.0 53.0 52.0 52.0 52.0 54.0 52.0 51.0 52.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 03:42:06 INFO - PROCESS | 5245 | Values: 62.0 60.0 60.0 60.0 62.0 61.0 61.0 61.0 61.0 61.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:78.50 stddev:8.03 (10.2%) stddev-sans-first:8.40 03:42:06 INFO - PROCESS | 5245 | Values: 77.0 81.0 76.0 82.0 79.0 80.0 76.0 77.0 103.0 78.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:121.00 stddev:8.42 (7.0%) stddev-sans-first:8.86 03:42:06 INFO - PROCESS | 5245 | Values: 119.0 118.0 116.0 123.0 122.0 116.0 116.0 120.0 144.0 126.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:155.00 stddev:2.62 (1.7%) stddev-sans-first:2.77 03:42:06 INFO - PROCESS | 5245 | Values: 154.0 153.0 153.0 153.0 158.0 156.0 156.0 157.0 153.0 149.0 03:42:06 INFO - PROCESS | 5245 | 03:42:06 INFO - PROCESS | 5245 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.50 stddev:1.60 (2.6%) stddev-sans-first:1.64 03:42:06 INFO - PROCESS | 5245 | Values: 60.0 64.0 61.0 62.0 62.0 63.0 60.0 60.0 59.0 60.0 03:42:06 INFO - PROCESS | 5245 | -------- Summary: end -------- 03:42:06 INFO - PROCESS | 5245 | 03:42:07 INFO - TEST-INFO | 5245: exit 0 03:42:07 INFO - TEST-OK | kraken | took 60057ms 03:42:07 INFO - SUITE-END | took 1172s 03:42:07 INFO - Completed test suite (00:19:32) 03:42:07 INFO - javascript benchmark 03:42:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.5154802553625, 3368.2084710093122, 3372.2749608834097, 3384.373890830198, 3428.725701943845, 5546.750396232169, 5592.0, 5625.80309689161, 5626.943730562693, 5652.0, 5511.421300763423, 5552.555795536357, 5563.860903477415, 5576.442355764421, 5604.775808967636, 4989.57588604969, 4998.075356059123, 5028.7988480460735, 5042.042012017723, 5082.949170508285, 4941.431735350427, 4979.103761322978, 5035.521625445577, 5134.922976155361, 5135.9743201283945, 5089.796408143669, 5101.51535604117, 5114.105031619451, 5123.487651234884, 5124.0, 5106.540411362995, 5128.000039992222, 5133.794648214067, 5136.871578210537, 5157.226416037587, 4893.290472881412, 4926.5812405945535, 4959.107360675077, 5027.994401119754, 5045.117104506697, 5445.101558242885, 5465.0, 5490.505854473116, 5522.66863988162, 5597.552195824324, 5958.314793798725, 5999.370066143036, 6049.48579370754, 6057.636541807506, 6061.454469097758, 5854.912176317359, 5857.70711464425, 5898.616589921641, 6056.636601803906, 6096.542759293026, 5528.226048353234, 5533.501984821385, 5555.2778138842505, 5569.526590239794, 5571.9442805572235, 6092.0, 6125.974972785665, 6131.785387511416, 6138.78514252008, 6140.969295153495, 5612.579056570774, 5717.085266357446, 5720.68536230503, 5767.913481297784, 5900.7049647518315, 5931.6441013539325, 5933.525317974551, 5941.970290148522, 5942.435468630473, 5960.7019649017375, 5877.52979761618, 5879.617824841372, 5896.056630939029, 5898.970505147533, 5900.76396944126, 5750.367459579443, 5853.88292234153, 5857.062869940789, 5900.76396944126, 5944.970275148597, 4553.658475614276, 4554.111948170142, 4556.179887620194, 4556.612687921497, 4587.518310577408, 4018.9196216075516, 4026.1947610478023, 4096.692748043909, 4103.630673239423, 4127.277726397869, 5511.063119269654, 5558.221848941152, 5560.193771903132, 5565.638233514808, 5605.299337582802, 5914.349421563625, 5919.4080591940465, 5927.555433342516, 5929.318128415288, 5993.160957465958, 5398.514133727984, 5486.341639003345, 5513.145462453326, 5529.4470552944385, 5567.498925096761, 4927.940492794067, 4944.357233559686, 4944.53026962438, 4947.826826061142, 4965.131102057126, 6114.847128821815, 6186.845328866724, 6199.504039676815, 6200.0699895015205, 6203.751849926042, 5775.768969241351, 5856.531477481876, 5884.411558844081, 5922.644641321534, 5986.820395388146, 6147.846303842261, 6160.642330537586, 6197.287311959002, 6208.0, 6208.348123447154, 5832.679202643895, 5874.5887787854435, 5882.058870580687, 5884.264466941632, 5915.37888521699, 5770.769169233352, 5923.4076592340425, 5974.731137098754, 5996.2504686914135, 6066.029435290332, 5888.882222355614, 5908.763649453974, 5909.261342332208, 5917.349091600006, 5917.378675239038, 5610.13042978339, 5838.299404071368, 5881.705914704162, 5894.970525147347, 5896.557758168069, 5452.154915988028, 5667.744951477276, 5673.631213971079, 5711.086226203787, 5736.827895163152, 5830.038043722739, 5860.0037993540345, 5891.734871930687, 5947.256592925884, 5950.613210141327, 5591.04952158126, 5765.221695071112, 5775.7400916957995, 5775.740091695968, 5777.306723193244], "value": 5478.750272858116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2748773983479, 645.4416929356107, 649.0491430054974, 658.496250368468, 658.9736410543578, 34701.13247168822, 46562.068758624846, 47734.283985740156, 47856.282155767694, 47875.04249915004, 48560.75719621406, 48965.51034489654, 49060.0, 49097.754511227395, 49286.50713492873, 8358.164183581654, 8562.0, 8562.61468233931, 8670.696525621588, 8829.823403531926, 10739.087177589914, 11065.170112241574, 11079.50142243597, 11396.316221026766, 11397.430128493583, 11045.171612129083, 11157.218994670377, 11165.106791456705, 11166.832497512543, 11170.944145279303, 11075.612353567627, 11178.720531986684, 11179.161562882735, 11182.944085279603, 11183.720406989849, 10987.560497580087, 11072.723181920435, 11085.778284434266, 11096.833547496793, 11102.333859968347, 43975.120497590186, 44035.33946990766, 44254.55745442537, 44307.77846110749, 44415.0, 3877.418387241908, 3917.6474117329294, 4085.5710150434074, 4247.851325203603, 4582.221022426195, 34272.6572734272, 34460.655393445995, 34661.0, 34928.0, 35060.0, 4492.842750503717, 4589.380433641449, 4624.329472226542, 4642.234031384817, 4718.0, 253475.73262133755, 253670.0, 253680.0, 253791.0, 254597.0, 34379.14052148716, 65212.67393663096, 65598.0, 65815.34184658092, 66030.0, 40891.7955410227, 41071.7946410272, 41072.38391424131, 41129.383059254134, 41135.38296925549, 15936.92031539858, 16140.273687683848, 16168.353265869233, 16176.514704558882, 16206.675866482605, 12653.36733163338, 12755.42600582976, 12796.424160912782, 12904.419301131471, 13696.0, 9037.186653201243, 9043.909560904307, 9044.81910361789, 9094.272458203328, 9108.316876234308, 3452.102453362094, 3519.4017017107153, 3530.8587656493964, 3546.946795798065, 3549.414346632777, 1015.5785349080197, 1039.3971496531992, 1125.8930401611833, 1171.9648410547697, 1232.0882546915218, 33798.986030419124, 33820.32359352848, 34448.65551344505, 34559.82720086384, 34597.654023459945, 1184.7156682396162, 1214.3988725580894, 1217.7807994561065, 1220.9694757630953, 1271.2944315904763, 17652.646947060988, 17953.0, 18001.639967200583, 18024.738268321093, 18162.0, 551300.0, 557623.0, 558152.0, 558740.0, 561386.0, 61156.38843611596, 62879.0, 63067.68466157732, 63105.684471578264, 63189.68405158037, 1373.6497193215866, 1478.4603619678956, 1480.4596322342268, 1493.3727834309616, 1523.1927078648555, 32925.83537082299, 33345.666543335225, 34234.828825856704, 34603.82698086594, 35339.46990795089, 63368.683156583924, 64119.67940160269, 64182.35817641764, 64592.0311195323, 64640.67679661571, 511109.0, 515563.0, 516349.0, 517123.0, 517226.0, 40751.38872916968, 46891.76554117208, 47083.529164707914, 47453.52546474629, 51301.23048154356, 52581.211281831565, 52611.73694131505, 53122.73438632782, 53778.0, 54169.187462188886, 45535.089298214516, 46221.306680399146, 46315.305270421646, 46454.30318545292, 47467.762661186476, 44675.81307890501, 45270.54729452663, 45350.31974520319, 45991.3101303474, 47014.059718806115, 44359.55640443554, 44544.777276114706, 45044.77477612591, 45604.315935261664, 45947.08105837931, 39022.0, 39982.0, 40014.39978400268, 40404.797976011105, 40773.0, 29771.85114074416, 29824.552631710976, 30012.399752005273, 30048.098557043322, 30120.397592048474], "value": 20861.20810493184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.6690082087203, 434.5741173649823, 435.5100511924085, 438.7358056062892, 439.9120175964806, 18715.0, 20358.389248322535, 20499.38501844947, 21378.144874205052, 21404.892975535102, 19406.417807465765, 19813.40559783205, 20187.0, 20365.389038328838, 20371.28700495483, 5710.172025056364, 5957.344692083867, 5989.401059893998, 5989.8203053908455, 5993.340732519441, 5823.039198532237, 5833.329167145769, 5916.467517923386, 5925.34821169671, 5928.525717942576, 5835.766569337221, 5873.765049398019, 5876.853078673046, 5878.5003274721485, 5887.764489420418, 5810.302763668345, 5897.4692277695, 5903.321118071433, 5912.0, 5912.349641539448, 5140.434552199255, 5173.9741301293625, 5330.653507521999, 5331.786728530854, 5335.973320133413, 23693.88153059241, 23870.641940370908, 23917.0, 23945.521089578284, 24063.87968060166, 2603.297109780349, 2606.387498937748, 2656.7077621461817, 3010.9548356774667, 3049.435854366927, 14337.928310358486, 14873.776893346609, 14920.925395373062, 15275.770863437057, 15521.223938803014, 2031.9593608127902, 2068.88621125838, 2076.356329537848, 2162.318869556085, 2231.52022315203, 72693.0, 74856.62571687161, 75231.24768752298, 76071.23928760752, 86786.56606716989, 11354.41038254645, 11768.823467647991, 11888.227265227733, 11920.105992050458, 11923.642290731292, 16954.0, 17091.48725538236, 17093.82906170947, 17113.828861711474, 17156.39952601678, 8776.824463510695, 8974.28205743539, 8986.415882967585, 9020.0, 9057.547122643842, 8586.699465518677, 8623.353248506388, 8660.22058014769, 8750.0, 8791.252743516745, 5067.87330316745, 5111.539961403491, 5143.794248230029, 5171.92242116361, 5230.843074707765, 1786.6248087901686, 1929.7491326127513, 1998.3505360757522, 2001.6497113005166, 2004.6091012252762, 1039.870016247969, 1042.233414362648, 1048.8059708953867, 1110.2347267844166, 1159.0611604600133, 19092.80907190938, 19366.322178723676, 19471.0, 19602.095702414153, 19927.60144797096, 1035.53400969564, 1039.2309690828884, 1079.767849912257, 1095.6224991767883, 1103.542030057533, 11002.889971100347, 11095.944520277348, 11225.887741122484, 11325.886741132648, 11340.376279304552, 464680.0, 474930.0, 476401.0, 477760.0, 479870.0, 57150.7142464285, 84017.57991210005, 87228.0, 88670.0, 89073.10926890778, 997.9850302245472, 1010.6715317521835, 1024.7489365105596, 1030.5208078243652, 1047.3506426015767, 17152.742708859627, 17798.37705680295, 17805.0, 17854.91072544629, 17897.284108635507, 37958.43062354122, 39096.0, 39602.15102083577, 40737.0, 40874.1825163501, 53760.0, 56280.43719562752, 56697.14954275772, 56752.432475674716, 57250.0, 7871.33093687043, 8025.197480251928, 8398.496090234605, 8445.95777021111, 8652.394332396672, 13004.674883127998, 13526.0, 13569.796453053015, 13724.588262352145, 13964.930175349058, 11983.940080299542, 11986.340751258764, 12072.215306005082, 12230.633081007583, 12545.686357841127, 11866.644000679993, 11971.281723096643, 12005.519779208735, 12194.939025304817, 12234.388280585757, 12063.879361206627, 12302.753944920873, 12564.183328083645, 12598.622041338775, 12939.223646581235, 8193.180681931997, 8350.749477515685, 8356.247937685637, 8457.873131902903, 8535.402521823662, 10490.318129321875, 12172.756544868877, 12193.756124877631, 12455.564055258023, 12692.555760548337], "value": 9606.352774785362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.5360507834955, 1569.176182504185, 1613.2740266879903, 1799.9370022049222, 1944.6888497840348, 9040.593173307201, 9383.43699378037, 9408.905910940888, 9660.710178694633, 9670.709878703632, 9322.580483878224, 9506.524673766302, 9508.572114254857, 9514.42913425195, 9516.619335226582, 2503.0863734736827, 2527.304991127436, 2528.8482691038503, 2529.6837895263093, 2529.84820910745, 2299.1608063056947, 2330.650402439631, 2332.3586013846243, 2334.789868911806, 2338.368640467081, 2464.346948058766, 2498.487809998946, 2511.610700341441, 2512.660790793247, 2532.987335063322, 2432.221689059502, 2434.050720219116, 2452.852828830267, 2465.3836540864786, 2482.6276058591175, 2368.0882860098814, 2369.4431808524982, 2370.0, 2373.169390713254, 2376.964345534818, 7947.284744372976, 8974.641014359418, 9403.57683904226, 9453.196478299353, 9463.763405914839, 5519.0, 5730.140478928152, 5738.0, 5743.425657434265, 5746.683932383718, 3429.554157959474, 3546.804925729084, 3562.091666624994, 3621.3300539400293, 3623.800690961996, 1159.6521043686944, 1178.834963105166, 1203.0796440722854, 1209.1113031921532, 1224.1920332580455, 12781.61655150347, 12812.935935320356, 12817.102802803807, 12901.870981290162, 12935.935320323339, 4758.619310455155, 4800.237930008936, 4880.511948805162, 4904.754762261872, 4911.8280860169725, 11199.216054876244, 11201.775964480665, 11208.495617697223, 11226.045786108272, 11228.943855280671, 5616.550675945915, 5625.324961004706, 5625.943740562624, 5629.493345598916, 5633.267675202197, 5055.443901170868, 5084.237364395296, 5216.478352164829, 5219.164933610604, 5241.659292145999, 4131.731437456556, 4136.276151673445, 4213.346931225665, 4228.788560571959, 4270.957290427056, 1262.0, 1268.7018550640591, 1273.2933222061658, 1277.591170825327, 1292.4377895615437, 876.4916348517971, 1013.7921726046143, 1015.761296095417, 1015.9949200253951, 1032.4785983078498, 5944.821655350346, 6021.0, 6033.969830150909, 6150.323464418911, 6282.089097080898, 948.8054948735493, 960.6541645007792, 1020.4846552490944, 1034.632705389591, 1046.6755305855208, 4100.302948498763, 4219.156168766259, 4247.978760106242, 4248.553901840324, 4275.337322714984, 11728.413579321, 12068.939655301667, 12196.390180491117, 12245.755084898252, 12262.386880655931, 11997.0, 12003.819942700866, 12063.336516491501, 12067.57763478274, 12075.396230188631, 8111.75664730059, 8465.280451161598, 8516.531590762568, 8946.418482798597, 9081.50051747147, 6175.413335733098, 6180.289266734383, 6197.535184861244, 6327.841803954938, 6357.777477788255, 10759.623413180501, 10971.0, 11017.338959662446, 11122.054625356936, 11173.217874748689, 11183.161262905152, 11231.66305010851, 11353.432328383713, 11392.0, 11410.771784564427, 8507.95746021266, 8675.089115643019, 8784.209421152127, 8810.515421651871, 8813.735587932373, 9015.594298256725, 9108.908910910806, 9131.13254240846, 9145.542722863696, 9154.67958621445, 7958.562279074475, 8142.51144931306, 8311.376646751396, 8349.206825351583, 8420.157984201776, 8423.789405264917, 8447.619857106567, 8499.0, 8538.829223415622, 8616.181462761027, 7756.767296981099, 7802.063752349754, 7817.96091019564, 7828.569428681477, 7837.921620783719, 5450.5367043801725, 5508.504234618904, 5610.579206559442, 5661.0093233684765, 5696.772129114789, 5444.564434845282, 5471.878264955754, 5476.561875050066, 5480.561555075505, 5522.696251706195], "value": 4949.62406633181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.27461791400754, 357.8711663801031, 360.2758455504436, 363.4130878631008, 365.11095482500133, 5478.945210547893, 5566.610337276392, 5573.721313934302, 5587.38538760736, 5604.327480702311, 5526.723663816813, 5548.805791797288, 5561.304836895388, 5567.137093750465, 5572.442755724435, 4214.536400995888, 4305.870823875289, 4343.174796788616, 4345.826166953318, 4381.277089280281, 4297.634701050414, 4311.655067594601, 4313.633341166004, 4316.093620339717, 4344.956550434503, 4305.698601097924, 4324.632406245473, 4329.978350108245, 4332.65338772899, 4333.176696427684, 4186.832526698929, 4292.678049146327, 4304.289792184286, 4326.935095973563, 4357.891052723676, 3770.472133901256, 3783.0920579060826, 3792.0, 3806.467094606757, 3831.578526362126, 5366.6511676741275, 5378.354597448331, 5394.487523685283, 5394.811181608664, 5419.458054194589, 4711.8350857719815, 4962.950370496321, 4977.228529577921, 4981.252812078181, 5008.29883816266, 5724.398938111522, 5735.397783232742, 5821.515513544062, 5859.2090067841145, 5882.264716910387, 4147.751134931884, 4167.91664166718, 4170.124273902484, 4200.6219440250525, 4202.9789851050855, 5754.187430959234, 5774.82675519735, 5826.271716035496, 6015.608985415934, 6055.394460553954, 4227.112306415687, 4245.91508169841, 4247.638950689165, 4253.361995700608, 4266.573342665771, 4306.095719898856, 4325.740455572675, 4326.610605045561, 4327.653787696977, 4336.544662810423, 4682.742449165328, 4825.855224343275, 4900.313956046157, 4926.802927882916, 4947.664130684695, 5754.309482862, 5775.740091695884, 5792.478676919098, 5799.333076696234, 5801.767929282866, 1476.1217075839859, 1495.132822962679, 1504.247876061969, 1510.9168995705122, 1510.9622259443381, 934.9345545811727, 954.71358592422, 961.1541843177959, 967.2552134856121, 967.5824916497365, 4901.313816065754, 4966.826161084345, 4968.850934471971, 5002.974985125051, 5009.248612708123, 5301.416844147141, 5313.8937221255355, 5326.387465441524, 5327.280817089721, 5334.159714898354, 4846.75766211688, 4852.068066078748, 5001.799928002839, 5005.874853128701, 5052.722100284446, 2809.819875652231, 2817.60553522507, 2842.317843717493, 2856.6859244747234, 2866.8246019132057, 5460.180972854024, 5473.9452605474235, 5477.20580515831, 5478.342598888159, 5494.835154945358, 5032.823851165192, 5481.835544933659, 5487.6158668893595, 5488.079172289747, 5489.39616642169, 5504.4495550444635, 5509.862253443615, 5520.585956053232, 5525.502704756591, 5528.834134975958, 5073.467285934924, 5131.384233891957, 5274.0, 5276.472352764693, 5289.444608316071, 5273.681579605099, 5309.009121579407, 5326.573874089986, 5713.514351280021, 5812.505936995233, 6166.044263139221, 6206.503479721521, 6206.937930620817, 6229.2524897010835, 6241.0, 4261.083866968616, 4263.957360426356, 4271.145770845906, 4280.250956082611, 4286.914261714811, 5745.534888603546, 5917.704114794157, 5929.258842644669, 5956.821295361146, 6025.638461692312, 5760.769569217185, 5783.826485205451, 5805.912911306418, 5821.825345239649, 5845.678487683218, 5535.584831137761, 5824.854378640568, 5830.18377427169, 5832.387599302182, 5852.092925596539, 5777.711114444345, 5802.738876750472, 5809.970950145223, 5817.709114544171, 5830.300363956352, 5872.853178670567, 5919.378465261258, 5945.19739835134, 5951.0, 5968.791092311922, 5511.614187006871, 5729.512991395778, 5733.627314224562, 5748.856278593069, 5804.5356371491025], "value": 4317.2061970985915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.3975169243836, 814.987775183372, 820.9917900820993, 833.899932008159, 872.6291326186371, 16463.753043704353, 17255.654886902255, 17259.309627614897, 17556.385526506576, 17568.912155439237, 14970.401183952628, 15188.088714677127, 15194.696106077872, 15394.076355418683, 15524.767128493082, 720.8089856188114, 859.4843094143495, 878.2315473960285, 882.1443200095929, 892.5225004622529, 878.3807415771865, 879.2833840420069, 882.6778225947547, 883.5493898111977, 883.6642076011107, 762.6225018615793, 929.6513807322254, 930.878985731854, 931.6552875436098, 931.9627214911395, 896.4531635702249, 915.9038300978401, 916.3814425262955, 923.7021984112333, 924.5562130177552, 682.8736683713479, 683.7641013850214, 684.260998122027, 685.1196212866442, 685.4584877946417, 16323.10222937738, 16367.099809510471, 16422.589435264093, 16466.0, 16477.093759843203, 13896.444142234299, 13994.0, 14050.43798248069, 14274.3576539056, 14522.927385363111, 13833.930830345784, 13989.090709103875, 14022.43910243589, 14183.007189496739, 14330.49843255481, 4668.509806470306, 4678.719276843401, 4681.812727490897, 4687.88280292992, 4711.411073615798, 76356.0, 77476.61261693711, 78021.60989195075, 78132.0, 78648.0, 12708.428120734588, 12719.809202861965, 12835.93582032084, 12983.740325193443, 13043.869561304455, 23193.304200874, 23319.0, 23322.766772332398, 23367.065317387114, 23381.0, 8753.080926502753, 8970.327225458117, 8993.640254389751, 9089.954550227207, 9100.271978241724, 4640.6751527393435, 4834.806607735722, 5063.974680126576, 5082.161443361804, 5116.411612664591, 3809.961900381016, 3919.9608003919598, 3921.6666583340734, 3924.0, 3942.113024569449, 624.4005754475754, 627.2723640576909, 678.9219239787388, 719.3525826755962, 747.9364254038468, 660.9140811694449, 715.8153256360731, 736.4660621049803, 779.6959185917497, 851.3104385447683, 10819.0, 11189.160812938899, 11302.208845380908, 11319.264247823865, 11344.602938897264, 790.8260182759784, 800.4116974024088, 801.2908575910245, 813.4387272781762, 834.9373796965131, 5314.5748340132695, 5316.73416329182, 5413.593980451482, 5433.456654334614, 5441.5102640762525, 72840.0, 73055.63472182605, 100871.0, 113102.0, 116024.0, 62861.37138628555, 83781.58109209414, 95414.52292738631, 97837.02162978279, 102815.0, 89666.0, 90135.54932225429, 91371.62942555867, 91520.54239728893, 93224.0, 10296.279260451996, 10588.735281618021, 10787.460626968463, 10794.460276986276, 10875.782484350428, 53931.73034134804, 54559.45440545703, 54966.17550736662, 55423.0, 55744.16383754166, 71970.0, 77472.2252777465, 78805.60597196977, 78838.6058069706, 80610.0, 13783.51757688476, 13806.930965345511, 13925.373358199107, 14112.647183820487, 14620.561383158521, 14095.506657266946, 15227.467038653594, 15681.843181568038, 15736.449224277096, 16379.590510236863, 13452.327383630975, 13513.864861351261, 13567.525136620567, 13772.517961871286, 15732.449364272195, 15346.309416076527, 15556.144412057445, 15897.841021590099, 16364.509064728078, 16530.0, 14599.197044162673, 14999.325030373877, 15080.54758357251, 15577.065376077471, 15610.219489025276, 12191.939040305097, 12661.74676506483, 13070.738585228431, 13159.93420032932, 13317.933410332886, 12103.318088645243, 12833.294168820805, 12970.0, 13036.41336139857, 13090.0], "value": 8135.575636088312, "unit": "score"}], "name": "dromaeo_css", "value": 7588.065389757251, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 111.0, 109.0, 109.0, 110.0, 109.0, 109.0, 108.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 130.0, 126.0, 181.0, 139.0, 133.0, 152.0, 123.0, 154.0, 126.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 74.0, 120.0, 76.0, 76.0, 76.0, 82.0, 98.0, 74.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 121.0, 84.0, 85.0, 85.0, 111.0, 86.0, 85.0, 123.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 52.0, 52.0, 52.0, 54.0, 52.0, 51.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 76.0, 82.0, 79.0, 80.0, 76.0, 77.0, 103.0, 78.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 116.0, 123.0, 122.0, 116.0, 116.0, 120.0, 144.0, 126.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 153.0, 153.0, 158.0, 156.0, 156.0, 157.0, 153.0, 149.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 61.0, 62.0, 62.0, 63.0, 60.0, 60.0, 59.0, 60.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1477.8000000000002, "alertThreshold": 2.0}]} 03:42:07 INFO - Return code: 0 03:42:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:42:07 ERROR - # TBPL SUCCESS # 03:42:07 INFO - Running post-action listener: _resource_record_post_action 03:42:07 INFO - ##### 03:42:07 INFO - ##### Finished run-tests step (success) 03:42:07 INFO - ##### 03:42:07 INFO - Running post-run listener: _resource_record_post_run 03:42:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 466944; Write bytes: 255176704; Read time: 96; Write time: 146544 03:42:07 INFO - TinderboxPrint: CPU usage
13.1% 03:42:07 INFO - TinderboxPrint: I/O read bytes / time
466,944 / 96 03:42:07 INFO - TinderboxPrint: I/O write bytes / time
255,176,704 / 146,544 03:42:07 INFO - TinderboxPrint: CPU idle
8,252.1 (86.9%) 03:42:07 INFO - TinderboxPrint: CPU user
1,201.8 (12.7%) 03:42:07 INFO - TinderboxPrint: Swap in / out
0 / 0 03:42:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5136384; Read time: 0; Write time: 2300 03:42:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 466944; Write bytes: 250040320; Read time: 96; Write time: 144244 03:42:08 INFO - Running post-run listener: _upload_blobber_files 03:42:08 INFO - Blob upload gear active. 03:42:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:42:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:42:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:09 INFO - (blobuploader) - INFO - Done attempting. 03:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:13 INFO - (blobuploader) - INFO - Done attempting. 03:42:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:42:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:13 INFO - (blobuploader) - INFO - Done attempting. 03:42:13 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:13 INFO - Return code: 0 03:42:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a38355dbf5b7dbee669499ad8564f94982be31b1b76826a1317d7ee5d16af1e9342879e16a2d5a43a75fef6b9d87aa99a488f3bf3efa63e02305711b64ad3192", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a3e863fd02d7baff03cafe5c156a2aebe67fd6ee1eebfbea3307ce6f1e48b13fff33c211fe36618f0822dc4cd2937a0f1f513fea4f1d13ffeac591007768458", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f4e13181c6511c1ed47a8caddd76f7513c216dc9e846c9af11d14b964576ae4db53c1febf7cf9df022b17e696a5d59e3bd5d8d076f9b1b1ea535b6ba929d62"} 03:42:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:13 INFO - Contents: 03:42:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a38355dbf5b7dbee669499ad8564f94982be31b1b76826a1317d7ee5d16af1e9342879e16a2d5a43a75fef6b9d87aa99a488f3bf3efa63e02305711b64ad3192", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a3e863fd02d7baff03cafe5c156a2aebe67fd6ee1eebfbea3307ce6f1e48b13fff33c211fe36618f0822dc4cd2937a0f1f513fea4f1d13ffeac591007768458", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f4e13181c6511c1ed47a8caddd76f7513c216dc9e846c9af11d14b964576ae4db53c1febf7cf9df022b17e696a5d59e3bd5d8d076f9b1b1ea535b6ba929d62"} 03:42:13 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:13 INFO - Copying logs to upload dir... 03:42:13 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.493865 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-10 03:42:13.875868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 03:42:13.879723) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465554100.695869-470040231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a38355dbf5b7dbee669499ad8564f94982be31b1b76826a1317d7ee5d16af1e9342879e16a2d5a43a75fef6b9d87aa99a488f3bf3efa63e02305711b64ad3192", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a3e863fd02d7baff03cafe5c156a2aebe67fd6ee1eebfbea3307ce6f1e48b13fff33c211fe36618f0822dc4cd2937a0f1f513fea4f1d13ffeac591007768458", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f4e13181c6511c1ed47a8caddd76f7513c216dc9e846c9af11d14b964576ae4db53c1febf7cf9df022b17e696a5d59e3bd5d8d076f9b1b1ea535b6ba929d62"} build_url:https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/BZjFNNw7TeOpsh0yqiSf2w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a38355dbf5b7dbee669499ad8564f94982be31b1b76826a1317d7ee5d16af1e9342879e16a2d5a43a75fef6b9d87aa99a488f3bf3efa63e02305711b64ad3192", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a3e863fd02d7baff03cafe5c156a2aebe67fd6ee1eebfbea3307ce6f1e48b13fff33c211fe36618f0822dc4cd2937a0f1f513fea4f1d13ffeac591007768458", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f4e13181c6511c1ed47a8caddd76f7513c216dc9e846c9af11d14b964576ae4db53c1febf7cf9df022b17e696a5d59e3bd5d8d076f9b1b1ea535b6ba929d62"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 03:42:13.907499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:42:13.907841) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1465554100.695869-470040231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:42:13.993565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 03:42:13.993927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 03:42:13.994239) ========= ========= Total master_lag: 0.19 =========