builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1470270127.48 results: success (0) buildid: 20160803160121 builduid: 6a61b06a301346d7a68aab5269999430 revision: 6265328c999cc098a56a2e4e3392927c94b220bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.475781) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.476855) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.477544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.494071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.494799) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 17:22:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-08-03 17:22:07 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.675438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.676046) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018412 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.728962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:07.729538) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6265328c999cc098a56a2e4e3392927c94b220bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 6265328c999cc098a56a2e4e3392927c94b220bc --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=9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 17:22:07,878 truncating revision to first 12 chars 2016-08-03 17:22:07,878 Setting DEBUG logging. 2016-08-03 17:22:07,878 attempt 1/10 2016-08-03 17:22:07,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6265328c999c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 17:22:08,295 unpacking tar archive at: autoland-6265328c999c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.853876 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:08.598731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:08.599102) ========= script_repo_revision: 6265328c999cc098a56a2e4e3392927c94b220bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:08.599695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:08.600082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 17:22:08.611304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-03 17:22:08.611617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:08 INFO - MultiFileLogger online at 20160803 17:22:08 in /builds/slave/test 17:22:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 17:22:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:08 INFO - {'append_to_log': False, 17:22:08 INFO - 'base_work_dir': '/builds/slave/test', 17:22:08 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 17:22:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:08 INFO - 'branch': 'Autoland-Non-PGO', 17:22:08 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:08 INFO - 'config_files': ('talos/linux_config.py',), 17:22:08 INFO - 'default_actions': ('clobber', 17:22:08 INFO - 'read-buildbot-config', 17:22:08 INFO - 'download-and-extract', 17:22:08 INFO - 'populate-webroot', 17:22:08 INFO - 'create-virtualenv', 17:22:08 INFO - 'install', 17:22:08 INFO - 'run-tests'), 17:22:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:08 INFO - 'download_minidump_stackwalk': True, 17:22:08 INFO - 'download_symbols': 'ondemand', 17:22:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:22:08 INFO - 'tooltool.py': '/tools/tooltool.py', 17:22:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:22:08 INFO - '/tools/misc-python/virtualenv.py')}, 17:22:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:08 INFO - 'installer_path': 'installer.exe', 17:22:08 INFO - 'log_level': 'info', 17:22:08 INFO - 'log_name': 'talos', 17:22:08 INFO - 'log_to_console': True, 17:22:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:08 INFO - 'opt_config_files': (), 17:22:08 INFO - 'pip_index': False, 17:22:08 INFO - 'sps_profile': False, 17:22:08 INFO - 'sps_profile_interval': 0, 17:22:08 INFO - 'suite': 'dromaeojs', 17:22:08 INFO - 'system_bits': '32', 17:22:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:08 INFO - 'title': 'talos-linux64-ix-013', 17:22:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:08 INFO - 'use_talos_json': True, 17:22:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:08 INFO - 'work_dir': 'build'} 17:22:08 INFO - [mozharness: 2016-08-04 00:22:08.845954Z] Running clobber step. 17:22:08 INFO - Running pre-action listener: _resource_record_pre_action 17:22:08 INFO - Running main action method: clobber 17:22:08 INFO - rmtree: /builds/slave/test/build 17:22:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:09 INFO - Running post-action listener: _resource_record_post_action 17:22:09 INFO - [mozharness: 2016-08-04 00:22:09.289261Z] Finished clobber step (success) 17:22:09 INFO - [mozharness: 2016-08-04 00:22:09.289363Z] Running read-buildbot-config step. 17:22:09 INFO - Running pre-action listener: _resource_record_pre_action 17:22:09 INFO - Running main action method: read_buildbot_config 17:22:09 INFO - Using buildbot properties: 17:22:09 INFO - { 17:22:09 INFO - "project": "", 17:22:09 INFO - "product": "firefox", 17:22:09 INFO - "script_repo_revision": "production", 17:22:09 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 17:22:09 INFO - "repository": "", 17:22:09 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 17:22:09 INFO - "buildid": "20160803160121", 17:22:09 INFO - "pgo_build": "False", 17:22:09 INFO - "basedir": "/builds/slave/test", 17:22:09 INFO - "buildnumber": 153, 17:22:09 INFO - "slavename": "talos-linux64-ix-013", 17:22:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:22:09 INFO - "platform": "ubuntu64_hw", 17:22:09 INFO - "scheduler": "tests-autoland-linux64-talos", 17:22:09 INFO - "branch": "autoland", 17:22:09 INFO - "repo_path": "integration/autoland", 17:22:09 INFO - "revision": "6265328c999cc098a56a2e4e3392927c94b220bc", 17:22:09 INFO - "stage_platform": "linux64", 17:22:09 INFO - "builduid": "6a61b06a301346d7a68aab5269999430", 17:22:09 INFO - "slavebuilddir": "test" 17:22:09 INFO - } 17:22:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:22:09 INFO - Running post-action listener: _resource_record_post_action 17:22:09 INFO - [mozharness: 2016-08-04 00:22:09.292012Z] Finished read-buildbot-config step (success) 17:22:09 INFO - [mozharness: 2016-08-04 00:22:09.292102Z] Running download-and-extract step. 17:22:09 INFO - Running pre-action listener: _resource_record_pre_action 17:22:09 INFO - Running main action method: download_and_extract 17:22:09 INFO - mkdir: /builds/slave/test/build/tests 17:22:09 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')]} 17:22:09 INFO - https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:22:09 INFO - Downloaded 1361 bytes. 17:22:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:22:09 INFO - Using the following test package requirements: 17:22:09 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:22:09 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:22:09 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:22:09 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:09 INFO - u'jsshell-linux-x86_64.zip'], 17:22:09 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:22:09 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:22:09 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:22:09 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:22:09 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:22:09 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:22:09 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:22:09 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')]} 17:22:09 INFO - https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:22:10 INFO - Downloaded 20241031 bytes. 17:22:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:22:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:22:11 INFO - Return code: 0 17:22:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:22:11 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')]} 17:22:11 INFO - https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:22:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:22:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:22:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:22:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:22:12 INFO - Downloaded 20241031 bytes. 17:22:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:22:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:22:14 INFO - Return code: 0 17: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')]} 17:22:14 INFO - https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:22:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:22:15 INFO - Downloaded 14413723 bytes. 17:22:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:22:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:22:15 INFO - Return code: 0 17:22:15 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')]} 17:22:15 INFO - https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:22:16 INFO - Downloaded 55564698 bytes. 17:22:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:22:16 INFO - mkdir: /builds/slave/test/properties 17:22:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:16 INFO - Contents: 17:22:16 INFO - build_url:https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:22:17 INFO - Running post-action listener: _resource_record_post_action 17:22:17 INFO - Running post-action listener: set_extra_try_arguments 17:22:17 INFO - [mozharness: 2016-08-04 00:22:17.597642Z] Finished download-and-extract step (success) 17:22:17 INFO - [mozharness: 2016-08-04 00:22:17.597876Z] Running populate-webroot step. 17:22:17 INFO - Running pre-action listener: _resource_record_pre_action 17:22:17 INFO - Running main action method: populate_webroot 17:22:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:22:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:22:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:22:17 INFO - '--tppagecycles', 17:22:17 INFO - '7'], 17:22:17 INFO - 'tests': ['tsvgm']}}, 17:22:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:22:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:22:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:17 INFO - 'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:17 INFO - 'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['damp', 'tps']}, 17:22:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:17 INFO - 'tests': ['damp', 'tps']}, 17:22:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['dromaeo_dom']}, 17:22:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['basic_compositor_video']}, 17:22:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:22:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['a11yr', 17:22:17 INFO - 'ts_paint', 17:22:17 INFO - 'tpaint', 17:22:17 INFO - 'sessionrestore', 17:22:17 INFO - 'sessionrestore_no_auto_restore', 17:22:17 INFO - 'tabpaint']}, 17:22:17 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:17 INFO - 'ts_paint', 17:22:17 INFO - 'tpaint', 17:22:17 INFO - 'sessionrestore', 17:22:17 INFO - 'sessionrestore_no_auto_restore', 17:22:17 INFO - 'tabpaint']}, 17:22:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:22:17 INFO - 'ts_paint', 17:22:17 INFO - 'tpaint', 17:22:17 INFO - 'sessionrestore', 17:22:17 INFO - 'sessionrestore_no_auto_restore', 17:22:17 INFO - 'tabpaint']}, 17:22:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:22:17 INFO - 'ts_paint', 17:22:17 INFO - 'tpaint', 17:22:17 INFO - 'sessionrestore', 17:22:17 INFO - 'sessionrestore_no_auto_restore', 17:22:17 INFO - 'tabpaint']}, 17:22:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['a11yr', 17:22:17 INFO - 'ts_paint', 17:22:17 INFO - 'tpaint', 17:22:17 INFO - 'sessionrestore', 17:22:17 INFO - 'sessionrestore_no_auto_restore', 17:22:17 INFO - 'tabpaint']}, 17:22:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['a11yr', 17:22:17 INFO - 'ts_paint', 17:22:17 INFO - 'tpaint', 17:22:17 INFO - 'sessionrestore', 17:22:17 INFO - 'sessionrestore_no_auto_restore', 17:22:17 INFO - 'tabpaint']}, 17:22:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['tsvgx', 17:22:17 INFO - 'tsvgr_opacity', 17:22:17 INFO - 'tart', 17:22:17 INFO - 'tscrollx', 17:22:17 INFO - 'cart']}, 17:22:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:17 INFO - 'tsvgr_opacity', 17:22:17 INFO - 'tart', 17:22:17 INFO - 'tscrollx', 17:22:17 INFO - 'cart']}, 17:22:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:17 INFO - 'talos_options': ['--disable-e10s'], 17:22:17 INFO - 'tests': ['tp5o']}, 17:22:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:17 INFO - 'tests': ['tp5o']}, 17:22:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:17 INFO - 'talos_options': ['--disable-e10s', 17:22:17 INFO - '--xperf_path', 17:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:17 INFO - 'tests': ['tp5n']}, 17:22:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:17 INFO - 'talos_options': ['--xperf_path', 17:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:17 INFO - 'tests': ['tp5n']}}, 17:22:17 INFO - 'talos.zip': {'path': '', 17:22:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:22:17 INFO - Running post-action listener: _resource_record_post_action 17:22:17 INFO - [mozharness: 2016-08-04 00:22:17.613528Z] Finished populate-webroot step (success) 17:22:17 INFO - [mozharness: 2016-08-04 00:22:17.613618Z] Running create-virtualenv step. 17:22:17 INFO - Running pre-action listener: _resource_record_pre_action 17:22:17 INFO - Running main action method: create_virtualenv 17:22:17 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:17 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 17:22:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:22:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:17 INFO - Using real prefix '/usr' 17:22:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:22:18 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:20 INFO - Installing pip.................done. 17:22:20 INFO - Return code: 0 17:22:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22:20 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')]} 17:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:20 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')]} 17:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:20 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:20 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 17:22:20 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 17:22:20 INFO - Using env: {'DISPLAY': ':0', 17:22:20 INFO - 'HOME': '/home/cltbld', 17:22:20 INFO - 'LANG': 'en_US.UTF-8', 17:22:20 INFO - 'LANGUAGE': 'en_US:en', 17:22:20 INFO - 'LOGNAME': 'cltbld', 17:22:20 INFO - 'MAIL': '/var/mail/cltbld', 17:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:20 INFO - 'MOZ_NO_REMOTE': '1', 17:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:20 INFO - 'NO_EM_RESTART': '1', 17:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:20 INFO - 'PWD': '/builds/slave/test', 17:22:20 INFO - 'SHELL': '/bin/bash', 17:22:20 INFO - 'SHLVL': '1', 17:22:20 INFO - 'TERM': 'linux', 17:22:20 INFO - 'TMOUT': '86400', 17:22:20 INFO - 'USER': 'cltbld', 17:22:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:20 INFO - '_': '/tools/buildbot/bin/python'} 17:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:20 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 17:22:20 INFO - Cleaning up... 17:22:20 INFO - Return code: 0 17:22:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:22:20 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')]} 17:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:20 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')]} 17:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:20 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:20 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 17:22:20 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 17:22:20 INFO - Using env: {'DISPLAY': ':0', 17:22:20 INFO - 'HOME': '/home/cltbld', 17:22:20 INFO - 'LANG': 'en_US.UTF-8', 17:22:20 INFO - 'LANGUAGE': 'en_US:en', 17:22:20 INFO - 'LOGNAME': 'cltbld', 17:22:20 INFO - 'MAIL': '/var/mail/cltbld', 17:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:20 INFO - 'MOZ_NO_REMOTE': '1', 17:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:20 INFO - 'NO_EM_RESTART': '1', 17:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:20 INFO - 'PWD': '/builds/slave/test', 17:22:20 INFO - 'SHELL': '/bin/bash', 17:22:20 INFO - 'SHLVL': '1', 17:22:20 INFO - 'TERM': 'linux', 17:22:20 INFO - 'TMOUT': '86400', 17:22:20 INFO - 'USER': 'cltbld', 17:22:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:20 INFO - '_': '/tools/buildbot/bin/python'} 17:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:20 INFO - Downloading/unpacking psutil>=3.1.1 17:22:20 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 17:22:20 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 17:22:20 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 17:22:20 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 17:22:20 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 17:22:20 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 17:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:22 INFO - Installing collected packages: psutil 17:22:22 INFO - Running setup.py install for psutil 17:22:22 INFO - building 'psutil._psutil_linux' extension 17:22:22 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 17:22:22 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 17:22:22 INFO - building 'psutil._psutil_posix' extension 17:22:22 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 17:22:23 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 17:22:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:23 INFO - Successfully installed psutil 17:22:23 INFO - Cleaning up... 17:22:23 INFO - Return code: 0 17:22:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:22:23 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')]} 17:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:23 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')]} 17:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:23 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:23 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 17:22:23 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 17:22:23 INFO - Using env: {'DISPLAY': ':0', 17:22:23 INFO - 'HOME': '/home/cltbld', 17:22:23 INFO - 'LANG': 'en_US.UTF-8', 17:22:23 INFO - 'LANGUAGE': 'en_US:en', 17:22:23 INFO - 'LOGNAME': 'cltbld', 17:22:23 INFO - 'MAIL': '/var/mail/cltbld', 17:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:23 INFO - 'MOZ_NO_REMOTE': '1', 17:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:23 INFO - 'NO_EM_RESTART': '1', 17:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:23 INFO - 'PWD': '/builds/slave/test', 17:22:23 INFO - 'SHELL': '/bin/bash', 17:22:23 INFO - 'SHLVL': '1', 17:22:23 INFO - 'TERM': 'linux', 17:22:23 INFO - 'TMOUT': '86400', 17:22:23 INFO - 'USER': 'cltbld', 17:22:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:23 INFO - '_': '/tools/buildbot/bin/python'} 17:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:22:23 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 17:22:23 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 17:22:23 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 17:22:23 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 17:22:23 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 17:22:23 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 17:22:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:25 INFO - Installing collected packages: mozsystemmonitor 17:22:25 INFO - Running setup.py install for mozsystemmonitor 17:22:25 INFO - Successfully installed mozsystemmonitor 17:22:25 INFO - Cleaning up... 17:22:25 INFO - Return code: 0 17:22:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:22:25 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')]} 17:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:25 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')]} 17:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:25 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:25 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 17:22:25 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 17:22:25 INFO - Using env: {'DISPLAY': ':0', 17:22:25 INFO - 'HOME': '/home/cltbld', 17:22:25 INFO - 'LANG': 'en_US.UTF-8', 17:22:25 INFO - 'LANGUAGE': 'en_US:en', 17:22:25 INFO - 'LOGNAME': 'cltbld', 17:22:25 INFO - 'MAIL': '/var/mail/cltbld', 17:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:25 INFO - 'MOZ_NO_REMOTE': '1', 17:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:25 INFO - 'NO_EM_RESTART': '1', 17:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:25 INFO - 'PWD': '/builds/slave/test', 17:22:25 INFO - 'SHELL': '/bin/bash', 17:22:25 INFO - 'SHLVL': '1', 17:22:25 INFO - 'TERM': 'linux', 17:22:25 INFO - 'TMOUT': '86400', 17:22:25 INFO - 'USER': 'cltbld', 17:22:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:25 INFO - '_': '/tools/buildbot/bin/python'} 17:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:25 INFO - Downloading/unpacking jsonschema==2.5.1 17:22:25 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 17:22:25 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 17:22:25 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 17:22:25 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 17:22:25 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 17:22:25 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 17:22:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:22:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:22:27 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 17:22:27 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 17:22:27 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 17:22:27 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 17:22:27 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 17:22:27 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 17:22:27 INFO - Downloading functools32-3.2.3-2.tar.gz 17:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:22:27 INFO - warning: no files found matching '*.txt' 17:22:27 INFO - no previously-included directories found matching 'build' 17:22:27 INFO - no previously-included directories found matching 'dist' 17:22:27 INFO - no previously-included directories found matching '.git*' 17:22:27 INFO - Installing collected packages: jsonschema, functools32 17:22:27 INFO - Running setup.py install for functools32 17:22:27 INFO - warning: no files found matching '*.txt' 17:22:27 INFO - no previously-included directories found matching 'build' 17:22:27 INFO - no previously-included directories found matching 'dist' 17:22:27 INFO - no previously-included directories found matching '.git*' 17:22:27 INFO - Successfully installed jsonschema functools32 17:22:27 INFO - Cleaning up... 17:22:28 INFO - Return code: 0 17:22:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:22:28 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')]} 17:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:28 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')]} 17:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:28 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:28 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:22:28 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 functools32==3.2.3-2 17:22:28 INFO - Using env: {'DISPLAY': ':0', 17:22:28 INFO - 'HOME': '/home/cltbld', 17:22:28 INFO - 'LANG': 'en_US.UTF-8', 17:22:28 INFO - 'LANGUAGE': 'en_US:en', 17:22:28 INFO - 'LOGNAME': 'cltbld', 17:22:28 INFO - 'MAIL': '/var/mail/cltbld', 17:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:28 INFO - 'MOZ_NO_REMOTE': '1', 17:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:28 INFO - 'NO_EM_RESTART': '1', 17:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:28 INFO - 'PWD': '/builds/slave/test', 17:22:28 INFO - 'SHELL': '/bin/bash', 17:22:28 INFO - 'SHLVL': '1', 17:22:28 INFO - 'TERM': 'linux', 17:22:28 INFO - 'TMOUT': '86400', 17:22:28 INFO - 'USER': 'cltbld', 17:22:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:28 INFO - '_': '/tools/buildbot/bin/python'} 17:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:22:28 INFO - Cleaning up... 17:22:28 INFO - Return code: 0 17:22:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:22:28 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')]} 17:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:28 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')]} 17:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:28 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:28 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 17:22:28 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 17:22:28 INFO - Using env: {'DISPLAY': ':0', 17:22:28 INFO - 'HOME': '/home/cltbld', 17:22:28 INFO - 'LANG': 'en_US.UTF-8', 17:22:28 INFO - 'LANGUAGE': 'en_US:en', 17:22:28 INFO - 'LOGNAME': 'cltbld', 17:22:28 INFO - 'MAIL': '/var/mail/cltbld', 17:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:28 INFO - 'MOZ_NO_REMOTE': '1', 17:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:28 INFO - 'NO_EM_RESTART': '1', 17:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:28 INFO - 'PWD': '/builds/slave/test', 17:22:28 INFO - 'SHELL': '/bin/bash', 17:22:28 INFO - 'SHLVL': '1', 17:22:28 INFO - 'TERM': 'linux', 17:22:28 INFO - 'TMOUT': '86400', 17:22:28 INFO - 'USER': 'cltbld', 17:22:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:28 INFO - '_': '/tools/buildbot/bin/python'} 17:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:28 INFO - Downloading/unpacking blobuploader==1.2.4 17:22:28 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 17:22:28 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 17:22:28 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 17:22:28 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 17:22:28 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 17:22:28 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 17:22:30 INFO - Downloading blobuploader-1.2.4.tar.gz 17:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:22:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:22:30 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 17:22:30 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 17:22:30 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 17:22:30 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 17:22:30 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 17:22:30 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 17:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:22:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:22:30 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 17:22:30 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 17:22:30 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 17:22:30 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 17:22:30 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 17:22:30 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 17:22:30 INFO - Downloading docopt-0.6.1.tar.gz 17:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:22:31 INFO - Installing collected packages: blobuploader, requests, docopt 17:22:31 INFO - Running setup.py install for blobuploader 17:22:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:22:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:22:31 INFO - Running setup.py install for requests 17:22:31 INFO - Running setup.py install for docopt 17:22:31 INFO - Successfully installed blobuploader requests docopt 17:22:31 INFO - Cleaning up... 17:22:31 INFO - Return code: 0 17:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:31 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')]} 17:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:31 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')]} 17:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:31 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:31 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 17:22:31 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 17:22:31 INFO - Using env: {'DISPLAY': ':0', 17:22:31 INFO - 'HOME': '/home/cltbld', 17:22:31 INFO - 'LANG': 'en_US.UTF-8', 17:22:31 INFO - 'LANGUAGE': 'en_US:en', 17:22:31 INFO - 'LOGNAME': 'cltbld', 17:22:31 INFO - 'MAIL': '/var/mail/cltbld', 17:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:31 INFO - 'MOZ_NO_REMOTE': '1', 17:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:31 INFO - 'NO_EM_RESTART': '1', 17:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:31 INFO - 'PWD': '/builds/slave/test', 17:22:31 INFO - 'SHELL': '/bin/bash', 17:22:31 INFO - 'SHLVL': '1', 17:22:31 INFO - 'TERM': 'linux', 17:22:31 INFO - 'TMOUT': '86400', 17:22:31 INFO - 'USER': 'cltbld', 17:22:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:31 INFO - '_': '/tools/buildbot/bin/python'} 17:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:31 INFO - Running setup.py (path:/tmp/pip-38oWMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:31 INFO - Running setup.py (path:/tmp/pip-hZPWZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:32 INFO - Running setup.py (path:/tmp/pip-zU5wR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:32 INFO - Running setup.py (path:/tmp/pip-kgeqiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:32 INFO - Running setup.py (path:/tmp/pip-PU0new-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:32 INFO - Running setup.py (path:/tmp/pip-T0MwkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:32 INFO - Running setup.py (path:/tmp/pip-Ig8OBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:32 INFO - Running setup.py (path:/tmp/pip-NivEW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:32 INFO - Running setup.py (path:/tmp/pip-NnrJL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:32 INFO - Running setup.py (path:/tmp/pip-J85_sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:32 INFO - Running setup.py (path:/tmp/pip-01uoQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:32 INFO - Running setup.py (path:/tmp/pip-a4fQev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:32 INFO - Running setup.py (path:/tmp/pip-7E3oNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:32 INFO - Running setup.py (path:/tmp/pip-lHgHLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:32 INFO - Running setup.py (path:/tmp/pip-2EIp3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:32 INFO - Running setup.py (path:/tmp/pip-QvrD0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:33 INFO - Running setup.py (path:/tmp/pip-m6P5Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:22:33 INFO - Running setup.py install for manifestparser 17:22:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Running setup.py install for mozcrash 17:22:33 INFO - Running setup.py install for mozdebug 17:22:33 INFO - Running setup.py install for mozdevice 17:22:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Running setup.py install for mozfile 17:22:33 INFO - Running setup.py install for mozhttpd 17:22:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Running setup.py install for mozinfo 17:22:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Running setup.py install for mozInstall 17:22:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:22:33 INFO - Running setup.py install for mozleak 17:22:33 INFO - Running setup.py install for mozlog 17:22:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Running setup.py install for moznetwork 17:22:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Running setup.py install for mozprocess 17:22:34 INFO - Running setup.py install for mozprofile 17:22:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Running setup.py install for mozrunner 17:22:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Running setup.py install for mozscreenshot 17:22:34 INFO - Running setup.py install for moztest 17:22:34 INFO - Running setup.py install for mozversion 17:22:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:22:34 INFO - Cleaning up... 17:22:34 INFO - Return code: 0 17:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:34 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')]} 17:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:34 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')]} 17:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:34 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:34 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 17:22:34 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 17:22:34 INFO - Using env: {'DISPLAY': ':0', 17:22:34 INFO - 'HOME': '/home/cltbld', 17:22:34 INFO - 'LANG': 'en_US.UTF-8', 17:22:34 INFO - 'LANGUAGE': 'en_US:en', 17:22:34 INFO - 'LOGNAME': 'cltbld', 17:22:34 INFO - 'MAIL': '/var/mail/cltbld', 17:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:34 INFO - 'MOZ_NO_REMOTE': '1', 17:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:34 INFO - 'NO_EM_RESTART': '1', 17:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:34 INFO - 'PWD': '/builds/slave/test', 17:22:34 INFO - 'SHELL': '/bin/bash', 17:22:34 INFO - 'SHLVL': '1', 17:22:34 INFO - 'TERM': 'linux', 17:22:34 INFO - 'TMOUT': '86400', 17:22:34 INFO - 'USER': 'cltbld', 17:22:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:34 INFO - '_': '/tools/buildbot/bin/python'} 17:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:35 INFO - Running setup.py (path:/tmp/pip-Uwbogw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:35 INFO - Running setup.py (path:/tmp/pip-hN7L7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:35 INFO - Running setup.py (path:/tmp/pip-DYYTNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:35 INFO - Running setup.py (path:/tmp/pip-MxcZPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:35 INFO - Running setup.py (path:/tmp/pip-aKpeVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:35 INFO - Running setup.py (path:/tmp/pip-QpmyRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:35 INFO - Running setup.py (path:/tmp/pip-H5ahk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:35 INFO - Running setup.py (path:/tmp/pip-3GJo1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:35 INFO - Running setup.py (path:/tmp/pip-kqmHvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:35 INFO - Running setup.py (path:/tmp/pip-Cfm4HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:35 INFO - Running setup.py (path:/tmp/pip-5J3qZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:35 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:35 INFO - Running setup.py (path:/tmp/pip-RMezve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 17:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:35 INFO - Running setup.py (path:/tmp/pip-dlFesz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:36 INFO - Running setup.py (path:/tmp/pip-45hYGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:36 INFO - Running setup.py (path:/tmp/pip-bQig7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:36 INFO - Running setup.py (path:/tmp/pip-jHI56l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:36 INFO - Running setup.py (path:/tmp/pip-wpxYUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:36 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)) 17:22:36 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)) 17:22:36 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)) 17:22:36 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)) 17:22:36 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)) 17:22:36 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)) 17:22:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:22:36 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 17:22:36 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 17:22:36 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 17:22:36 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 17:22:36 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 17:22:36 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 17:22:38 INFO - Downloading blessings-1.6.tar.gz 17:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:22:38 INFO - Installing collected packages: blessings 17:22:38 INFO - Running setup.py install for blessings 17:22:38 INFO - Successfully installed blessings 17:22:38 INFO - Cleaning up... 17:22:38 INFO - Return code: 0 17:22:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:38 INFO - Reading from file tmpfile_stdout 17:22:38 INFO - Current package versions: 17:22:38 INFO - argparse == 1.2.1 17:22:38 INFO - blessings == 1.6 17:22:38 INFO - blobuploader == 1.2.4 17:22:38 INFO - docopt == 0.6.1 17:22:38 INFO - functools32 == 3.2.3-2 17:22:38 INFO - jsonschema == 2.5.1 17:22:38 INFO - manifestparser == 1.1 17:22:38 INFO - mozInstall == 1.12 17:22:38 INFO - mozcrash == 0.17 17:22:38 INFO - mozdebug == 0.1 17:22:38 INFO - mozdevice == 0.48 17:22:38 INFO - mozfile == 1.2 17:22:38 INFO - mozhttpd == 0.7 17:22:38 INFO - mozinfo == 0.9 17:22:38 INFO - mozleak == 0.1 17:22:38 INFO - mozlog == 3.3 17:22:38 INFO - moznetwork == 0.27 17:22:38 INFO - mozprocess == 0.23 17:22:38 INFO - mozprofile == 0.28 17:22:38 INFO - mozrunner == 6.12 17:22:38 INFO - mozscreenshot == 0.1 17:22:38 INFO - mozsystemmonitor == 0.3 17:22:38 INFO - moztest == 0.7 17:22:38 INFO - mozversion == 1.4 17:22:38 INFO - psutil == 3.1.1 17:22:38 INFO - requests == 1.2.3 17:22:38 INFO - wsgiref == 0.1.2 17:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:38 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')]} 17:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:38 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')]} 17:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:38 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:38 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 17:22:38 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 17:22:38 INFO - Using env: {'DISPLAY': ':0', 17:22:38 INFO - 'HOME': '/home/cltbld', 17:22:38 INFO - 'LANG': 'en_US.UTF-8', 17:22:38 INFO - 'LANGUAGE': 'en_US:en', 17:22:38 INFO - 'LOGNAME': 'cltbld', 17:22:38 INFO - 'MAIL': '/var/mail/cltbld', 17:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:38 INFO - 'MOZ_NO_REMOTE': '1', 17:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:38 INFO - 'NO_EM_RESTART': '1', 17:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:38 INFO - 'PWD': '/builds/slave/test', 17:22:38 INFO - 'SHELL': '/bin/bash', 17:22:38 INFO - 'SHLVL': '1', 17:22:38 INFO - 'TERM': 'linux', 17:22:38 INFO - 'TMOUT': '86400', 17:22:38 INFO - 'USER': 'cltbld', 17:22:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:38 INFO - '_': '/tools/buildbot/bin/python'} 17:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 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)) 17:22:38 INFO - Cleaning up... 17:22:38 INFO - Return code: 0 17:22:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:22:38 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')]} 17:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:38 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')]} 17:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:38 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 0x2263030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', '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 17:22:38 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 17:22:38 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 17:22:38 INFO - Using env: {'DISPLAY': ':0', 17:22:38 INFO - 'HOME': '/home/cltbld', 17:22:38 INFO - 'LANG': 'en_US.UTF-8', 17:22:38 INFO - 'LANGUAGE': 'en_US:en', 17:22:38 INFO - 'LOGNAME': 'cltbld', 17:22:38 INFO - 'MAIL': '/var/mail/cltbld', 17:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:38 INFO - 'MOZ_NO_REMOTE': '1', 17:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:38 INFO - 'NO_EM_RESTART': '1', 17:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:38 INFO - 'PWD': '/builds/slave/test', 17:22:38 INFO - 'SHELL': '/bin/bash', 17:22:38 INFO - 'SHLVL': '1', 17:22:38 INFO - 'TERM': 'linux', 17:22:38 INFO - 'TMOUT': '86400', 17:22:38 INFO - 'USER': 'cltbld', 17:22:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:38 INFO - '_': '/tools/buildbot/bin/python'} 17:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:22:39 INFO - Cleaning up... 17:22:39 INFO - Return code: 0 17:22:39 INFO - Running post-action listener: _resource_record_post_action 17:22:39 INFO - Running post-action listener: _start_resource_monitoring 17:22:39 INFO - Starting resource monitoring. 17:22:39 INFO - [mozharness: 2016-08-04 00:22:39.205753Z] Finished create-virtualenv step (success) 17:22:39 INFO - [mozharness: 2016-08-04 00:22:39.206231Z] Running install step. 17:22:39 INFO - Running pre-action listener: _resource_record_pre_action 17:22:39 INFO - Running main action method: install 17:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:39 INFO - Reading from file tmpfile_stdout 17:22:39 INFO - Detecting whether we're running mozinstall >=1.0... 17:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:22:39 INFO - Reading from file tmpfile_stdout 17:22:39 INFO - Output received: 17:22:39 INFO - Usage: mozinstall [options] installer 17:22:39 INFO - Options: 17:22:39 INFO - -h, --help show this help message and exit 17:22:39 INFO - -d DEST, --destination=DEST 17:22:39 INFO - Directory to install application into. [default: 17:22:39 INFO - "/builds/slave/test"] 17:22:39 INFO - --app=APP Application being installed. [default: firefox] 17:22:39 INFO - mkdir: /builds/slave/test/build/application 17:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:22:55 INFO - Reading from file tmpfile_stdout 17:22:55 INFO - Output received: 17:22:55 INFO - /builds/slave/test/build/application/firefox/firefox 17:22:55 INFO - Running post-action listener: _resource_record_post_action 17:22:55 INFO - [mozharness: 2016-08-04 00:22:55.495844Z] Finished install step (success) 17:22:55 INFO - [mozharness: 2016-08-04 00:22:55.496125Z] Running run-tests step. 17:22:55 INFO - Running pre-action listener: _resource_record_pre_action 17:22:55 INFO - Running main action method: run_tests 17:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:22:55 INFO - Python 2.7.3 17:22:55 INFO - Return code: 0 17:22:55 INFO - grabbing minidump binary from tooltool 17:22: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')]} 17:22:55 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 0x25223b0>, '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 0x25232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2523740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:22:55 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 17:22:55 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 17:22:55 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 17:22:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:22:55 INFO - Return code: 0 17:22:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:22:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:22:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:22:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:22:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 17:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 17:22:55 INFO - Using env: {'DISPLAY': ':0', 17:22:55 INFO - 'HOME': '/home/cltbld', 17:22:55 INFO - 'LANG': 'en_US.UTF-8', 17:22:55 INFO - 'LANGUAGE': 'en_US:en', 17:22:55 INFO - 'LOGNAME': 'cltbld', 17:22:55 INFO - 'MAIL': '/var/mail/cltbld', 17:22:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:22:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:55 INFO - 'MOZ_NO_REMOTE': '1', 17:22:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:55 INFO - 'NO_EM_RESTART': '1', 17:22:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:55 INFO - 'PWD': '/builds/slave/test', 17:22:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:22:55 INFO - 'SHELL': '/bin/bash', 17:22:55 INFO - 'SHLVL': '1', 17:22:55 INFO - 'TERM': 'linux', 17:22:55 INFO - 'TMOUT': '86400', 17:22:55 INFO - 'USER': 'cltbld', 17:22:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590', 17:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:55 INFO - '_': '/tools/buildbot/bin/python'} 17:22:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 17:22:55 INFO - mozversion application_buildid: 20160803160121 17:22:55 INFO - mozversion application_changeset: 6265328c999cc098a56a2e4e3392927c94b220bc 17:22:55 INFO - mozversion application_display_name: Nightly 17:22:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:22:55 INFO - mozversion application_name: Firefox 17:22:55 INFO - mozversion application_remotingname: firefox 17:22:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:22:55 INFO - mozversion application_vendor: Mozilla 17:22:55 INFO - mozversion application_version: 51.0a1 17:22:55 INFO - mozversion platform_buildid: 20160803160121 17:22:55 INFO - mozversion platform_changeset: 6265328c999cc098a56a2e4e3392927c94b220bc 17:22:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:22:55 INFO - mozversion platform_version: 51.0a1 17:22:55 INFO - using testdate: 1470270175 17:22:55 INFO - actual date: 1470270175 17:22:55 INFO - starting webserver on 'localhost:44978' 17:22:55 INFO - SUITE-START | Running 2 tests 17:22:55 INFO - TEST-START | dromaeo_css 17:22:55 INFO - operating with platform_type : linux_ 17:22:55 INFO - Initialising browser for dromaeo_css test... 17:22:55 INFO - TEST-INFO | started process 8313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpffxq7z/profile http://localhost:44978/getInfo.html) 17:23:00 INFO - PROCESS | 8313 | __metrics Screen width/height:1600/1200 17:23:00 INFO - PROCESS | 8313 | colorDepth:24 17:23:00 INFO - PROCESS | 8313 | Browser inner width/height: 1024/697 17:23:00 INFO - PROCESS | 8313 | __metrics 17:23:01 INFO - PROCESS | 8313 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:23:01 INFO - PROCESS | 8313 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:23:02 INFO - TEST-INFO | 8313: exit 0 17:23:02 INFO - Browser initialized. 17:23:02 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:02 INFO - TEST-INFO | started process 8388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpffxq7z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:14 INFO - PROCESS | 8388 | RSS: Main: 158097408 17:23:14 INFO - PROCESS | 8388 | 17:24:06 INFO - PROCESS | 8388 | 1470270246106 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] 17:26:18 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:44978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44978/tests/dromaeo/cssquery-ext.html) 17:26:19 INFO - PROCESS | 8388 | RSS: Main: 239042560 17:26:19 INFO - PROCESS | 8388 | 17:29:21 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:44978/tests/dromaeo/cssquery-ext.html (next: http://localhost:44978/tests/dromaeo/cssquery-jquery.html) 17:29:22 INFO - PROCESS | 8388 | RSS: Main: 244678656 17:29:22 INFO - PROCESS | 8388 | 17:32:24 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:44978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44978/tests/dromaeo/cssquery-mootools.html) 17:32:25 INFO - PROCESS | 8388 | RSS: Main: 251682816 17:32:25 INFO - PROCESS | 8388 | 17:35:27 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:44978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44978/tests/dromaeo/cssquery-prototype.html) 17:35:27 INFO - PROCESS | 8388 | RSS: Main: 191373312 17:35:27 INFO - PROCESS | 8388 | 17:38:31 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:44978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44978/tests/dromaeo/cssquery-yui.html) 17:38:31 INFO - PROCESS | 8388 | RSS: Main: 189153280 17:38:31 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:44978/tests/dromaeo/cssquery-yui.html (next: http://localhost:44978/tests/dromaeo/cssquery-dojo.html) 17:41:34 INFO - PROCESS | 8388 | RSS: Main: 269529088 17:41:34 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | __start_tp_report 17:41:34 INFO - PROCESS | 8388 | _x_x_mozilla_page_load 17:41:34 INFO - PROCESS | 8388 | _x_x_mozilla_page_load_details 17:41:34 INFO - PROCESS | 8388 | |i|pagename|runs| 17:41:34 INFO - PROCESS | 8388 | |0;dojo.html;2600.2329312852708;2619.0309585453383;2643.881025353859;2657.4685062987396;2662.6405435266247;4571.588557029867;4608.308753686949;4766.9507335492435;4814.662973591846;4824.63815213859;4661.88345291367;4697.9765101174535;4796.328514008042;4847.612191024718;4862.2220444728855;4288.035192081772;4332.350147477872;4352.194843953878;4372.103718737667;4424.048829501657;4387.824487020532;4488.281874900017;4495.64034877209;4498.932516012263;4546.0680560485025;4243.575642435762;4329.307310830283;4458.152950939344;4468.642508599304;4556.589906908378;4331;4403.603675669206;4418.469783625986;4419.602235798761;4478.596926276651;4327.848525301631;4350.651947844165;4357.433533640638;4388.078503514266;4392.011797345604;4557.293619488984;4812.205986012339;4813.590844778198;4824.252240902666;4832.299316599108;5028.245763135559;5066.949330506684;5068.898622027576;5180.611454140954;5184.196449550326;5158.123119069767;5202.037623039712;5205.817796377109;5207.375114986188;5209.218617207449;4829.661923665345;4834;4835.274708793674;4837.854864354075;4840.83057093;4944.060628480577;4979.278004689299;5252.2384254282915;5293.629445938747;5317.601179911522;5108.233764935289;5154.742262886841;5161.225816127536;5162.328897243335;5162.6386152968935;5203.765830537635;5206.817761378409;5211.400688920747;5245.10833158364;5255.39562950258;4829.034193161311;5005.3242812220615;5090.211017292326;5113.8721531962;5143.665661731976;5129.051125541787;5130.4356520782685;5134.614903882149;5135.383753949475;5173.22401639757;4306.461692288464;4329.891752706208;4333.653307735373;4380.408644832907;4382.057857560576;3619.475176099451;3667.431548110047;3698.7041036717537;3728.9440658390145;3789.052736815796;4389.253826849444;4430.756308403069;4436.578525040116;4461.152381047591;4466.888327791831;5127.743612819419;5133.204353325241;5137.897242055138;5145.716985565755;5188.143956247177;4245.448091748053;4359.346098085312;4419.469663640384;4424.6239069678795;4472.418585583853;4572.1312950539295;4587.655925805511;4590.104929538707;4635;4638.257878739386;4782.665213435026;4796.5203479651755;4796.664233503621;4798.04039192156;4842.322074909515;4944.777485013255;5054.317667114892;5109.386873575195;5111.977604479193;5154.458781827854;4750.097481478508;4783.6412269079265;4807.663463557517;4850.53919877611;4852.44196917359;5001.399832020181;5027.874303142451;5030.673006254582;5033.647644664985;5083.542481176712;4849.854504364875;5042.697438153723;5094.337736094284;5111.233315002779;5159.845204643867;4991.126552853309;5021.84934451967;5053.216751403538;5075.11185542536;5102.69383836971;5017.448080711192;5035.974820125876;5036.445990941067;5040.117979353525;5084.9745751271;4665.953340466687;4897.877553061202;4954.281629163823;4960.553550180501;5018.222175562793;5027.195648696191;5069.366329208849;5076.238564215398;5100.438951715234;5119.846404607868;4907.754612269444;4951.554360107463;4957.380327459067;4957.429895562056;5009.699418034929 17:41:34 INFO - PROCESS | 8388 | |1;ext.html;579.2527639345245;589.5813972079823;592.8488235499947;599.7780821096195;605.7062324772487;39388.606113938855;41192.38211426827;41394.79302603483;45512;45759.313610295874;41662.58337416625;42169.36745948813;42173;42175.57824421755;42224.577754222446;7770.650320735566;7904;7904.565248911307;7907.051153861545;7913.723019694312;7826.530408175499;7907.209279072075;7915.762527124196;7916.366690664762;7916.960415197916;7936.404769642271;7968.920310796876;7975.441719079667;7976.920230797705;7997.320227780646;7921.7227397041115;7950.3242224411;7955.443118981702;7956.960215198945;7959.124496305401;7847.176046515091;7912.80217994549;7913.298640792257;7913.96043019787;7917.049954005556;38664.80667596644;38769;39082.60917390818;39121.413178802344;39241.21517569633;2752.0707448733274;2918.387138700854;3208.3583283343423;3211.42194405007;3278.0821370016197;30097.849510752527;30353.24116897095;30465.695343046507;30795.38409231803;31764.364712705617;3058.4189004089153;3061.4336347775734;3074.415860986428;3089.7991630543943;3143.5441860930264;257188;258272;259488;260841;261166;31766.523502147487;32938;53771;54202.64493387697;54213.45786542084;34401.311973760385;34504.65495345065;34612.134696632784;34632.13419664528;34656.480152797725;13683.657908552366;13864.168149911038;13875.583732488041;13884.861151388357;13885.514007009706;11333.829992550118;11488.023518000897;11497.54009839597;11497.597584084517;11498.655040348804;7974.322182614426;8057.6776928923355;8077.596120193967;8124.593770311579;8145.755627331189;3067.6165479315086;3080.614923134608;3094.98452507736;3114.9065528034193;3166.4142133705336;902.1474706402518;923.4505469245788;943.9480828554358;965.932384733076;970.679675707015;27079.1876243713;28204;28928.27679307992;29112.708872911422;29344.413111737646;829.4608504472142;960.711786464058;961.6489981156827;983.2478154212033;1007.2194049611463;15206.46777362787;15514.37942482288;15573.14347710864;15686.450974216075;15948.362065517482;399513;400872;402450;403259;404142;51096;51616;51628;51753.482465174864;51799;1087.9020888120108;1141.577616281981;1151.9366434846163;1165.539611853313;1198.101423932051;28275.57586636161;30054.398912022076;30157.246068848453;30318.696813031587;30503.542446863758;43538.34692479679;43946.12107757891;43987;43989.78005109954;43991.340129898716;303447;304850;305326;305740;306610;25715.228543143734;25796.226113216635;26765.19704408871;26850.865745671148;27899.721002789713;42252.57747422486;42445.15109697851;42453.363199551415;42597;43735.56264437315;32830.83584582062;33124.1718957028;33271.16822079467;33279.667203327655;33602.66397336093;36475.635243648285;36530.452043218844;36551.45172822463;36738.26523469569;36790.08024799402;35691.46462803112;36377.45433818442;36829.44755828718;36926;37314.62685373111;30834.229144271572;32307;32400;32629.836850815595;33130.33739325152;25022.374440638403;25887.741122588533;26657.33356666099;28031.859840700665;28114.2971425716 17:41:34 INFO - PROCESS | 8388 | |2;jquery.html;342.417889587701;353.129535694513;368.3553780883454;369.69130775802205;374.50004244333815;12331.938340308297;16313.83686163138;16580.66838663226;16711.83288167118;17716;14361.210133442657;14630.780538291934;15055.397784088651;15463.072215667067;15554.84445155548;4744.288356746499;4999.550040496355;5084.288199652052;5220.6606570572985;5281.603879709018;5227.47725227478;5317.308749862532;5319.787208511655;5321.042212401766;5322.387925388572;5100.336956195708;5180.456052114511;5230.947690523103;5317.8936421271555;5325.227841962913;5184.974075129619;5249.86875328116;5262.05283049051;5281.894362112775;5284.10170271051;4483.39474170986;4594.035252596958;4602.148602508513;4720.12677654635;4721.409823772028;20765.5846883063;20807.479813004797;20977.426692998088;21088;21188;2007.5357349335118;2020.05057622917;2060.1450398084776;2106.441792924876;2126.3514628038442;13281.86718132816;13373.331333433387;13555.661108472268;13648.93175534116;14172.858271417257;1688.0631249656435;1698.464983530184;1732.023544384355;1748.7814023247095;1765.9823401766075;70096;70146.0006568536;70604.29395706029;71533;72642;9343.579538920765;9532.142107210384;9568;9771.413715177112;10186.337888037255;12184.756304873852;12216.144869859025;12217.450214740358;12284.1401101922;12373.62879113628;6662.333766623396;6798.082258895085;6848.212455567574;6854.554453960476;6857.828554286083;6619.172603424572;6973.476989225828;6994.755183568551;7173.390261827699;7187.7843664690145;5930.258717660293;6076.605020673642;6083.441265355762;6086.969565152146;6180.721867515973;1668.78305820245;1693.797403843285;1695.9660806783795;1697.3550050980548;1731.965360692779;687.8830598798116;854.8162145138825;879.1955360844884;885.1148851148852;898.85168947123;17383.65232695339;17478.979938661574;18399.908000459913;18514.722279165824;18541.536461588297;855.8373908957278;862.5644049754834;868.2316150207113;884.6151923913119;897.9326550508738;10013.148882344936;10620.468976551296;10718.088962438123;10782.514786834612;10782.838257426145;409609;415086;415602;415859;418159;65517;69172.3082769176;71408.64295678488;72056;73701;934.0239449775002;949.2074118111316;987.2842189412762;988.1551273661061;989.6734077754323;9799.559019844266;15768.211589420713;15997.200139993187;16182.838171618134;16922.661546769243;36326.91019269426;38033;39232.215355692155;41483;43072;54394.7280263612;55409.44590554043;55751.721241393534;55817;56827.71586142043;11666.70833229176;11669;11800.3509806958;12010.75978480408;12510.499580017062;12691.746165076462;12699.682507937376;12950.546730864375;13045.412956416794;13074.542391016268;10444.582216711246;10483.895161048596;10601.522931467947;10924.836127458253;11129.721756956142;10916.12670986335;10948.890511094787;11003.944980275048;11057.396677481882;11156.219064665396;10366.429846358522;10915.78168436611;10944.23390362667;11243.943780281046;11248.775024499628;11342.943285283522;11527.250728702607;12443.066769992105;12466.252024878537;12501.74996500083;11048;11124.221304508606;11182.88817111851;11212.775744485229;11336.659900203007 17:41:34 INFO - PROCESS | 8388 | |3;mootools.html;1205.1443475132653;1266.7656483550538;1315.5790147152911;1621.6837716645243;1642.4087328561716;6739.5282330236905;7228.530145540542;7253.16588592312;7255.383292420144;7266.527675701076;6016.42843929826;6210.161628180194;6658.30087840777;6905.551139175963;7116.537425067367;2038.3477287268042;2101.75829779575;2102.2642075273607;2102.5374417628173;2104.305579158874;2046.9283575074876;2064.545799924022;2069.6067747128;2108.8523803333696;2114.1015068595784;1805.9909700451478;1835.2292037344348;1847.861410394219;1868.6075924055897;2055.352563942361;2050.159434631801;2119.364190742771;2123.98938005309;2124.7237859078377;2127.3617914625706;2055.6535469267656;2079.334612923865;2080.989595052015;2103.6634138537916;2106.8419868509923;7068.434525237969;7105.75129870452;7119.50163488556;7153.856922861513;7164.283571642846;4012.799360031987;4191.392248124035;4196.391523229115;4211.936820947658;4219.198352313051;2702.662167229096;2768.8892444302205;2803.6775770786417;2847.4447482740875;2853.5006373884694;869.5347988826011;891.4116682989261;912.3248795890993;915.2906497464452;918.5407296351824;9178.67874624385;9282.257419406431;9402.200812930909;9407.200387966963;9411.152996230372;3488.302339532104;3751.531058617673;3908.436625349883;3910.393888947218;3913.021744563859;8245.257926786499;8267.421280510427;8278.958605206935;8279.254867061993;8285.62714677841;4123.010477485442;4129.731567448106;4146.647534959562;4203.033302340479;4203.47456567929;3876.8449262029767;3877.8061096945603;3882.650561449483;3883.0680636647003;3884.2425726983533;3342.766006379579;3407.6421975692197;3466.445368740989;3485.9477107843404;3487.982560087234;1102.2064113838023;1117.9273347232404;1124.3366413815725;1126.7014241226082;1137.2891942535914;578.3522454850594;614.2935624032399;641.7433026789322;787.5786454246951;789.3763926498117;4347.934780978288;4923.704577725276;4969.726665033386;4987.0524600325825;4999.950000499948;404.20170163926014;417.5782459715709;420.47440699126093;429.2466720904792;593.66721709761;3390.4405773047665;3452.5511683480986;3462.3940810358085;3478.286951175003;3564.1980554375577;8367.916320836835;8663.263622592025;8717.564121793885;8741.562921853882;8758.47449153053;8619.655213791379;8622.784430389165;8629.568521573896;8632.093630168867;8648.654053837901;6652.534322597468;6715.46276297895;6787.355201255873;6790.117284752951;6798.320167983162;4717.268823332389;4737.431508219036;4779.95220047809;4782.545658162469;5052.924206136984;7873.803154921173;7984.560849153352;8078.596070196584;8099.757007289791;8140.063892652184;8133.552654603817;8188.099309076116;8188.877166842383;8260.504369737835;8283;6196.47329976957;6256;6260.280067792262;6262.937370626236;6263.029230469285;6735.663216839236;6749.223839258548;6753.3246675332075;6772.830679233059;6780.966095169492;6112.358202388863;6173.47525460323;6173.660448675366;6269.623822570478;6277.246730392382;5997.31030931431;6118.479929206067;6167.506599472121;6206.410391012847;6341.587796793194;5873;5894.823155305347;5959.195508606456;5975.970120149372;6006.729697163551;4186.392973018835;4229.894252643586;4233.5131459882505;4242.236397448489;4310.073334233155;4250.086231460251;4258.914821703611;4269.487661480518;4323.740575565476;4377.9781101094295 17:41:34 INFO - PROCESS | 8388 | |4;prototype.html;278.3681044030051;281.5941191291331;285.9847541228638;294.6272964699654;296.42345637734616;4764.142454358219;4811.831585894494;4813.711177329363;4832.371791667083;4852;4760.976195119019;4764.761761911908;4768.1894078006735;4784.688995215309;4792.90414191716;3584.781174400703;3681.631836816324;3829.7319187656876;3831.2720583089194;3831.3103641344546;3630.8547658093776;3758.191988722424;3785.2429514097153;3785.829637666298;3792.889830339123;3724.0689827543115;3724.1992971511118;3726.906827329325;3744.906377340561;3746.2320224353944;3621.8088056725564;3748.6251374862295;3769.208466222097;3781.3382658034734;3786.772793632391;3266.526353678727;3344.916377090568;3350.676482789309;3356.496525521167;3364.7812892161933;4581.335706322598;4628.39830821991;4640.79116439761;4644.373009643688;4650.767631536881;4287.378330142144;4297.914041719179;4298.828046878121;4305.138972205571;4320.438343015419;4905.386826646669;4905.601903457497;4962.391132224854;4989.351384320052;5003.624728145403;3645.362061639229;3647.8723244686576;3650.3064417760543;3652.7443078984484;3655.6527129922615;5233.842984710427;5247.973760131213;5248.268071536384;5264.578833693296;5280.6039547034125;3630.8184590770884;3735.9439608405896;3742.3076730804887;3753.0804952786743;3760.981195094007;3771.377722675728;3773.019164938429;3798.164403831153;3798.2023775007005;3799.905002374963;4260.44614200152;4271.765052922057;4289.206496798102;4298.247806633889;4312.202242585069;4849.636277279218;4971.850844474671;4985.750712464363;4987.678265259709;4987.730582584915;1279.2452453052745;1293.683047653312;1294.5274974634378;1295.740851829638;1296.4749276543016;799.4803377804358;809.1908091908092;830.7424698343533;834.2950207075012;844.6410275632832;3990.4213888985932;3991.4012898064943;3996.780981800579;4227.471566054243;4307.590778876001;5099.725068732817;5106.463821298785;5127.564157046618;5128.461511541234;5166;4410.977945110318;4413.845515406945;4434.911301774011;4441.133978874153;4443.622292105143;2625.267323566475;2687.4490729400427;2698.608701738237;2704.9729502705113;2721.360480287131;4853.635977301717;4853.665242058391;4857.125717370907;4864.148773964542;4872.3909511311085;5254.579633629301;5279.208118782213;5284.260203571503;5295.523402893758;5295.749306544703;4582.587567118975;4785.3300537924715;4891.608671306287;4893.779779909842;4897.412310522617;5161.535461808305;5180.974095129651;5184.948150518447;5185.585153187812;5195.584353251656;5100.821471248489;5110.897782044264;5121.41103773056;5122.820701275437;5126.410462796826;4705.76471176433;4826.95173048265;4910.337104490848;4913.7543122843;4927.408710954708;3579.803110828825;3583.6953858922284;3584.265225628792;3597.406427939465;3609.9819500902327;5223.268742375994;5232.659877107976;5247.137266270572;5253;5260.3692855215;4830.227163653799;5033;5066.569341606005;5096.719680417613;5103.464136265788;4986.177280748636;5017.448080711192;5019.071471777733;5021.824236151717;5025.924611130763;4952.331435256338;4963.528464795839;4982.327385803015;4991.301217829434;4999;4940.827071052496;5010.3737032870895;5032.376688784069;5065.949340506548;5105.0600771708;4722.1972264714395;4781.832635857728;4838.903221935612;4878.756062196947;4940.752962351796 17:41:34 INFO - PROCESS | 8388 | |5;yui.html;672.61996971711;684.0833283400245;690.1476676304766;714.011094633932;732.1763016606317;12072.275663460188;12814.231146131238;12817.871821281784;12842.357882105893;12900.483980640774;13069.477220911152;13156.93421532891;13166.27585482798;13205.537806176786;13206.735865282688;628.045371036025;639.830444932091;774.5314084978592;778.4589710151461;795.2604078207265;781.4295564238109;793.1909452358591;797.3262593108814;797.752696664036;798.0503201190564;842.1031601344579;846.327169899931;848.3976376772499;849.0745087854237;849.3417601358934;655.1450357283743;794.6860989908954;811.7727036429809;828.5277391886627;830.8670612701939;612.9203203583505;613.5490414545305;613.6440864298696;613.7606333529927;613.8311964209834;11908.880911190863;11945.462454189495;11971.64085077449;11976.341301228429;11980.520779168823;11593.826092608617;11920.701982450422;12107.213031152947;12262.693432664166;12973.156744811557;11535.558204211413;11678.357690327028;11705.473253703518;11866.940665296705;11952.58165964187;4151.647109995654;4193.056562273495;4228.9041704745705;4234.13200293939;4341.696081274312;65751.67124164349;65964.3403565963;69031;70597.64701176513;70856.6457167716;10312.175025997902;10469.895301047045;10475.371477711362;10483;10695.732606684895;18585.25658973626;18845.151968161466;18880.716789248174;18904.71642925357;18909.7163542547;6379.075034120026;6379.298277189506;6401.775937842153;6432.678366081771;6627.701753421107;3603.963960360415;3638.0904773806546;3662.322470342995;3669.8532058717888;3680.5399325084363;2704.8512331821544;2754.380264440525;2778.749912507884;2787.4425114977084;2797.888084476639;478.7654049515782;487.7219984608739;492.2124600638949;501.20558914120795;508.23003150227436;437.85331913808596;441.2366605772032;441.99558004420186;464.21779301876444;506.9214271787879;7158.749443769443;7519.507922605294;7523.924760752432;7633.618319084024;7702.8844567331535;485.7935377464634;504.94193167786176;522.9215617657305;523.2256260734059;529.2458246998012;3529.4705794131087;3537.557805274341;3542.1518050873146;3601.38776408006;3633.636636336398;62449;103073.48463257635;106342;112330.43834780774;112835;73024.63487682528;74499;93089;93769.5311523438;95903;45113.09773804506;67900.32099679038;73621.63189184127;73920.63039684767;74522.25477745153;7569.962150189213;8133.227343402367;8171.673133074611;8238.134995825352;8426.325893928348;44557.77721111374;45032;46600.7669961648;46704.69486619399;46984.29523557218;59385.703071484364;62180.37819621746;62647.373526265976;63163.36836631575;63906;11032;11310;11326.207165498336;11416;11572.59495917639;11826.76346473083;11983.700407489883;12337.814932776195;12801.679958001125;13374;9586.281028922998;10162.898371016196;10368.377897326185;10501;10618.681439556825;10394.740131496774;10557.841632375366;10785.62250321235;10808.351498910091;11216.66350009501;10087.193024558164;10274.434906080238;10639.8936010642;10676.786464270515;11004.064654504136;9764.462954537568;9771.951140244253;9799.755006124904;9976.451295178835;10161.612021175166;8182.22268884455;8544.957275213585;9079.848818772096;9374;9643.649889015684 17:41:34 INFO - PROCESS | 8388 | __end_tp_report 17:41:34 INFO - PROCESS | 8388 | __start_cc_report 17:41:34 INFO - PROCESS | 8388 | _x_x_mozilla_cycle_collect,1008 17:41:34 INFO - PROCESS | 8388 | __end_cc_report 17:41:34 INFO - PROCESS | 8388 | __startTimestamp1470271294919__endTimestamp 17:41:34 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | ------- Summary: start ------- 17:41:34 INFO - PROCESS | 8388 | Number of tests: 6 17:41:34 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | [#0] dojo.html Cycles:165 Average:4732.83 Median:4842.32 stddev:513.13 (10.6%) stddev-sans-first:486.67 17:41:34 INFO - PROCESS | 8388 | Values: 2600.2 2619.0 2643.9 2657.5 2662.6 4571.6 4608.3 4767.0 4814.7 4824.6 4661.9 4698.0 4796.3 4847.6 4862.2 4288.0 4332.4 4352.2 4372.1 4424.0 4387.8 4488.3 4495.6 4498.9 4546.1 4243.6 4329.3 4458.2 4468.6 4556.6 4331.0 4403.6 4418.5 4419.6 4478.6 4327.8 4350.7 4357.4 4388.1 4392.0 4557.3 4812.2 4813.6 4824.3 4832.3 5028.2 5066.9 5068.9 5180.6 5184.2 5158.1 5202.0 5205.8 5207.4 5209.2 4829.7 4834.0 4835.3 4837.9 4840.8 4944.1 4979.3 5252.2 5293.6 5317.6 5108.2 5154.7 5161.2 5162.3 5162.6 5203.8 5206.8 5211.4 5245.1 5255.4 4829.0 5005.3 5090.2 5113.9 5143.7 5129.1 5130.4 5134.6 5135.4 5173.2 4306.5 4329.9 4333.7 4380.4 4382.1 3619.5 3667.4 3698.7 3728.9 3789.1 4389.3 4430.8 4436.6 4461.2 4466.9 5127.7 5133.2 5137.9 5145.7 5188.1 4245.4 4359.3 4419.5 4424.6 4472.4 4572.1 4587.7 4590.1 4635.0 4638.3 4782.7 4796.5 4796.7 4798.0 4842.3 4944.8 5054.3 5109.4 5112.0 5154.5 4750.1 4783.6 4807.7 4850.5 4852.4 5001.4 5027.9 5030.7 5033.6 5083.5 4849.9 5042.7 5094.3 5111.2 5159.8 4991.1 5021.8 5053.2 5075.1 5102.7 5017.4 5036.0 5036.4 5040.1 5085.0 4666.0 4897.9 4954.3 4960.6 5018.2 5027.2 5069.4 5076.2 5100.4 5119.8 4907.8 4951.6 4957.4 4957.4 5009.7 17:41:34 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | [#1] ext.html Cycles:180 Average:46974.10 Median:36503.04 stddev:86426.77 (236.8%) stddev-sans-first:86599.02 17:41:34 INFO - PROCESS | 8388 | Values: 579.3 589.6 592.8 599.8 605.7 39388.6 41192.4 41394.8 45512.0 45759.3 41662.6 42169.4 42173.0 42175.6 42224.6 7770.7 7904.0 7904.6 7907.1 7913.7 7826.5 7907.2 7915.8 7916.4 7917.0 7936.4 7968.9 7975.4 7976.9 7997.3 7921.7 7950.3 7955.4 7957.0 7959.1 7847.2 7912.8 7913.3 7914.0 7917.0 38664.8 38769.0 39082.6 39121.4 39241.2 2752.1 2918.4 3208.4 3211.4 3278.1 30097.8 30353.2 30465.7 30795.4 31764.4 3058.4 3061.4 3074.4 3089.8 3143.5 257188.0 258272.0 259488.0 260841.0 261166.0 31766.5 32938.0 53771.0 54202.6 54213.5 34401.3 34504.7 34612.1 34632.1 34656.5 13683.7 13864.2 13875.6 13884.9 13885.5 11333.8 11488.0 11497.5 11497.6 11498.7 7974.3 8057.7 8077.6 8124.6 8145.8 3067.6 3080.6 3095.0 3114.9 3166.4 902.1 923.5 943.9 965.9 970.7 27079.2 28204.0 28928.3 29112.7 29344.4 829.5 960.7 961.6 983.2 1007.2 15206.5 15514.4 15573.1 15686.5 15948.4 399513.0 400872.0 402450.0 403259.0 404142.0 51096.0 51616.0 51628.0 51753.5 51799.0 1087.9 1141.6 1151.9 1165.5 1198.1 28275.6 30054.4 30157.2 30318.7 30503.5 43538.3 43946.1 43987.0 43989.8 43991.3 303447.0 304850.0 305326.0 305740.0 306610.0 25715.2 25796.2 26765.2 26850.9 27899.7 42252.6 42445.2 42453.4 42597.0 43735.6 32830.8 33124.2 33271.2 33279.7 33602.7 36475.6 36530.5 36551.5 36738.3 36790.1 35691.5 36377.5 36829.4 36926.0 37314.6 30834.2 32307.0 32400.0 32629.8 33130.3 25022.4 25887.7 26657.3 28031.9 28114.3 17:41:34 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | [#2] jquery.html Cycles:180 Average:25476.51 Median:347.77 stddev:68229.66 (19619.0%) stddev-sans-first:68394.96 17:41:34 INFO - PROCESS | 8388 | Values: 342.4 353.1 368.4 369.7 374.5 12331.9 16313.8 16580.7 16711.8 17716.0 14361.2 14630.8 15055.4 15463.1 15554.8 4744.3 4999.6 5084.3 5220.7 5281.6 5227.5 5317.3 5319.8 5321.0 5322.4 5100.3 5180.5 5230.9 5317.9 5325.2 5185.0 5249.9 5262.1 5281.9 5284.1 4483.4 4594.0 4602.1 4720.1 4721.4 20765.6 20807.5 20977.4 21088.0 21188.0 2007.5 2020.1 2060.1 2106.4 2126.4 13281.9 13373.3 13555.7 13648.9 14172.9 1688.1 1698.5 1732.0 1748.8 1766.0 70096.0 70146.0 70604.3 71533.0 72642.0 9343.6 9532.1 9568.0 9771.4 10186.3 12184.8 12216.1 12217.5 12284.1 12373.6 6662.3 6798.1 6848.2 6854.6 6857.8 6619.2 6973.5 6994.8 7173.4 7187.8 5930.3 6076.6 6083.4 6087.0 6180.7 1668.8 1693.8 1696.0 1697.4 1732.0 687.9 854.8 879.2 885.1 898.9 17383.7 17479.0 18399.9 18514.7 18541.5 855.8 862.6 868.2 884.6 897.9 10013.1 10620.5 10718.1 10782.5 10782.8 409609.0 415086.0 415602.0 415859.0 418159.0 65517.0 69172.3 71408.6 72056.0 73701.0 934.0 949.2 987.3 988.2 989.7 9799.6 15768.2 15997.2 16182.8 16922.7 36326.9 38033.0 39232.2 41483.0 43072.0 54394.7 55409.4 55751.7 55817.0 56827.7 11666.7 11669.0 11800.4 12010.8 12510.5 12691.7 12699.7 12950.5 13045.4 13074.5 10444.6 10483.9 10601.5 10924.8 11129.7 10916.1 10948.9 11003.9 11057.4 11156.2 10366.4 10915.8 10944.2 11243.9 11248.8 11342.9 11527.3 12443.1 12466.3 12501.7 11048.0 11124.2 11182.9 11212.8 11336.7 17:41:34 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | [#3] mootools.html Cycles:180 Average:4688.03 Median:4978.39 stddev:2578.33 (51.8%) stddev-sans-first:2572.27 17:41:34 INFO - PROCESS | 8388 | Values: 1205.1 1266.8 1315.6 1621.7 1642.4 6739.5 7228.5 7253.2 7255.4 7266.5 6016.4 6210.2 6658.3 6905.6 7116.5 2038.3 2101.8 2102.3 2102.5 2104.3 2046.9 2064.5 2069.6 2108.9 2114.1 1806.0 1835.2 1847.9 1868.6 2055.4 2050.2 2119.4 2124.0 2124.7 2127.4 2055.7 2079.3 2081.0 2103.7 2106.8 7068.4 7105.8 7119.5 7153.9 7164.3 4012.8 4191.4 4196.4 4211.9 4219.2 2702.7 2768.9 2803.7 2847.4 2853.5 869.5 891.4 912.3 915.3 918.5 9178.7 9282.3 9402.2 9407.2 9411.2 3488.3 3751.5 3908.4 3910.4 3913.0 8245.3 8267.4 8279.0 8279.3 8285.6 4123.0 4129.7 4146.6 4203.0 4203.5 3876.8 3877.8 3882.7 3883.1 3884.2 3342.8 3407.6 3466.4 3485.9 3488.0 1102.2 1117.9 1124.3 1126.7 1137.3 578.4 614.3 641.7 787.6 789.4 4347.9 4923.7 4969.7 4987.1 5000.0 404.2 417.6 420.5 429.2 593.7 3390.4 3452.6 3462.4 3478.3 3564.2 8367.9 8663.3 8717.6 8741.6 8758.5 8619.7 8622.8 8629.6 8632.1 8648.7 6652.5 6715.5 6787.4 6790.1 6798.3 4717.3 4737.4 4780.0 4782.5 5052.9 7873.8 7984.6 8078.6 8099.8 8140.1 8133.6 8188.1 8188.9 8260.5 8283.0 6196.5 6256.0 6260.3 6262.9 6263.0 6735.7 6749.2 6753.3 6772.8 6781.0 6112.4 6173.5 6173.7 6269.6 6277.2 5997.3 6118.5 6167.5 6206.4 6341.6 5873.0 5894.8 5959.2 5976.0 6006.7 4186.4 4229.9 4233.5 4242.2 4310.1 4250.1 4258.9 4269.5 4323.7 4378.0 17:41:34 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | [#4] prototype.html Cycles:180 Average:4167.19 Median:4766.48 stddev:1211.83 (25.4%) stddev-sans-first:1179.56 17:41:34 INFO - PROCESS | 8388 | Values: 278.4 281.6 286.0 294.6 296.4 4764.1 4811.8 4813.7 4832.4 4852.0 4761.0 4764.8 4768.2 4784.7 4792.9 3584.8 3681.6 3829.7 3831.3 3831.3 3630.9 3758.2 3785.2 3785.8 3792.9 3724.1 3724.2 3726.9 3744.9 3746.2 3621.8 3748.6 3769.2 3781.3 3786.8 3266.5 3344.9 3350.7 3356.5 3364.8 4581.3 4628.4 4640.8 4644.4 4650.8 4287.4 4297.9 4298.8 4305.1 4320.4 4905.4 4905.6 4962.4 4989.4 5003.6 3645.4 3647.9 3650.3 3652.7 3655.7 5233.8 5248.0 5248.3 5264.6 5280.6 3630.8 3735.9 3742.3 3753.1 3761.0 3771.4 3773.0 3798.2 3798.2 3799.9 4260.4 4271.8 4289.2 4298.2 4312.2 4849.6 4971.9 4985.8 4987.7 4987.7 1279.2 1293.7 1294.5 1295.7 1296.5 799.5 809.2 830.7 834.3 844.6 3990.4 3991.4 3996.8 4227.5 4307.6 5099.7 5106.5 5127.6 5128.5 5166.0 4411.0 4413.8 4434.9 4441.1 4443.6 2625.3 2687.4 2698.6 2705.0 2721.4 4853.6 4853.7 4857.1 4864.1 4872.4 5254.6 5279.2 5284.3 5295.5 5295.7 4582.6 4785.3 4891.6 4893.8 4897.4 5161.5 5181.0 5184.9 5185.6 5195.6 5100.8 5110.9 5121.4 5122.8 5126.4 4705.8 4827.0 4910.3 4913.8 4927.4 3579.8 3583.7 3584.3 3597.4 3610.0 5223.3 5232.7 5247.1 5253.0 5260.4 4830.2 5033.0 5066.6 5096.7 5103.5 4986.2 5017.4 5019.1 5021.8 5025.9 4952.3 4963.5 4982.3 4991.3 4999.0 4940.8 5010.4 5032.4 5065.9 5105.1 4722.2 4781.8 4838.9 4878.8 4940.8 17:41:34 INFO - PROCESS | 8388 | 17:41:34 INFO - PROCESS | 8388 | [#5] yui.html Cycles:180 Average:17682.83 Median:23532.49 stddev:25907.25 (110.1%) stddev-sans-first:25948.44 17:41:34 INFO - PROCESS | 8388 | Values: 672.6 684.1 690.1 714.0 732.2 12072.3 12814.2 12817.9 12842.4 12900.5 13069.5 13156.9 13166.3 13205.5 13206.7 628.0 639.8 774.5 778.5 795.3 781.4 793.2 797.3 797.8 798.1 842.1 846.3 848.4 849.1 849.3 655.1 794.7 811.8 828.5 830.9 612.9 613.5 613.6 613.8 613.8 11908.9 11945.5 11971.6 11976.3 11980.5 11593.8 11920.7 12107.2 12262.7 12973.2 11535.6 11678.4 11705.5 11866.9 11952.6 4151.6 4193.1 4228.9 4234.1 4341.7 65751.7 65964.3 69031.0 70597.6 70856.6 10312.2 10469.9 10475.4 10483.0 10695.7 18585.3 18845.2 18880.7 18904.7 18909.7 6379.1 6379.3 6401.8 6432.7 6627.7 3604.0 3638.1 3662.3 3669.9 3680.5 2704.9 2754.4 2778.7 2787.4 2797.9 478.8 487.7 492.2 501.2 508.2 437.9 441.2 442.0 464.2 506.9 7158.7 7519.5 7523.9 7633.6 7702.9 485.8 504.9 522.9 523.2 529.2 3529.5 3537.6 3542.2 3601.4 3633.6 62449.0 103073.5 106342.0 112330.4 112835.0 73024.6 74499.0 93089.0 93769.5 95903.0 45113.1 67900.3 73621.6 73920.6 74522.3 7570.0 8133.2 8171.7 8238.1 8426.3 44557.8 45032.0 46600.8 46704.7 46984.3 59385.7 62180.4 62647.4 63163.4 63906.0 11032.0 11310.0 11326.2 11416.0 11572.6 11826.8 11983.7 12337.8 12801.7 13374.0 9586.3 10162.9 10368.4 10501.0 10618.7 10394.7 10557.8 10785.6 10808.4 11216.7 10087.2 10274.4 10639.9 10676.8 11004.1 9764.5 9772.0 9799.8 9976.5 10161.6 8182.2 8545.0 9079.8 9374.0 9643.6 17:41:34 INFO - PROCESS | 8388 | -------- Summary: end -------- 17:41:34 INFO - PROCESS | 8388 | 17:41:35 INFO - TEST-INFO | 8388: exit 0 17:41:35 INFO - TEST-OK | dromaeo_css | took 1119983ms 17:41:35 INFO - TEST-START | kraken 17:41:35 INFO - operating with platform_type : linux_ 17:41:35 INFO - Initialising browser for kraken test... 17:41:35 INFO - TEST-INFO | started process 8573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT0gcvh/profile http://localhost:44978/getInfo.html) 17:41:40 INFO - PROCESS | 8573 | __metrics Screen width/height:1600/1200 17:41:40 INFO - PROCESS | 8573 | colorDepth:24 17:41:40 INFO - PROCESS | 8573 | Browser inner width/height: 1024/697 17:41:40 INFO - PROCESS | 8573 | __metrics 17:41:41 INFO - PROCESS | 8573 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:41:41 INFO - PROCESS | 8573 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:41:41 INFO - PROCESS | 8573 | console.error: PushService: 17:41:41 INFO - PROCESS | 8573 | stateChangeProcessEnqueue: Error transitioning state 17:41:41 INFO - PROCESS | 8573 | UnknownError 17:41:42 INFO - TEST-INFO | 8573: exit 0 17:41:42 INFO - Browser initialized. 17:41:42 INFO - Running cycle 1/1 for kraken test... 17:41:42 INFO - TEST-INFO | started process 8651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT0gcvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:54 INFO - PROCESS | 8651 | RSS: Main: 157868032 17:41:54 INFO - PROCESS | 8651 | 17:41:56 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44978/tests/kraken/driver.html?testName=audio-beat-detection) 17:41:57 INFO - PROCESS | 8651 | RSS: Main: 214339584 17:41:57 INFO - PROCESS | 8651 | 17:42:00 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44978/tests/kraken/driver.html?testName=audio-dft) 17:42:01 INFO - PROCESS | 8651 | RSS: Main: 192180224 17:42:01 INFO - PROCESS | 8651 | 17:42:04 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44978/tests/kraken/driver.html?testName=audio-fft) 17:42:04 INFO - PROCESS | 8651 | RSS: Main: 273178624 17:42:04 INFO - PROCESS | 8651 | 17:42:07 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44978/tests/kraken/driver.html?testName=audio-oscillator) 17:42:07 INFO - PROCESS | 8651 | RSS: Main: 180596736 17:42:07 INFO - PROCESS | 8651 | 17:42:09 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:10 INFO - PROCESS | 8651 | RSS: Main: 185708544 17:42:10 INFO - PROCESS | 8651 | 17:42:13 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44978/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:14 INFO - PROCESS | 8651 | RSS: Main: 221986816 17:42:14 INFO - PROCESS | 8651 | 17:42:17 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44978/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:18 INFO - PROCESS | 8651 | RSS: Main: 215355392 17:42:18 INFO - PROCESS | 8651 | 17:42:21 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44978/tests/kraken/driver.html?testName=json-parse-financial) 17:42:21 INFO - PROCESS | 8651 | RSS: Main: 218849280 17:42:21 INFO - PROCESS | 8651 | 17:42:23 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:24 INFO - PROCESS | 8651 | RSS: Main: 184913920 17:42:24 INFO - PROCESS | 8651 | 17:42:26 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44978/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:26 INFO - PROCESS | 8651 | RSS: Main: 190337024 17:42:26 INFO - PROCESS | 8651 | 17:42:28 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:29 INFO - PROCESS | 8651 | RSS: Main: 194957312 17:42:29 INFO - PROCESS | 8651 | 17:42:32 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:32 INFO - PROCESS | 8651 | RSS: Main: 189194240 17:42:32 INFO - PROCESS | 8651 | 17:42:35 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:42:36 INFO - PROCESS | 8651 | RSS: Main: 192491520 17:42:36 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | Cycle 1(1): loaded http://localhost:44978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44978/tests/kraken/driver.html?testName=ai-astar) 17:42:38 INFO - PROCESS | 8651 | RSS: Main: 243392512 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | __start_tp_report 17:42:38 INFO - PROCESS | 8651 | _x_x_mozilla_page_load 17:42:38 INFO - PROCESS | 8651 | _x_x_mozilla_page_load_details 17:42:38 INFO - PROCESS | 8651 | |i|pagename|runs| 17:42:38 INFO - PROCESS | 8651 | |0;ai-astar;106;116;114;114;116;116;114;114;113;114 17:42:38 INFO - PROCESS | 8651 | |1;audio-beat-detection;150;121;123;178;127;127;143;123;167;121 17:42:38 INFO - PROCESS | 8651 | |2;audio-dft;161;161;161;163;162;159;160;160;162;158 17:42:38 INFO - PROCESS | 8651 | |3;audio-fft;75;77;76;117;76;76;77;76;100;76 17:42:38 INFO - PROCESS | 8651 | |4;audio-oscillator;85;85;112;86;85;86;119;84;86;130 17:42:38 INFO - PROCESS | 8651 | |5;imaging-gaussian-blur;117;116;117;118;117;117;117;117;117;116 17:42:38 INFO - PROCESS | 8651 | |6;imaging-darkroom;146;146;146;146;147;146;147;147;146;146 17:42:38 INFO - PROCESS | 8651 | |7;imaging-desaturate;95;94;95;94;95;95;94;95;95;95 17:42:38 INFO - PROCESS | 8651 | |8;json-parse-financial;67;63;62;63;63;65;62;63;62;62 17:42:38 INFO - PROCESS | 8651 | |9;json-stringify-tinderbox;64;64;65;65;65;64;65;65;65;66 17:42:38 INFO - PROCESS | 8651 | |10;stanford-crypto-aes;79;78;79;79;79;79;82;80;83;84 17:42:38 INFO - PROCESS | 8651 | |11;stanford-crypto-ccm;130;136;138;128;128;138;137;126;164;139 17:42:38 INFO - PROCESS | 8651 | |12;stanford-crypto-pbkdf2;166;162;164;161;164;167;168;167;162;167 17:42:38 INFO - PROCESS | 8651 | |13;stanford-crypto-sha256-iterative;68;69;66;66;67;67;67;66;65;66 17:42:38 INFO - PROCESS | 8651 | __end_tp_report 17:42:38 INFO - PROCESS | 8651 | __start_cc_report 17:42:38 INFO - PROCESS | 8651 | _x_x_mozilla_cycle_collect,1986 17:42:38 INFO - PROCESS | 8651 | __end_cc_report 17:42:38 INFO - PROCESS | 8651 | __startTimestamp1470271358329__endTimestamp 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | ------- Summary: start ------- 17:42:38 INFO - PROCESS | 8651 | Number of tests: 14 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:2.91 (2.6%) stddev-sans-first:1.13 17:42:38 INFO - PROCESS | 8651 | Values: 106.0 116.0 114.0 114.0 116.0 116.0 114.0 114.0 113.0 114.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:135.00 stddev:20.76 (15.4%) stddev-sans-first:21.56 17:42:38 INFO - PROCESS | 8651 | Values: 150.0 121.0 123.0 178.0 127.0 127.0 143.0 123.0 167.0 121.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 17:42:38 INFO - PROCESS | 8651 | Values: 161.0 161.0 161.0 163.0 162.0 159.0 160.0 160.0 162.0 158.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:14.24 (18.7%) stddev-sans-first:14.83 17:42:38 INFO - PROCESS | 8651 | Values: 75.0 77.0 76.0 117.0 76.0 76.0 77.0 76.0 100.0 76.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.00 stddev:17.47 (20.6%) stddev-sans-first:18.09 17:42:38 INFO - PROCESS | 8651 | Values: 85.0 85.0 112.0 86.0 85.0 86.0 119.0 84.0 86.0 130.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:42:38 INFO - PROCESS | 8651 | Values: 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:42:38 INFO - PROCESS | 8651 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:42:38 INFO - PROCESS | 8651 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:1.62 (2.6%) stddev-sans-first:0.97 17:42:38 INFO - PROCESS | 8651 | Values: 67.0 63.0 62.0 63.0 63.0 65.0 62.0 63.0 62.0 62.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 17:42:38 INFO - PROCESS | 8651 | Values: 64.0 64.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 66.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:2.04 (2.6%) stddev-sans-first:2.12 17:42:38 INFO - PROCESS | 8651 | Values: 79.0 78.0 79.0 79.0 79.0 79.0 82.0 80.0 83.0 84.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:137.50 stddev:10.88 (7.9%) stddev-sans-first:11.29 17:42:38 INFO - PROCESS | 8651 | Values: 130.0 136.0 138.0 128.0 128.0 138.0 137.0 126.0 164.0 139.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:166.50 stddev:2.53 (1.5%) stddev-sans-first:2.65 17:42:38 INFO - PROCESS | 8651 | Values: 166.0 162.0 164.0 161.0 164.0 167.0 168.0 167.0 162.0 167.0 17:42:38 INFO - PROCESS | 8651 | 17:42:38 INFO - PROCESS | 8651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 17:42:38 INFO - PROCESS | 8651 | Values: 68.0 69.0 66.0 66.0 67.0 67.0 67.0 66.0 65.0 66.0 17:42:38 INFO - PROCESS | 8651 | -------- Summary: end -------- 17:42:38 INFO - PROCESS | 8651 | 17:42:39 INFO - TEST-INFO | 8651: exit 0 17:42:39 INFO - TEST-OK | kraken | took 63718ms 17:42:39 INFO - SUITE-END | took 1183s 17:42:39 INFO - Completed test suite (00:19:43) 17:42:39 INFO - javascript benchmark 17:42:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.2329312852708, 2619.0309585453383, 2643.881025353859, 2657.4685062987396, 2662.6405435266247, 4571.588557029867, 4608.308753686949, 4766.9507335492435, 4814.662973591846, 4824.63815213859, 4661.88345291367, 4697.9765101174535, 4796.328514008042, 4847.612191024718, 4862.2220444728855, 4288.035192081772, 4332.350147477872, 4352.194843953878, 4372.103718737667, 4424.048829501657, 4387.824487020532, 4488.281874900017, 4495.64034877209, 4498.932516012263, 4546.0680560485025, 4243.575642435762, 4329.307310830283, 4458.152950939344, 4468.642508599304, 4556.589906908378, 4331.0, 4403.603675669206, 4418.469783625986, 4419.602235798761, 4478.596926276651, 4327.848525301631, 4350.651947844165, 4357.433533640638, 4388.078503514266, 4392.011797345604, 4557.293619488984, 4812.205986012339, 4813.590844778198, 4824.252240902666, 4832.299316599108, 5028.245763135559, 5066.949330506684, 5068.898622027576, 5180.611454140954, 5184.196449550326, 5158.123119069767, 5202.037623039712, 5205.817796377109, 5207.375114986188, 5209.218617207449, 4829.661923665345, 4834.0, 4835.274708793674, 4837.854864354075, 4840.83057093, 4944.060628480577, 4979.278004689299, 5252.2384254282915, 5293.629445938747, 5317.601179911522, 5108.233764935289, 5154.742262886841, 5161.225816127536, 5162.328897243335, 5162.6386152968935, 5203.765830537635, 5206.817761378409, 5211.400688920747, 5245.10833158364, 5255.39562950258, 4829.034193161311, 5005.3242812220615, 5090.211017292326, 5113.8721531962, 5143.665661731976, 5129.051125541787, 5130.4356520782685, 5134.614903882149, 5135.383753949475, 5173.22401639757, 4306.461692288464, 4329.891752706208, 4333.653307735373, 4380.408644832907, 4382.057857560576, 3619.475176099451, 3667.431548110047, 3698.7041036717537, 3728.9440658390145, 3789.052736815796, 4389.253826849444, 4430.756308403069, 4436.578525040116, 4461.152381047591, 4466.888327791831, 5127.743612819419, 5133.204353325241, 5137.897242055138, 5145.716985565755, 5188.143956247177, 4245.448091748053, 4359.346098085312, 4419.469663640384, 4424.6239069678795, 4472.418585583853, 4572.1312950539295, 4587.655925805511, 4590.104929538707, 4635.0, 4638.257878739386, 4782.665213435026, 4796.5203479651755, 4796.664233503621, 4798.04039192156, 4842.322074909515, 4944.777485013255, 5054.317667114892, 5109.386873575195, 5111.977604479193, 5154.458781827854, 4750.097481478508, 4783.6412269079265, 4807.663463557517, 4850.53919877611, 4852.44196917359, 5001.399832020181, 5027.874303142451, 5030.673006254582, 5033.647644664985, 5083.542481176712, 4849.854504364875, 5042.697438153723, 5094.337736094284, 5111.233315002779, 5159.845204643867, 4991.126552853309, 5021.84934451967, 5053.216751403538, 5075.11185542536, 5102.69383836971, 5017.448080711192, 5035.974820125876, 5036.445990941067, 5040.117979353525, 5084.9745751271, 4665.953340466687, 4897.877553061202, 4954.281629163823, 4960.553550180501, 5018.222175562793, 5027.195648696191, 5069.366329208849, 5076.238564215398, 5100.438951715234, 5119.846404607868, 4907.754612269444, 4951.554360107463, 4957.380327459067, 4957.429895562056, 5009.699418034929], "value": 4699.062969137272, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.2527639345245, 589.5813972079823, 592.8488235499947, 599.7780821096195, 605.7062324772487, 39388.606113938855, 41192.38211426827, 41394.79302603483, 45512.0, 45759.313610295874, 41662.58337416625, 42169.36745948813, 42173.0, 42175.57824421755, 42224.577754222446, 7770.650320735566, 7904.0, 7904.565248911307, 7907.051153861545, 7913.723019694312, 7826.530408175499, 7907.209279072075, 7915.762527124196, 7916.366690664762, 7916.960415197916, 7936.404769642271, 7968.920310796876, 7975.441719079667, 7976.920230797705, 7997.320227780646, 7921.7227397041115, 7950.3242224411, 7955.443118981702, 7956.960215198945, 7959.124496305401, 7847.176046515091, 7912.80217994549, 7913.298640792257, 7913.96043019787, 7917.049954005556, 38664.80667596644, 38769.0, 39082.60917390818, 39121.413178802344, 39241.21517569633, 2752.0707448733274, 2918.387138700854, 3208.3583283343423, 3211.42194405007, 3278.0821370016197, 30097.849510752527, 30353.24116897095, 30465.695343046507, 30795.38409231803, 31764.364712705617, 3058.4189004089153, 3061.4336347775734, 3074.415860986428, 3089.7991630543943, 3143.5441860930264, 257188.0, 258272.0, 259488.0, 260841.0, 261166.0, 31766.523502147487, 32938.0, 53771.0, 54202.64493387697, 54213.45786542084, 34401.311973760385, 34504.65495345065, 34612.134696632784, 34632.13419664528, 34656.480152797725, 13683.657908552366, 13864.168149911038, 13875.583732488041, 13884.861151388357, 13885.514007009706, 11333.829992550118, 11488.023518000897, 11497.54009839597, 11497.597584084517, 11498.655040348804, 7974.322182614426, 8057.6776928923355, 8077.596120193967, 8124.593770311579, 8145.755627331189, 3067.6165479315086, 3080.614923134608, 3094.98452507736, 3114.9065528034193, 3166.4142133705336, 902.1474706402518, 923.4505469245788, 943.9480828554358, 965.932384733076, 970.679675707015, 27079.1876243713, 28204.0, 28928.27679307992, 29112.708872911422, 29344.413111737646, 829.4608504472142, 960.711786464058, 961.6489981156827, 983.2478154212033, 1007.2194049611463, 15206.46777362787, 15514.37942482288, 15573.14347710864, 15686.450974216075, 15948.362065517482, 399513.0, 400872.0, 402450.0, 403259.0, 404142.0, 51096.0, 51616.0, 51628.0, 51753.482465174864, 51799.0, 1087.9020888120108, 1141.577616281981, 1151.9366434846163, 1165.539611853313, 1198.101423932051, 28275.57586636161, 30054.398912022076, 30157.246068848453, 30318.696813031587, 30503.542446863758, 43538.34692479679, 43946.12107757891, 43987.0, 43989.78005109954, 43991.340129898716, 303447.0, 304850.0, 305326.0, 305740.0, 306610.0, 25715.228543143734, 25796.226113216635, 26765.19704408871, 26850.865745671148, 27899.721002789713, 42252.57747422486, 42445.15109697851, 42453.363199551415, 42597.0, 43735.56264437315, 32830.83584582062, 33124.1718957028, 33271.16822079467, 33279.667203327655, 33602.66397336093, 36475.635243648285, 36530.452043218844, 36551.45172822463, 36738.26523469569, 36790.08024799402, 35691.46462803112, 36377.45433818442, 36829.44755828718, 36926.0, 37314.62685373111, 30834.229144271572, 32307.0, 32400.0, 32629.836850815595, 33130.33739325152, 25022.374440638403, 25887.741122588533, 26657.33356666099, 28031.859840700665, 28114.2971425716], "value": 16686.291752211564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.417889587701, 353.129535694513, 368.3553780883454, 369.69130775802205, 374.50004244333815, 12331.938340308297, 16313.83686163138, 16580.66838663226, 16711.83288167118, 17716.0, 14361.210133442657, 14630.780538291934, 15055.397784088651, 15463.072215667067, 15554.84445155548, 4744.288356746499, 4999.550040496355, 5084.288199652052, 5220.6606570572985, 5281.603879709018, 5227.47725227478, 5317.308749862532, 5319.787208511655, 5321.042212401766, 5322.387925388572, 5100.336956195708, 5180.456052114511, 5230.947690523103, 5317.8936421271555, 5325.227841962913, 5184.974075129619, 5249.86875328116, 5262.05283049051, 5281.894362112775, 5284.10170271051, 4483.39474170986, 4594.035252596958, 4602.148602508513, 4720.12677654635, 4721.409823772028, 20765.5846883063, 20807.479813004797, 20977.426692998088, 21088.0, 21188.0, 2007.5357349335118, 2020.05057622917, 2060.1450398084776, 2106.441792924876, 2126.3514628038442, 13281.86718132816, 13373.331333433387, 13555.661108472268, 13648.93175534116, 14172.858271417257, 1688.0631249656435, 1698.464983530184, 1732.023544384355, 1748.7814023247095, 1765.9823401766075, 70096.0, 70146.0006568536, 70604.29395706029, 71533.0, 72642.0, 9343.579538920765, 9532.142107210384, 9568.0, 9771.413715177112, 10186.337888037255, 12184.756304873852, 12216.144869859025, 12217.450214740358, 12284.1401101922, 12373.62879113628, 6662.333766623396, 6798.082258895085, 6848.212455567574, 6854.554453960476, 6857.828554286083, 6619.172603424572, 6973.476989225828, 6994.755183568551, 7173.390261827699, 7187.7843664690145, 5930.258717660293, 6076.605020673642, 6083.441265355762, 6086.969565152146, 6180.721867515973, 1668.78305820245, 1693.797403843285, 1695.9660806783795, 1697.3550050980548, 1731.965360692779, 687.8830598798116, 854.8162145138825, 879.1955360844884, 885.1148851148852, 898.85168947123, 17383.65232695339, 17478.979938661574, 18399.908000459913, 18514.722279165824, 18541.536461588297, 855.8373908957278, 862.5644049754834, 868.2316150207113, 884.6151923913119, 897.9326550508738, 10013.148882344936, 10620.468976551296, 10718.088962438123, 10782.514786834612, 10782.838257426145, 409609.0, 415086.0, 415602.0, 415859.0, 418159.0, 65517.0, 69172.3082769176, 71408.64295678488, 72056.0, 73701.0, 934.0239449775002, 949.2074118111316, 987.2842189412762, 988.1551273661061, 989.6734077754323, 9799.559019844266, 15768.211589420713, 15997.200139993187, 16182.838171618134, 16922.661546769243, 36326.91019269426, 38033.0, 39232.215355692155, 41483.0, 43072.0, 54394.7280263612, 55409.44590554043, 55751.721241393534, 55817.0, 56827.71586142043, 11666.70833229176, 11669.0, 11800.3509806958, 12010.75978480408, 12510.499580017062, 12691.746165076462, 12699.682507937376, 12950.546730864375, 13045.412956416794, 13074.542391016268, 10444.582216711246, 10483.895161048596, 10601.522931467947, 10924.836127458253, 11129.721756956142, 10916.12670986335, 10948.890511094787, 11003.944980275048, 11057.396677481882, 11156.219064665396, 10366.429846358522, 10915.78168436611, 10944.23390362667, 11243.943780281046, 11248.775024499628, 11342.943285283522, 11527.250728702607, 12443.066769992105, 12466.252024878537, 12501.74996500083, 11048.0, 11124.221304508606, 11182.88817111851, 11212.775744485229, 11336.659900203007], "value": 8599.536491995546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1205.1443475132653, 1266.7656483550538, 1315.5790147152911, 1621.6837716645243, 1642.4087328561716, 6739.5282330236905, 7228.530145540542, 7253.16588592312, 7255.383292420144, 7266.527675701076, 6016.42843929826, 6210.161628180194, 6658.30087840777, 6905.551139175963, 7116.537425067367, 2038.3477287268042, 2101.75829779575, 2102.2642075273607, 2102.5374417628173, 2104.305579158874, 2046.9283575074876, 2064.545799924022, 2069.6067747128, 2108.8523803333696, 2114.1015068595784, 1805.9909700451478, 1835.2292037344348, 1847.861410394219, 1868.6075924055897, 2055.352563942361, 2050.159434631801, 2119.364190742771, 2123.98938005309, 2124.7237859078377, 2127.3617914625706, 2055.6535469267656, 2079.334612923865, 2080.989595052015, 2103.6634138537916, 2106.8419868509923, 7068.434525237969, 7105.75129870452, 7119.50163488556, 7153.856922861513, 7164.283571642846, 4012.799360031987, 4191.392248124035, 4196.391523229115, 4211.936820947658, 4219.198352313051, 2702.662167229096, 2768.8892444302205, 2803.6775770786417, 2847.4447482740875, 2853.5006373884694, 869.5347988826011, 891.4116682989261, 912.3248795890993, 915.2906497464452, 918.5407296351824, 9178.67874624385, 9282.257419406431, 9402.200812930909, 9407.200387966963, 9411.152996230372, 3488.302339532104, 3751.531058617673, 3908.436625349883, 3910.393888947218, 3913.021744563859, 8245.257926786499, 8267.421280510427, 8278.958605206935, 8279.254867061993, 8285.62714677841, 4123.010477485442, 4129.731567448106, 4146.647534959562, 4203.033302340479, 4203.47456567929, 3876.8449262029767, 3877.8061096945603, 3882.650561449483, 3883.0680636647003, 3884.2425726983533, 3342.766006379579, 3407.6421975692197, 3466.445368740989, 3485.9477107843404, 3487.982560087234, 1102.2064113838023, 1117.9273347232404, 1124.3366413815725, 1126.7014241226082, 1137.2891942535914, 578.3522454850594, 614.2935624032399, 641.7433026789322, 787.5786454246951, 789.3763926498117, 4347.934780978288, 4923.704577725276, 4969.726665033386, 4987.0524600325825, 4999.950000499948, 404.20170163926014, 417.5782459715709, 420.47440699126093, 429.2466720904792, 593.66721709761, 3390.4405773047665, 3452.5511683480986, 3462.3940810358085, 3478.286951175003, 3564.1980554375577, 8367.916320836835, 8663.263622592025, 8717.564121793885, 8741.562921853882, 8758.47449153053, 8619.655213791379, 8622.784430389165, 8629.568521573896, 8632.093630168867, 8648.654053837901, 6652.534322597468, 6715.46276297895, 6787.355201255873, 6790.117284752951, 6798.320167983162, 4717.268823332389, 4737.431508219036, 4779.95220047809, 4782.545658162469, 5052.924206136984, 7873.803154921173, 7984.560849153352, 8078.596070196584, 8099.757007289791, 8140.063892652184, 8133.552654603817, 8188.099309076116, 8188.877166842383, 8260.504369737835, 8283.0, 6196.47329976957, 6256.0, 6260.280067792262, 6262.937370626236, 6263.029230469285, 6735.663216839236, 6749.223839258548, 6753.3246675332075, 6772.830679233059, 6780.966095169492, 6112.358202388863, 6173.47525460323, 6173.660448675366, 6269.623822570478, 6277.246730392382, 5997.31030931431, 6118.479929206067, 6167.506599472121, 6206.410391012847, 6341.587796793194, 5873.0, 5894.823155305347, 5959.195508606456, 5975.970120149372, 6006.729697163551, 4186.392973018835, 4229.894252643586, 4233.5131459882505, 4242.236397448489, 4310.073334233155, 4250.086231460251, 4258.914821703611, 4269.487661480518, 4323.740575565476, 4377.9781101094295], "value": 3752.932340069463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.3681044030051, 281.5941191291331, 285.9847541228638, 294.6272964699654, 296.42345637734616, 4764.142454358219, 4811.831585894494, 4813.711177329363, 4832.371791667083, 4852.0, 4760.976195119019, 4764.761761911908, 4768.1894078006735, 4784.688995215309, 4792.90414191716, 3584.781174400703, 3681.631836816324, 3829.7319187656876, 3831.2720583089194, 3831.3103641344546, 3630.8547658093776, 3758.191988722424, 3785.2429514097153, 3785.829637666298, 3792.889830339123, 3724.0689827543115, 3724.1992971511118, 3726.906827329325, 3744.906377340561, 3746.2320224353944, 3621.8088056725564, 3748.6251374862295, 3769.208466222097, 3781.3382658034734, 3786.772793632391, 3266.526353678727, 3344.916377090568, 3350.676482789309, 3356.496525521167, 3364.7812892161933, 4581.335706322598, 4628.39830821991, 4640.79116439761, 4644.373009643688, 4650.767631536881, 4287.378330142144, 4297.914041719179, 4298.828046878121, 4305.138972205571, 4320.438343015419, 4905.386826646669, 4905.601903457497, 4962.391132224854, 4989.351384320052, 5003.624728145403, 3645.362061639229, 3647.8723244686576, 3650.3064417760543, 3652.7443078984484, 3655.6527129922615, 5233.842984710427, 5247.973760131213, 5248.268071536384, 5264.578833693296, 5280.6039547034125, 3630.8184590770884, 3735.9439608405896, 3742.3076730804887, 3753.0804952786743, 3760.981195094007, 3771.377722675728, 3773.019164938429, 3798.164403831153, 3798.2023775007005, 3799.905002374963, 4260.44614200152, 4271.765052922057, 4289.206496798102, 4298.247806633889, 4312.202242585069, 4849.636277279218, 4971.850844474671, 4985.750712464363, 4987.678265259709, 4987.730582584915, 1279.2452453052745, 1293.683047653312, 1294.5274974634378, 1295.740851829638, 1296.4749276543016, 799.4803377804358, 809.1908091908092, 830.7424698343533, 834.2950207075012, 844.6410275632832, 3990.4213888985932, 3991.4012898064943, 3996.780981800579, 4227.471566054243, 4307.590778876001, 5099.725068732817, 5106.463821298785, 5127.564157046618, 5128.461511541234, 5166.0, 4410.977945110318, 4413.845515406945, 4434.911301774011, 4441.133978874153, 4443.622292105143, 2625.267323566475, 2687.4490729400427, 2698.608701738237, 2704.9729502705113, 2721.360480287131, 4853.635977301717, 4853.665242058391, 4857.125717370907, 4864.148773964542, 4872.3909511311085, 5254.579633629301, 5279.208118782213, 5284.260203571503, 5295.523402893758, 5295.749306544703, 4582.587567118975, 4785.3300537924715, 4891.608671306287, 4893.779779909842, 4897.412310522617, 5161.535461808305, 5180.974095129651, 5184.948150518447, 5185.585153187812, 5195.584353251656, 5100.821471248489, 5110.897782044264, 5121.41103773056, 5122.820701275437, 5126.410462796826, 4705.76471176433, 4826.95173048265, 4910.337104490848, 4913.7543122843, 4927.408710954708, 3579.803110828825, 3583.6953858922284, 3584.265225628792, 3597.406427939465, 3609.9819500902327, 5223.268742375994, 5232.659877107976, 5247.137266270572, 5253.0, 5260.3692855215, 4830.227163653799, 5033.0, 5066.569341606005, 5096.719680417613, 5103.464136265788, 4986.177280748636, 5017.448080711192, 5019.071471777733, 5021.824236151717, 5025.924611130763, 4952.331435256338, 4963.528464795839, 4982.327385803015, 4991.301217829434, 4999.0, 4940.827071052496, 5010.3737032870895, 5032.376688784069, 5065.949340506548, 5105.0600771708, 4722.1972264714395, 4781.832635857728, 4838.903221935612, 4878.756062196947, 4940.752962351796], "value": 3777.166501699486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.61996971711, 684.0833283400245, 690.1476676304766, 714.011094633932, 732.1763016606317, 12072.275663460188, 12814.231146131238, 12817.871821281784, 12842.357882105893, 12900.483980640774, 13069.477220911152, 13156.93421532891, 13166.27585482798, 13205.537806176786, 13206.735865282688, 628.045371036025, 639.830444932091, 774.5314084978592, 778.4589710151461, 795.2604078207265, 781.4295564238109, 793.1909452358591, 797.3262593108814, 797.752696664036, 798.0503201190564, 842.1031601344579, 846.327169899931, 848.3976376772499, 849.0745087854237, 849.3417601358934, 655.1450357283743, 794.6860989908954, 811.7727036429809, 828.5277391886627, 830.8670612701939, 612.9203203583505, 613.5490414545305, 613.6440864298696, 613.7606333529927, 613.8311964209834, 11908.880911190863, 11945.462454189495, 11971.64085077449, 11976.341301228429, 11980.520779168823, 11593.826092608617, 11920.701982450422, 12107.213031152947, 12262.693432664166, 12973.156744811557, 11535.558204211413, 11678.357690327028, 11705.473253703518, 11866.940665296705, 11952.58165964187, 4151.647109995654, 4193.056562273495, 4228.9041704745705, 4234.13200293939, 4341.696081274312, 65751.67124164349, 65964.3403565963, 69031.0, 70597.64701176513, 70856.6457167716, 10312.175025997902, 10469.895301047045, 10475.371477711362, 10483.0, 10695.732606684895, 18585.25658973626, 18845.151968161466, 18880.716789248174, 18904.71642925357, 18909.7163542547, 6379.075034120026, 6379.298277189506, 6401.775937842153, 6432.678366081771, 6627.701753421107, 3603.963960360415, 3638.0904773806546, 3662.322470342995, 3669.8532058717888, 3680.5399325084363, 2704.8512331821544, 2754.380264440525, 2778.749912507884, 2787.4425114977084, 2797.888084476639, 478.7654049515782, 487.7219984608739, 492.2124600638949, 501.20558914120795, 508.23003150227436, 437.85331913808596, 441.2366605772032, 441.99558004420186, 464.21779301876444, 506.9214271787879, 7158.749443769443, 7519.507922605294, 7523.924760752432, 7633.618319084024, 7702.8844567331535, 485.7935377464634, 504.94193167786176, 522.9215617657305, 523.2256260734059, 529.2458246998012, 3529.4705794131087, 3537.557805274341, 3542.1518050873146, 3601.38776408006, 3633.636636336398, 62449.0, 103073.48463257635, 106342.0, 112330.43834780774, 112835.0, 73024.63487682528, 74499.0, 93089.0, 93769.5311523438, 95903.0, 45113.09773804506, 67900.32099679038, 73621.63189184127, 73920.63039684767, 74522.25477745153, 7569.962150189213, 8133.227343402367, 8171.673133074611, 8238.134995825352, 8426.325893928348, 44557.77721111374, 45032.0, 46600.7669961648, 46704.69486619399, 46984.29523557218, 59385.703071484364, 62180.37819621746, 62647.373526265976, 63163.36836631575, 63906.0, 11032.0, 11310.0, 11326.207165498336, 11416.0, 11572.59495917639, 11826.76346473083, 11983.700407489883, 12337.814932776195, 12801.679958001125, 13374.0, 9586.281028922998, 10162.898371016196, 10368.377897326185, 10501.0, 10618.681439556825, 10394.740131496774, 10557.841632375366, 10785.62250321235, 10808.351498910091, 11216.66350009501, 10087.193024558164, 10274.434906080238, 10639.8936010642, 10676.786464270515, 11004.064654504136, 9764.462954537568, 9771.951140244253, 9799.755006124904, 9976.451295178835, 10161.612021175166, 8182.22268884455, 8544.957275213585, 9079.848818772096, 9374.0, 9643.649889015684], "value": 6400.599338133862, "unit": "score"}], "name": "dromaeo_css", "value": 6277.345097038528, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 114.0, 114.0, 116.0, 116.0, 114.0, 114.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 123.0, 178.0, 127.0, 127.0, 143.0, 123.0, 167.0, 121.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 162.0, 159.0, 160.0, 160.0, 162.0, 158.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 117.0, 76.0, 76.0, 77.0, 76.0, 100.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 112.0, 86.0, 85.0, 86.0, 119.0, 84.0, 86.0, 130.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 62.0, 63.0, 63.0, 65.0, 62.0, 63.0, 62.0, 62.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 82.0, 80.0, 83.0, 84.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 136.0, 138.0, 128.0, 128.0, 138.0, 137.0, 126.0, 164.0, 139.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 164.0, 161.0, 164.0, 167.0, 168.0, 167.0, 162.0, 167.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 65.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1524.8000000000002, "alertThreshold": 2.0}]} 17:42:39 INFO - Return code: 0 17:42:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:42:39 INFO - # TBPL SUCCESS # 17:42:39 INFO - Running post-action listener: _resource_record_post_action 17:42:39 INFO - [mozharness: 2016-08-04 00:42:39.621495Z] Finished run-tests step (success) 17:42:39 INFO - Running post-run listener: _resource_record_post_run 17:42:39 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 200704; Write bytes: 532176896; Read time: 124; Write time: 465184 17:42:39 INFO - TinderboxPrint: CPU usage
13.0% 17:42:39 INFO - TinderboxPrint: I/O read bytes / time
200,704 / 124 17:42:39 INFO - TinderboxPrint: I/O write bytes / time
532,176,896 / 465,184 17:42:39 INFO - TinderboxPrint: CPU idle
8,333.0 (87.0%) 17:42:39 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 17:42:39 INFO - TinderboxPrint: Swap in / out
0 / 0 17:42:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247906304; Read time: 0; Write time: 264752 17:42:39 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 200704; Write bytes: 284270592; Read time: 124; Write time: 200432 17:42:40 INFO - Running post-run listener: _upload_blobber_files 17:42:40 INFO - Blob upload gear active. 17:42:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:42:40 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 17:42:40 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:42:40 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:42:40 INFO - (blobuploader) - INFO - Open directory for files ... 17:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:42:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:41 INFO - (blobuploader) - INFO - Done attempting. 17:42:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:42:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:42:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:44 INFO - (blobuploader) - INFO - Done attempting. 17:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:45 INFO - (blobuploader) - INFO - Done attempting. 17:42:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:42:45 INFO - Return code: 0 17:42:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:42:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:42:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ac84a5019daf7f59055f2827fe6f3f51ba46000d71397246376bdf2f9211e5ab4859749ace9375dc329eed5cffb750352f3ddcde5c05e9609cba1e2b29a331ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0427f533e3fbffaaa120a3be882c70145750724c718a8dda75aaa236eb11b085cd96fc46b2ea34ef05672a50c3c70a6c1961781786e2c9f99ecf2c00f75423e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42cd01c91055c1a1fbc5049a3299d55d869fde40c6f16d6dbb05282b58394df0bea24857c7c4cd7f76e9b696e3e63f598aaaa57dc43d7e7821df78ccdf861d76"} 17:42:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:42:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:42:45 INFO - Contents: 17:42:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ac84a5019daf7f59055f2827fe6f3f51ba46000d71397246376bdf2f9211e5ab4859749ace9375dc329eed5cffb750352f3ddcde5c05e9609cba1e2b29a331ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0427f533e3fbffaaa120a3be882c70145750724c718a8dda75aaa236eb11b085cd96fc46b2ea34ef05672a50c3c70a6c1961781786e2c9f99ecf2c00f75423e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42cd01c91055c1a1fbc5049a3299d55d869fde40c6f16d6dbb05282b58394df0bea24857c7c4cd7f76e9b696e3e63f598aaaa57dc43d7e7821df78ccdf861d76"} 17:42:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:42:45 INFO - Copying logs to upload dir... 17:42:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:42:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.955667 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-03 17:42:45.587623) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 17:42:45.591658) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ac84a5019daf7f59055f2827fe6f3f51ba46000d71397246376bdf2f9211e5ab4859749ace9375dc329eed5cffb750352f3ddcde5c05e9609cba1e2b29a331ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0427f533e3fbffaaa120a3be882c70145750724c718a8dda75aaa236eb11b085cd96fc46b2ea34ef05672a50c3c70a6c1961781786e2c9f99ecf2c00f75423e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42cd01c91055c1a1fbc5049a3299d55d869fde40c6f16d6dbb05282b58394df0bea24857c7c4cd7f76e9b696e3e63f598aaaa57dc43d7e7821df78ccdf861d76"} build_url:https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/QTIfLVgHTV6eqmrdX_Mc9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ac84a5019daf7f59055f2827fe6f3f51ba46000d71397246376bdf2f9211e5ab4859749ace9375dc329eed5cffb750352f3ddcde5c05e9609cba1e2b29a331ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0427f533e3fbffaaa120a3be882c70145750724c718a8dda75aaa236eb11b085cd96fc46b2ea34ef05672a50c3c70a6c1961781786e2c9f99ecf2c00f75423e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42cd01c91055c1a1fbc5049a3299d55d869fde40c6f16d6dbb05282b58394df0bea24857c7c4cd7f76e9b696e3e63f598aaaa57dc43d7e7821df78ccdf861d76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 17:42:45.617578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:42:45.617911) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470270126.667852-1157707590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 17:42:45.701476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 17:42:45.701821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 17:42:45.702128) ========= ========= Total master_lag: 0.18 =========