builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1470290722.41 results: success (0) buildid: 20160803203014 builduid: 630ae9772a694b2eaeb6705697d1e800 revision: 03e541a38d87381782c7fccea38aaa32cdd491df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.408693) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.409149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.409446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.434908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.435180) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 23:05:22-- 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% 111M=0s 2016-08-03 23:05:22 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.559598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.559912) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020368 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.615412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:22.615770) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03e541a38d87381782c7fccea38aaa32cdd491df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 03e541a38d87381782c7fccea38aaa32cdd491df --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=652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 23:05:22,852 truncating revision to first 12 chars 2016-08-03 23:05:22,853 Setting DEBUG logging. 2016-08-03 23:05:22,853 attempt 1/10 2016-08-03 23:05:22,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03e541a38d87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 23:05:23,152 unpacking tar archive at: fx-team-03e541a38d87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:23.273898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:23.274189) ========= script_repo_revision: 03e541a38d87381782c7fccea38aaa32cdd491df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:23.274605) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:23.274881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 23:05:23.285742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-08-03 23:05:23.286052) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:05:23 INFO - MultiFileLogger online at 20160803 23:05:23 in /builds/slave/test 23:05:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:05:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:05:23 INFO - {'append_to_log': False, 23:05:23 INFO - 'base_work_dir': '/builds/slave/test', 23:05:23 INFO - 'blob_upload_branch': 'Fx-Team', 23:05:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:05:23 INFO - 'branch': 'Fx-Team', 23:05:23 INFO - 'buildbot_json_path': 'buildprops.json', 23:05:23 INFO - 'config_files': ('talos/linux_config.py',), 23:05:23 INFO - 'default_actions': ('clobber', 23:05:23 INFO - 'read-buildbot-config', 23:05:23 INFO - 'download-and-extract', 23:05:23 INFO - 'populate-webroot', 23:05:23 INFO - 'create-virtualenv', 23:05:23 INFO - 'install', 23:05:23 INFO - 'run-tests'), 23:05:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:05:23 INFO - 'download_minidump_stackwalk': True, 23:05:23 INFO - 'download_symbols': 'ondemand', 23:05:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:05:23 INFO - 'tooltool.py': '/tools/tooltool.py', 23:05:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:05:23 INFO - '/tools/misc-python/virtualenv.py')}, 23:05:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:05:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:05:23 INFO - 'installer_path': 'installer.exe', 23:05:23 INFO - 'log_level': 'info', 23:05:23 INFO - 'log_name': 'talos', 23:05:23 INFO - 'log_to_console': True, 23:05:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:05:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:05:23 INFO - 'opt_config_files': (), 23:05:23 INFO - 'pip_index': False, 23:05:23 INFO - 'sps_profile': False, 23:05:23 INFO - 'sps_profile_interval': 0, 23:05:23 INFO - 'suite': 'dromaeojs', 23:05:23 INFO - 'system_bits': '32', 23:05:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:05:23 INFO - 'title': 'talos-linux64-ix-046', 23:05:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:05:23 INFO - 'use_talos_json': True, 23:05:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:05:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:05:23 INFO - 'work_dir': 'build'} 23:05:23 INFO - [mozharness: 2016-08-04 06:05:23.609019Z] Running clobber step. 23:05:23 INFO - Running pre-action listener: _resource_record_pre_action 23:05:23 INFO - Running main action method: clobber 23:05:23 INFO - rmtree: /builds/slave/test/build 23:05:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:05:24 INFO - Running post-action listener: _resource_record_post_action 23:05:24 INFO - [mozharness: 2016-08-04 06:05:24.078710Z] Finished clobber step (success) 23:05:24 INFO - [mozharness: 2016-08-04 06:05:24.078810Z] Running read-buildbot-config step. 23:05:24 INFO - Running pre-action listener: _resource_record_pre_action 23:05:24 INFO - Running main action method: read_buildbot_config 23:05:24 INFO - Using buildbot properties: 23:05:24 INFO - { 23:05:24 INFO - "project": "", 23:05:24 INFO - "product": "firefox", 23:05:24 INFO - "script_repo_revision": "production", 23:05:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:05:24 INFO - "repository": "", 23:05:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:05:24 INFO - "buildid": "20160803203014", 23:05:24 INFO - "pgo_build": "True", 23:05:24 INFO - "basedir": "/builds/slave/test", 23:05:24 INFO - "buildnumber": 1415, 23:05:24 INFO - "slavename": "talos-linux64-ix-046", 23:05:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:05:24 INFO - "platform": "ubuntu64_hw", 23:05:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:05:24 INFO - "branch": "fx-team", 23:05:24 INFO - "repo_path": "integration/fx-team", 23:05:24 INFO - "revision": "03e541a38d87381782c7fccea38aaa32cdd491df", 23:05:24 INFO - "stage_platform": "linux64-pgo", 23:05:24 INFO - "builduid": "630ae9772a694b2eaeb6705697d1e800", 23:05:24 INFO - "slavebuilddir": "test" 23:05:24 INFO - } 23:05:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:05:24 INFO - Running post-action listener: _resource_record_post_action 23:05:24 INFO - [mozharness: 2016-08-04 06:05:24.081239Z] Finished read-buildbot-config step (success) 23:05:24 INFO - [mozharness: 2016-08-04 06:05:24.081348Z] Running download-and-extract step. 23:05:24 INFO - Running pre-action listener: _resource_record_pre_action 23:05:24 INFO - Running main action method: download_and_extract 23:05:24 INFO - mkdir: /builds/slave/test/build/tests 23:05:24 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')]} 23:05:24 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:05:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:05:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:05:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:31 INFO - Downloaded 1361 bytes. 23:05:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:05:31 INFO - Using the following test package requirements: 23:05:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:05:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:05:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:31 INFO - u'jsshell-linux-x86_64.zip'], 23:05:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:05:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:05:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:05:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:05:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:05:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:05: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')]} 23:05:31 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:05:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:05:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:05:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:38 INFO - Downloaded 21813316 bytes. 23:05:38 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'] 23:05:38 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 23:05:39 INFO - Return code: 0 23:05:39 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 23:05:39 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')]} 23:05:39 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:05:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:05:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:05:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:41 INFO - Downloaded 21813316 bytes. 23:05:41 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'] 23:05:41 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 23:05:43 INFO - Return code: 0 23:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:43 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:43 INFO - Downloaded 14413723 bytes. 23:05:43 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'] 23:05:43 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 23:05:44 INFO - Return code: 0 23:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:44 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:05:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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 23:05:45 INFO - Downloaded 59348740 bytes. 23:05:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:45 INFO - mkdir: /builds/slave/test/properties 23:05:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:05:45 INFO - Writing to file /builds/slave/test/properties/build_url 23:05:45 INFO - Contents: 23:05:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:46 INFO - Running post-action listener: _resource_record_post_action 23:05:46 INFO - Running post-action listener: set_extra_try_arguments 23:05:46 INFO - [mozharness: 2016-08-04 06:05:46.149625Z] Finished download-and-extract step (success) 23:05:46 INFO - [mozharness: 2016-08-04 06:05:46.149858Z] Running populate-webroot step. 23:05:46 INFO - Running pre-action listener: _resource_record_pre_action 23:05:46 INFO - Running main action method: populate_webroot 23:05:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:46 INFO - '--tppagecycles', 23:05:46 INFO - '7'], 23:05:46 INFO - 'tests': ['tsvgm']}}, 23:05:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:05:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:05:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:05:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:46 INFO - 'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:46 INFO - 'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['damp', 'tps']}, 23:05:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:46 INFO - 'tests': ['damp', 'tps']}, 23:05:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['dromaeo_dom']}, 23:05:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['basic_compositor_video']}, 23:05:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:05:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['a11yr', 23:05:46 INFO - 'ts_paint', 23:05:46 INFO - 'tpaint', 23:05:46 INFO - 'sessionrestore', 23:05:46 INFO - 'sessionrestore_no_auto_restore', 23:05:46 INFO - 'tabpaint']}, 23:05:46 INFO - 'other-e10s': {'tests': ['a11yr', 23:05:46 INFO - 'ts_paint', 23:05:46 INFO - 'tpaint', 23:05:46 INFO - 'sessionrestore', 23:05:46 INFO - 'sessionrestore_no_auto_restore', 23:05:46 INFO - 'tabpaint']}, 23:05:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:05:46 INFO - 'ts_paint', 23:05:46 INFO - 'tpaint', 23:05:46 INFO - 'sessionrestore', 23:05:46 INFO - 'sessionrestore_no_auto_restore', 23:05:46 INFO - 'tabpaint']}, 23:05:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:05:46 INFO - 'ts_paint', 23:05:46 INFO - 'tpaint', 23:05:46 INFO - 'sessionrestore', 23:05:46 INFO - 'sessionrestore_no_auto_restore', 23:05:46 INFO - 'tabpaint']}, 23:05:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['a11yr', 23:05:46 INFO - 'ts_paint', 23:05:46 INFO - 'tpaint', 23:05:46 INFO - 'sessionrestore', 23:05:46 INFO - 'sessionrestore_no_auto_restore', 23:05:46 INFO - 'tabpaint']}, 23:05:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['a11yr', 23:05:46 INFO - 'ts_paint', 23:05:46 INFO - 'tpaint', 23:05:46 INFO - 'sessionrestore', 23:05:46 INFO - 'sessionrestore_no_auto_restore', 23:05:46 INFO - 'tabpaint']}, 23:05:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['tsvgx', 23:05:46 INFO - 'tsvgr_opacity', 23:05:46 INFO - 'tart', 23:05:46 INFO - 'tscrollx', 23:05:46 INFO - 'cart']}, 23:05:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:05:46 INFO - 'tsvgr_opacity', 23:05:46 INFO - 'tart', 23:05:46 INFO - 'tscrollx', 23:05:46 INFO - 'cart']}, 23:05:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:46 INFO - 'talos_options': ['--disable-e10s'], 23:05:46 INFO - 'tests': ['tp5o']}, 23:05:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:46 INFO - 'tests': ['tp5o']}, 23:05:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:46 INFO - 'talos_options': ['--disable-e10s', 23:05:46 INFO - '--xperf_path', 23:05:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:46 INFO - 'tests': ['tp5n']}, 23:05:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:46 INFO - 'talos_options': ['--xperf_path', 23:05:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:46 INFO - 'tests': ['tp5n']}}, 23:05:46 INFO - 'talos.zip': {'path': '', 23:05:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:46 INFO - Running post-action listener: _resource_record_post_action 23:05:46 INFO - [mozharness: 2016-08-04 06:05:46.170379Z] Finished populate-webroot step (success) 23:05:46 INFO - [mozharness: 2016-08-04 06:05:46.170467Z] Running create-virtualenv step. 23:05:46 INFO - Running pre-action listener: _resource_record_pre_action 23:05:46 INFO - Running main action method: create_virtualenv 23:05:46 INFO - Creating virtualenv /builds/slave/test/build/venv 23:05:46 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 23:05:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:05:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:46 INFO - Using real prefix '/usr' 23:05:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:05:46 INFO - Installing distribute.............................................................................................................................................................................................done. 23:05:48 INFO - Installing pip.................done. 23:05:48 INFO - Return code: 0 23:05:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:05:48 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')]} 23:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:48 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')]} 23:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:48 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:05:48 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 23:05:48 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 23:05:48 INFO - Using env: {'DISPLAY': ':0', 23:05:48 INFO - 'HOME': '/home/cltbld', 23:05:48 INFO - 'LANG': 'en_US.UTF-8', 23:05:48 INFO - 'LANGUAGE': 'en_US:en', 23:05:48 INFO - 'LOGNAME': 'cltbld', 23:05:48 INFO - 'MAIL': '/var/mail/cltbld', 23:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:48 INFO - 'MOZ_NO_REMOTE': '1', 23:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:48 INFO - 'NO_EM_RESTART': '1', 23:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:48 INFO - 'PWD': '/builds/slave/test', 23:05:48 INFO - 'SHELL': '/bin/bash', 23:05:48 INFO - 'SHLVL': '1', 23:05:48 INFO - 'TERM': 'linux', 23:05:48 INFO - 'TMOUT': '86400', 23:05:48 INFO - 'USER': 'cltbld', 23:05:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:48 INFO - '_': '/tools/buildbot/bin/python'} 23:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:48 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 23:05:48 INFO - Cleaning up... 23:05:48 INFO - Return code: 0 23:05:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:05:48 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')]} 23:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:48 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')]} 23:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:48 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:05:48 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 23:05:48 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 23:05:48 INFO - Using env: {'DISPLAY': ':0', 23:05:48 INFO - 'HOME': '/home/cltbld', 23:05:48 INFO - 'LANG': 'en_US.UTF-8', 23:05:48 INFO - 'LANGUAGE': 'en_US:en', 23:05:48 INFO - 'LOGNAME': 'cltbld', 23:05:48 INFO - 'MAIL': '/var/mail/cltbld', 23:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:48 INFO - 'MOZ_NO_REMOTE': '1', 23:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:48 INFO - 'NO_EM_RESTART': '1', 23:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:48 INFO - 'PWD': '/builds/slave/test', 23:05:48 INFO - 'SHELL': '/bin/bash', 23:05:48 INFO - 'SHLVL': '1', 23:05:48 INFO - 'TERM': 'linux', 23:05:48 INFO - 'TMOUT': '86400', 23:05:48 INFO - 'USER': 'cltbld', 23:05:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:48 INFO - '_': '/tools/buildbot/bin/python'} 23:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:49 INFO - Downloading/unpacking psutil>=3.1.1 23:05:49 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 23:05:49 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 23:05:49 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 23:05:49 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 23:05:49 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 23:05:49 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 23:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:51 INFO - Installing collected packages: psutil 23:05:51 INFO - Running setup.py install for psutil 23:05:51 INFO - building 'psutil._psutil_linux' extension 23:05:51 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 23:05:51 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 23:05:51 INFO - building 'psutil._psutil_posix' extension 23:05:51 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 23:05:51 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 23:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:51 INFO - Successfully installed psutil 23:05:51 INFO - Cleaning up... 23:05:51 INFO - Return code: 0 23:05:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:05:51 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')]} 23:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:51 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')]} 23:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:51 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:05:51 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 23:05:51 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 23:05:51 INFO - Using env: {'DISPLAY': ':0', 23:05:51 INFO - 'HOME': '/home/cltbld', 23:05:51 INFO - 'LANG': 'en_US.UTF-8', 23:05:51 INFO - 'LANGUAGE': 'en_US:en', 23:05:51 INFO - 'LOGNAME': 'cltbld', 23:05:51 INFO - 'MAIL': '/var/mail/cltbld', 23:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:51 INFO - 'MOZ_NO_REMOTE': '1', 23:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:51 INFO - 'NO_EM_RESTART': '1', 23:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:51 INFO - 'PWD': '/builds/slave/test', 23:05:51 INFO - 'SHELL': '/bin/bash', 23:05:51 INFO - 'SHLVL': '1', 23:05:51 INFO - 'TERM': 'linux', 23:05:51 INFO - 'TMOUT': '86400', 23:05:51 INFO - 'USER': 'cltbld', 23:05:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:51 INFO - '_': '/tools/buildbot/bin/python'} 23:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:05:51 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 23:05:51 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 23:05:51 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 23:05:51 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 23:05:51 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 23:05:51 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 23:05:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:05:53 INFO - Installing collected packages: mozsystemmonitor 23:05:53 INFO - Running setup.py install for mozsystemmonitor 23:05:53 INFO - Successfully installed mozsystemmonitor 23:05:53 INFO - Cleaning up... 23:05:54 INFO - Return code: 0 23:05:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:05:54 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')]} 23:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:54 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')]} 23:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:54 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:05:54 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 23:05:54 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 23:05:54 INFO - Using env: {'DISPLAY': ':0', 23:05:54 INFO - 'HOME': '/home/cltbld', 23:05:54 INFO - 'LANG': 'en_US.UTF-8', 23:05:54 INFO - 'LANGUAGE': 'en_US:en', 23:05:54 INFO - 'LOGNAME': 'cltbld', 23:05:54 INFO - 'MAIL': '/var/mail/cltbld', 23:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:54 INFO - 'MOZ_NO_REMOTE': '1', 23:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:54 INFO - 'NO_EM_RESTART': '1', 23:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:54 INFO - 'PWD': '/builds/slave/test', 23:05:54 INFO - 'SHELL': '/bin/bash', 23:05:54 INFO - 'SHLVL': '1', 23:05:54 INFO - 'TERM': 'linux', 23:05:54 INFO - 'TMOUT': '86400', 23:05:54 INFO - 'USER': 'cltbld', 23:05:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:54 INFO - '_': '/tools/buildbot/bin/python'} 23:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:54 INFO - Downloading/unpacking jsonschema==2.5.1 23:05:54 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 23:05:54 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 23:05:54 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 23:05:54 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 23:05:54 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 23:05:54 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 23:05:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:05:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:05:56 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 23:05:56 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 23:05:56 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 23:05:56 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 23:05:56 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 23:05:56 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 23:05:56 INFO - Downloading functools32-3.2.3-2.tar.gz 23:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:05:56 INFO - warning: no files found matching '*.txt' 23:05:56 INFO - no previously-included directories found matching 'build' 23:05:56 INFO - no previously-included directories found matching 'dist' 23:05:56 INFO - no previously-included directories found matching '.git*' 23:05:56 INFO - Installing collected packages: jsonschema, functools32 23:05:56 INFO - Running setup.py install for functools32 23:05:56 INFO - warning: no files found matching '*.txt' 23:05:56 INFO - no previously-included directories found matching 'build' 23:05:56 INFO - no previously-included directories found matching 'dist' 23:05:56 INFO - no previously-included directories found matching '.git*' 23:05:56 INFO - Successfully installed jsonschema functools32 23:05:56 INFO - Cleaning up... 23:05:56 INFO - Return code: 0 23:05:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:05:56 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')]} 23:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:56 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')]} 23:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:56 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:05:56 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 23:05:56 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 23:05:56 INFO - Using env: {'DISPLAY': ':0', 23:05:56 INFO - 'HOME': '/home/cltbld', 23:05:56 INFO - 'LANG': 'en_US.UTF-8', 23:05:56 INFO - 'LANGUAGE': 'en_US:en', 23:05:56 INFO - 'LOGNAME': 'cltbld', 23:05:56 INFO - 'MAIL': '/var/mail/cltbld', 23:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:56 INFO - 'MOZ_NO_REMOTE': '1', 23:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:56 INFO - 'NO_EM_RESTART': '1', 23:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:56 INFO - 'PWD': '/builds/slave/test', 23:05:56 INFO - 'SHELL': '/bin/bash', 23:05:56 INFO - 'SHLVL': '1', 23:05:56 INFO - 'TERM': 'linux', 23:05:56 INFO - 'TMOUT': '86400', 23:05:56 INFO - 'USER': 'cltbld', 23:05:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:56 INFO - '_': '/tools/buildbot/bin/python'} 23:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:05:56 INFO - Cleaning up... 23:05:56 INFO - Return code: 0 23:05:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:05:56 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')]} 23:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:56 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')]} 23:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:56 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:05:56 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 23:05:56 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 23:05:56 INFO - Using env: {'DISPLAY': ':0', 23:05:56 INFO - 'HOME': '/home/cltbld', 23:05:56 INFO - 'LANG': 'en_US.UTF-8', 23:05:56 INFO - 'LANGUAGE': 'en_US:en', 23:05:56 INFO - 'LOGNAME': 'cltbld', 23:05:56 INFO - 'MAIL': '/var/mail/cltbld', 23:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:56 INFO - 'MOZ_NO_REMOTE': '1', 23:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:56 INFO - 'NO_EM_RESTART': '1', 23:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:56 INFO - 'PWD': '/builds/slave/test', 23:05:56 INFO - 'SHELL': '/bin/bash', 23:05:56 INFO - 'SHLVL': '1', 23:05:56 INFO - 'TERM': 'linux', 23:05:56 INFO - 'TMOUT': '86400', 23:05:56 INFO - 'USER': 'cltbld', 23:05:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:56 INFO - '_': '/tools/buildbot/bin/python'} 23:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:56 INFO - Downloading/unpacking blobuploader==1.2.4 23:05:56 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 23:05:56 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 23:05:56 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 23:05:56 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 23:05:56 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 23:05:56 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 23:05:58 INFO - Downloading blobuploader-1.2.4.tar.gz 23:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:05:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:05:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:05:59 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 23:05:59 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 23:05:59 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 23:05:59 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 23:05:59 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 23:05:59 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 23:05:59 INFO - Downloading docopt-0.6.1.tar.gz 23:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:05:59 INFO - Installing collected packages: blobuploader, requests, docopt 23:05:59 INFO - Running setup.py install for blobuploader 23:05:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:05:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:05:59 INFO - Running setup.py install for requests 23:06:00 INFO - Running setup.py install for docopt 23:06:00 INFO - Successfully installed blobuploader requests docopt 23:06:00 INFO - Cleaning up... 23:06:00 INFO - Return code: 0 23:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:00 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:06:00 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 23:06:00 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 23:06:00 INFO - Using env: {'DISPLAY': ':0', 23:06:00 INFO - 'HOME': '/home/cltbld', 23:06:00 INFO - 'LANG': 'en_US.UTF-8', 23:06:00 INFO - 'LANGUAGE': 'en_US:en', 23:06:00 INFO - 'LOGNAME': 'cltbld', 23:06:00 INFO - 'MAIL': '/var/mail/cltbld', 23:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:00 INFO - 'MOZ_NO_REMOTE': '1', 23:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:00 INFO - 'NO_EM_RESTART': '1', 23:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:00 INFO - 'PWD': '/builds/slave/test', 23:06:00 INFO - 'SHELL': '/bin/bash', 23:06:00 INFO - 'SHLVL': '1', 23:06:00 INFO - 'TERM': 'linux', 23:06:00 INFO - 'TMOUT': '86400', 23:06:00 INFO - 'USER': 'cltbld', 23:06:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:00 INFO - '_': '/tools/buildbot/bin/python'} 23:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:00 INFO - Running setup.py (path:/tmp/pip-S1pnHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:00 INFO - Running setup.py (path:/tmp/pip-zg7pEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:00 INFO - Running setup.py (path:/tmp/pip-tGJjBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:00 INFO - Running setup.py (path:/tmp/pip-Z1Zya7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:00 INFO - Running setup.py (path:/tmp/pip-mid5u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:00 INFO - Running setup.py (path:/tmp/pip-ZSB0Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:00 INFO - Running setup.py (path:/tmp/pip-JB8oIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:00 INFO - Running setup.py (path:/tmp/pip-htjjO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:01 INFO - Running setup.py (path:/tmp/pip-ijbEq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:01 INFO - Running setup.py (path:/tmp/pip-Pr4wWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:01 INFO - Running setup.py (path:/tmp/pip-EncGC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:01 INFO - Running setup.py (path:/tmp/pip-mgP1SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:01 INFO - Running setup.py (path:/tmp/pip-tuTiRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:01 INFO - Running setup.py (path:/tmp/pip-Xut19h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:01 INFO - Running setup.py (path:/tmp/pip-aKbSYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:01 INFO - Running setup.py (path:/tmp/pip-hj4Va1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:01 INFO - Running setup.py (path:/tmp/pip-03iLO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:01 INFO - Running setup.py install for manifestparser 23:06:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:01 INFO - Running setup.py install for mozcrash 23:06:01 INFO - Running setup.py install for mozdebug 23:06:01 INFO - Running setup.py install for mozdevice 23:06:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Running setup.py install for mozfile 23:06:02 INFO - Running setup.py install for mozhttpd 23:06:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Running setup.py install for mozinfo 23:06:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Running setup.py install for mozInstall 23:06:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Running setup.py install for mozleak 23:06:02 INFO - Running setup.py install for mozlog 23:06:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Running setup.py install for moznetwork 23:06:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:02 INFO - Running setup.py install for mozprocess 23:06:02 INFO - Running setup.py install for mozprofile 23:06:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:03 INFO - Running setup.py install for mozrunner 23:06:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:03 INFO - Running setup.py install for mozscreenshot 23:06:03 INFO - Running setup.py install for moztest 23:06:03 INFO - Running setup.py install for mozversion 23:06:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:03 INFO - Cleaning up... 23:06:03 INFO - Return code: 0 23:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:03 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:06:03 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 23:06:03 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 23:06:03 INFO - Using env: {'DISPLAY': ':0', 23:06:03 INFO - 'HOME': '/home/cltbld', 23:06:03 INFO - 'LANG': 'en_US.UTF-8', 23:06:03 INFO - 'LANGUAGE': 'en_US:en', 23:06:03 INFO - 'LOGNAME': 'cltbld', 23:06:03 INFO - 'MAIL': '/var/mail/cltbld', 23:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:03 INFO - 'MOZ_NO_REMOTE': '1', 23:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:03 INFO - 'NO_EM_RESTART': '1', 23:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:03 INFO - 'PWD': '/builds/slave/test', 23:06:03 INFO - 'SHELL': '/bin/bash', 23:06:03 INFO - 'SHLVL': '1', 23:06:03 INFO - 'TERM': 'linux', 23:06:03 INFO - 'TMOUT': '86400', 23:06:03 INFO - 'USER': 'cltbld', 23:06:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:03 INFO - '_': '/tools/buildbot/bin/python'} 23:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:03 INFO - Running setup.py (path:/tmp/pip-GYkRf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:03 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)) 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:03 INFO - Running setup.py (path:/tmp/pip-DPNpBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:03 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)) 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:03 INFO - Running setup.py (path:/tmp/pip-b7GW7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:03 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)) 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:03 INFO - Running setup.py (path:/tmp/pip-i7cwBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:03 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)) 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:03 INFO - Running setup.py (path:/tmp/pip-M39QQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:04 INFO - Running setup.py (path:/tmp/pip-FraclD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:04 INFO - Running setup.py (path:/tmp/pip-v1LyN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:04 INFO - Running setup.py (path:/tmp/pip-35_cTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:04 INFO - Running setup.py (path:/tmp/pip-lKEFIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:04 INFO - Running setup.py (path:/tmp/pip-i2iVt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:04 INFO - Running setup.py (path:/tmp/pip-RmCsLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:04 INFO - Running setup.py (path:/tmp/pip-QOWNKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:04 INFO - Running setup.py (path:/tmp/pip-G76A5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:04 INFO - Running setup.py (path:/tmp/pip-JuKUt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:04 INFO - Running setup.py (path:/tmp/pip-jz85B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:04 INFO - Running setup.py (path:/tmp/pip-1FYNnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:04 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)) 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:04 INFO - Running setup.py (path:/tmp/pip-n8YDGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:04 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)) 23:06:04 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)) 23:06:04 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)) 23:06:04 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)) 23:06:04 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)) 23:06:04 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)) 23:06:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:04 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 23:06:04 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 23:06:04 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 23:06:04 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 23:06:04 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 23:06:04 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 23:06:06 INFO - Downloading blessings-1.6.tar.gz 23:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:06 INFO - Installing collected packages: blessings 23:06:06 INFO - Running setup.py install for blessings 23:06:06 INFO - Successfully installed blessings 23:06:06 INFO - Cleaning up... 23:06:07 INFO - Return code: 0 23:06:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:07 INFO - Reading from file tmpfile_stdout 23:06:07 INFO - Current package versions: 23:06:07 INFO - argparse == 1.2.1 23:06:07 INFO - blessings == 1.6 23:06:07 INFO - blobuploader == 1.2.4 23:06:07 INFO - docopt == 0.6.1 23:06:07 INFO - functools32 == 3.2.3-2 23:06:07 INFO - jsonschema == 2.5.1 23:06:07 INFO - manifestparser == 1.1 23:06:07 INFO - mozInstall == 1.12 23:06:07 INFO - mozcrash == 0.17 23:06:07 INFO - mozdebug == 0.1 23:06:07 INFO - mozdevice == 0.48 23:06:07 INFO - mozfile == 1.2 23:06:07 INFO - mozhttpd == 0.7 23:06:07 INFO - mozinfo == 0.9 23:06:07 INFO - mozleak == 0.1 23:06:07 INFO - mozlog == 3.3 23:06:07 INFO - moznetwork == 0.27 23:06:07 INFO - mozprocess == 0.23 23:06:07 INFO - mozprofile == 0.28 23:06:07 INFO - mozrunner == 6.12 23:06:07 INFO - mozscreenshot == 0.1 23:06:07 INFO - mozsystemmonitor == 0.3 23:06:07 INFO - moztest == 0.7 23:06:07 INFO - mozversion == 1.4 23:06:07 INFO - psutil == 3.1.1 23:06:07 INFO - requests == 1.2.3 23:06:07 INFO - wsgiref == 0.1.2 23:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:07 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')]} 23:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:07 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')]} 23:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:07 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:06:07 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 23:06:07 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 23:06:07 INFO - Using env: {'DISPLAY': ':0', 23:06:07 INFO - 'HOME': '/home/cltbld', 23:06:07 INFO - 'LANG': 'en_US.UTF-8', 23:06:07 INFO - 'LANGUAGE': 'en_US:en', 23:06:07 INFO - 'LOGNAME': 'cltbld', 23:06:07 INFO - 'MAIL': '/var/mail/cltbld', 23:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:07 INFO - 'MOZ_NO_REMOTE': '1', 23:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:07 INFO - 'NO_EM_RESTART': '1', 23:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:07 INFO - 'PWD': '/builds/slave/test', 23:06:07 INFO - 'SHELL': '/bin/bash', 23:06:07 INFO - 'SHLVL': '1', 23:06:07 INFO - 'TERM': 'linux', 23:06:07 INFO - 'TMOUT': '86400', 23:06:07 INFO - 'USER': 'cltbld', 23:06:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:07 INFO - '_': '/tools/buildbot/bin/python'} 23:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 INFO - Cleaning up... 23:06:07 INFO - Return code: 0 23:06:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:07 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')]} 23:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:07 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')]} 23:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:07 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 0x2365030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', '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 23:06:07 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 23:06:07 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 23:06:07 INFO - Using env: {'DISPLAY': ':0', 23:06:07 INFO - 'HOME': '/home/cltbld', 23:06:07 INFO - 'LANG': 'en_US.UTF-8', 23:06:07 INFO - 'LANGUAGE': 'en_US:en', 23:06:07 INFO - 'LOGNAME': 'cltbld', 23:06:07 INFO - 'MAIL': '/var/mail/cltbld', 23:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:07 INFO - 'MOZ_NO_REMOTE': '1', 23:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:07 INFO - 'NO_EM_RESTART': '1', 23:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:07 INFO - 'PWD': '/builds/slave/test', 23:06:07 INFO - 'SHELL': '/bin/bash', 23:06:07 INFO - 'SHLVL': '1', 23:06:07 INFO - 'TERM': 'linux', 23:06:07 INFO - 'TMOUT': '86400', 23:06:07 INFO - 'USER': 'cltbld', 23:06:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:07 INFO - '_': '/tools/buildbot/bin/python'} 23:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:06:07 INFO - Cleaning up... 23:06:07 INFO - Return code: 0 23:06:07 INFO - Running post-action listener: _resource_record_post_action 23:06:07 INFO - Running post-action listener: _start_resource_monitoring 23:06:07 INFO - Starting resource monitoring. 23:06:07 INFO - [mozharness: 2016-08-04 06:06:07.738797Z] Finished create-virtualenv step (success) 23:06:07 INFO - [mozharness: 2016-08-04 06:06:07.739238Z] Running install step. 23:06:07 INFO - Running pre-action listener: _resource_record_pre_action 23:06:07 INFO - Running main action method: install 23:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:07 INFO - Reading from file tmpfile_stdout 23:06:07 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:08 INFO - Reading from file tmpfile_stdout 23:06:08 INFO - Output received: 23:06:08 INFO - Usage: mozinstall [options] installer 23:06:08 INFO - Options: 23:06:08 INFO - -h, --help show this help message and exit 23:06:08 INFO - -d DEST, --destination=DEST 23:06:08 INFO - Directory to install application into. [default: 23:06:08 INFO - "/builds/slave/test"] 23:06:08 INFO - --app=APP Application being installed. [default: firefox] 23:06:08 INFO - mkdir: /builds/slave/test/build/application 23:06:08 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'] 23:06:08 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 23:06:24 INFO - Reading from file tmpfile_stdout 23:06:24 INFO - Output received: 23:06:24 INFO - /builds/slave/test/build/application/firefox/firefox 23:06:24 INFO - Running post-action listener: _resource_record_post_action 23:06:24 INFO - [mozharness: 2016-08-04 06:06:24.907616Z] Finished install step (success) 23:06:24 INFO - [mozharness: 2016-08-04 06:06:24.907949Z] Running run-tests step. 23:06:24 INFO - Running pre-action listener: _resource_record_pre_action 23:06:24 INFO - Running main action method: run_tests 23:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:06:24 INFO - Python 2.7.3 23:06:24 INFO - Return code: 0 23:06:24 INFO - grabbing minidump binary from tooltool 23:06:24 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')]} 23:06:24 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 0x26243b0>, '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 0x26252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2625740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:06:24 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 23:06:24 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 23:06:24 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 23:06:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:24 INFO - Return code: 0 23:06:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:06:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:06:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:06:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:06:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 23:06:24 INFO - Using env: {'DISPLAY': ':0', 23:06:24 INFO - 'HOME': '/home/cltbld', 23:06:24 INFO - 'LANG': 'en_US.UTF-8', 23:06:24 INFO - 'LANGUAGE': 'en_US:en', 23:06:24 INFO - 'LOGNAME': 'cltbld', 23:06:24 INFO - 'MAIL': '/var/mail/cltbld', 23:06:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:06:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:24 INFO - 'MOZ_NO_REMOTE': '1', 23:06:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:24 INFO - 'NO_EM_RESTART': '1', 23:06:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:24 INFO - 'PWD': '/builds/slave/test', 23:06:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:06:24 INFO - 'SHELL': '/bin/bash', 23:06:24 INFO - 'SHLVL': '1', 23:06:24 INFO - 'TERM': 'linux', 23:06:24 INFO - 'TMOUT': '86400', 23:06:24 INFO - 'USER': 'cltbld', 23:06:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126', 23:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:24 INFO - '_': '/tools/buildbot/bin/python'} 23:06:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:06:25 INFO - mozversion application_buildid: 20160803203014 23:06:25 INFO - mozversion application_changeset: 03e541a38d87381782c7fccea38aaa32cdd491df 23:06:25 INFO - mozversion application_display_name: Nightly 23:06:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:25 INFO - mozversion application_name: Firefox 23:06:25 INFO - mozversion application_remotingname: firefox 23:06:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:06:25 INFO - mozversion application_vendor: Mozilla 23:06:25 INFO - mozversion application_version: 51.0a1 23:06:25 INFO - mozversion platform_buildid: 20160803203014 23:06:25 INFO - mozversion platform_changeset: 03e541a38d87381782c7fccea38aaa32cdd491df 23:06:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:06:25 INFO - mozversion platform_version: 51.0a1 23:06:25 INFO - using testdate: 1470290785 23:06:25 INFO - actual date: 1470290785 23:06:25 INFO - starting webserver on 'localhost:43143' 23:06:25 INFO - SUITE-START | Running 2 tests 23:06:25 INFO - TEST-START | dromaeo_css 23:06:25 INFO - operating with platform_type : linux_ 23:06:25 INFO - Initialising browser for dromaeo_css test... 23:06:25 INFO - TEST-INFO | started process 26763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXV0mN/profile http://localhost:43143/getInfo.html) 23:06:29 INFO - PROCESS | 26763 | __metrics Screen width/height:1600/1200 23:06:29 INFO - PROCESS | 26763 | colorDepth:24 23:06:29 INFO - PROCESS | 26763 | Browser inner width/height: 1024/697 23:06:29 INFO - PROCESS | 26763 | __metrics 23:06:29 INFO - PROCESS | 26763 | 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" 23:06:29 INFO - PROCESS | 26763 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:06:30 INFO - TEST-INFO | 26763: exit 0 23:06:30 INFO - Browser initialized. 23:06:30 INFO - Running cycle 1/1 for dromaeo_css test... 23:06:30 INFO - TEST-INFO | started process 26843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXV0mN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:42 INFO - PROCESS | 26843 | RSS: Main: 156815360 23:06:42 INFO - PROCESS | 26843 | 23:07:33 INFO - PROCESS | 26843 | 1470290853716 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] 23:09:43 INFO - PROCESS | 26843 | Cycle 1(1): loaded http://localhost:43143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43143/tests/dromaeo/cssquery-ext.html) 23:09:44 INFO - PROCESS | 26843 | RSS: Main: 287031296 23:09:44 INFO - PROCESS | 26843 | 23:12:51 INFO - PROCESS | 26843 | Cycle 1(1): loaded http://localhost:43143/tests/dromaeo/cssquery-ext.html (next: http://localhost:43143/tests/dromaeo/cssquery-jquery.html) 23:12:51 INFO - PROCESS | 26843 | RSS: Main: 244756480 23:12:51 INFO - PROCESS | 26843 | 23:15:58 INFO - PROCESS | 26843 | Cycle 1(1): loaded http://localhost:43143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43143/tests/dromaeo/cssquery-mootools.html) 23:16:03 INFO - PROCESS | 26843 | RSS: Main: 183033856 23:16:03 INFO - PROCESS | 26843 | 23:19:14 INFO - PROCESS | 26843 | Cycle 1(1): loaded http://localhost:43143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43143/tests/dromaeo/cssquery-prototype.html) 23:19:14 INFO - PROCESS | 26843 | RSS: Main: 202084352 23:19:14 INFO - PROCESS | 26843 | 23:22:25 INFO - PROCESS | 26843 | Cycle 1(1): loaded http://localhost:43143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43143/tests/dromaeo/cssquery-yui.html) 23:22:25 INFO - PROCESS | 26843 | RSS: Main: 185479168 23:22:25 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | Cycle 1(1): loaded http://localhost:43143/tests/dromaeo/cssquery-yui.html (next: http://localhost:43143/tests/dromaeo/cssquery-dojo.html) 23:25:37 INFO - PROCESS | 26843 | RSS: Main: 270733312 23:25:37 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | __start_tp_report 23:25:37 INFO - PROCESS | 26843 | _x_x_mozilla_page_load 23:25:37 INFO - PROCESS | 26843 | _x_x_mozilla_page_load_details 23:25:37 INFO - PROCESS | 26843 | |i|pagename|runs| 23:25:37 INFO - PROCESS | 26843 | |0;dojo.html;3029.182120827377;3036.1802313375388;3054.954175687365;3080.9075727728177;3098.45776989027;5125.282460455539;5176.120059589869;5219.660722053064;5265.18389649604;5277.736113194339;5200.739963001844;5214.374275086985;5236.816711415101;5261;5319.707416092114;4763.54746299101;4789.688670236441;4821.445533763609;4822.807087716487;4872.829450969217;4838.467768545457;4870.512948705119;4877.292792545079;4900.950990490103;4923.704577725348;4630.097131059445;4649.628029757611;4665.813367465297;4778.4265888093305;4789.233722604384;4721.3862197914395;4728.4798672146035;4736.100140973204;4736.194846876039;4737.194676904935;4688.484266730657;4688.5545873142;4700.177468942956;4710.505396933307;4714.811407543694;5148.150555158394;5154.433012368637;5165.354330708661;5199.740012999335;5208.609354298443;5562.694051827148;5597.524210442118;5604.607677462579;5607.271054762896;5609.635373700697;5440.755166017539;5556.249906262643;5590.91613625796;5629.324481062299;5643.746031428595;5243.659162154486;5262.473752624707;5287.127623942045;5292.02097611943;5292.364916210079;5752.654840709487;5759.712014399347;5764.74058667361;5766.106253530709;5769.480746732815;5277.577793776489;5379.811706590329;5382.165764306539;5384.9461505385225;5540.722963851872;5496.477834605706;5532.170174473861;5538.363088244822;5545.417731138253;5550.028744969614;5464.0711079116645;5466.781328746885;5472.808451704172;5475.123980163155;5476.698781567052;5387.191921211849;5434.70109143993;5462.426445223195;5466.972665136649;5468.781248750085;4308;4309.762963037063;4312.396264522969;4348.608625223745;4351.26028575143;3830;3851.1912498375095;3853.7109716771356;3877.933568268749;3883.689304855605;5184.170532714747;5233.528982391527;5236.423993360727;5310.8141215057285;5348.304720386325;5636.323641163005;5657.830265092054;5661.745221465044;5663.263775709132;5692.089265717465;5360.3299587551555;5365.436629153961;5370.70461124634;5378.085725426687;5378.51593356592;4734.479207287196;4804.42346918372;4825.179719447702;4841.806327746851;4851.34506841579;5864.472197502075;5925.318588362394;5925.762969481172;5926.140709597084;5966.194563733927;5583.050881350261;5583.860403489783;5591.4688104629995;5653.236813030188;5655.604107712421;5709.68596727184;5801.390853960443;5834.416558344302;5839.5036421904615;5913.379095195115;5487.368952570506;5529.640573362719;5530.281063461724;5537.446255374431;5584.525315348241;5602.3837377887585;5608.96234196675;5610.382857885547;5615.466530679579;5616.410276920865;5286.788528458818;5383.1117865553315;5424.783008679608;5429.131338985743;5539.446055394428;5467.7266136692215;5469.097598896137;5481.534069603968;5485.588580856532;5517.531009864046;5378.838634840961;5404.7567859445635;5407.513323800877;5409.350877894678;5468.753906074316;5287.8149264777085;5418.810341638024;5451.48210919962;5453.26380938584;5544.667319960815;5378.946210538001;5385;5386.13821788512;5386.407495175606;5417.295751552273 23:25:37 INFO - PROCESS | 26843 | |1;ext.html;577.8266520043986;605.1407002057081;606.2179788073386;616.35898665388;628.4563852267788;32276.83861580692;32878.67121328786;41780.16439671205;42856;43441.34837977433;41089;45025.0994980101;45051.09897802042;45051.54948450514;45057.54942450574;8837.60230789616;8962.820743585124;8979.146981036823;8982.59578318974;8983.820323593523;8834.337424693174;8921.509316987564;8926;8930.732078037669;8931.598078086501;8917.063708310632;8976.281897448222;8982.775430614254;8987;8991.100889911022;8880.822383552326;8884.955575222082;8893.333000024959;8924.33067519932;8934.374593778439;8787.824243515093;8836.690715824916;8838.602262898185;8846.955765221133;8854.335924805666;42354.1529169418;42751.144977100594;42797.78601107006;42849;42856.357154642705;3470.880451334287;3610.29599228148;3649.7445178837493;3711.2948539777626;3754.436834474823;28451.857740711162;29294.121176364744;32476.837615811768;33052.33895322104;33144.83427582871;4008.8797336079965;4345.283028300327;4404.273294906337;4454.0646464242545;4496.460424749051;331805;333027;336792.99999999756;336876;338441;55714.44285557174;56003.439965600635;56007.43992560022;56042.719786400805;56078;58595.414045859;58643;58667.11999320013;58706.477611342605;58714.41285587175;16930.830691693172;17177;17183.226754796066;17192.140392980302;17193;13294.933525332312;13303.733925321632;13379.732405351839;13380.866191337962;13385;14739.115653060851;15692.372305107669;15709.293081811345;15745.527634170992;15779.05325680463;6302.306746257908;6387.828138432955;6418.432626949164;6547.9017814732815;6556.114924485133;990.7374545745383;1073.1575713065363;1090.487470888681;1099.999000909169;1103.9236744174527;31966.840165799487;32271.35457290841;32335.35329293401;32645.673543264264;32851.19318437461;1087.9945600272106;1127.2729089737074;1148.8276758486127;1150.263831148066;1163.6160067177811;16361.263743131587;16978.745318820227;17043.914780426017;17150.228239728993;17298.65402691939;544740;544832;547816;547833;547916;57875.421245787846;57999;58149;58466.707666462244;58580.70709646425;1262.1669697999275;1359.4562175129631;1369.2195448594405;1383.8685324894118;1396.2809153286269;31540.842295788374;33626.66373336333;33731.32537349288;33910.491342629386;34627.13432164216;49401.50598494113;50156.23515765996;50162.74918625384;50169.49830501648;50199.24701129413;454381;456795;457141;457616;457868;35731.642683572834;41159.7942010288;41536.37695434631;42404.787976059924;42525;48302;48705.26942095801;48755.26867096926;49231.753841230566;50255;40078.79960600295;40331.19337613173;40821;41104.38343424911;42261.57738422576;40306.1938761229;40891.18217635571;41448.792756036026;42109.157816844105;42400.78799605982;40512.59487405088;40677.796611016754;41140.794296028325;41243.1751364977;42104;34063;36550.634493654725;36959.44560831643;37438;37859;27335.316617084733;27956.44087118287;28162.718372816827;28196.43607127887;28232 23:25:37 INFO - PROCESS | 26843 | |2;jquery.html;382.2755877611927;384.2890652293257;389.60649743758796;394.0287192071543;415.6051750836706;18643.62712745746;20483.69274460884;20560.69158962613;20635.17459301626;20677.172913083497;19291.4212573623;19391.321303754372;19753.802461975374;19916.302929397472;20055.398338049847;4944.159492886218;5084.516970887769;5276.577873770108;5909.379515150912;5961.642301461926;5824.155497452867;5901.852453688649;5907.497862681677;5910.34986151523;5910.379410161936;5576.832695019156;5852.502537284336;5863.882722345551;5872.530197584183;5873.0603103503445;5650.491455769001;5811.244538210027;5841.47426731592;5853.853653658672;5857.3849745776715;5600.60795744294;5630.4369563043365;5637.210790489335;5639.4642508962;5641.266635337421;13219.405126769318;13268.601941941757;13390.263535505543;13428.127171733806;13542.796858047137;2286.8056215221727;2529.7723204911645;2684.9731502684917;2730.645016147908;2800.8739606717745;9321.44071355721;9476.620935162655;9485.952570237174;9791.069848364394;9815.460149691764;1887.8489720822301;1906.9618607627908;1918.386116442739;1966.429735376739;1983.3950645053253;79082.6045869767;79216.20783792147;80319.59840200761;81248.59375703143;82610;10874.565017399374;10928.289661172157;11206.439678016066;11222.270552414067;11287.887121128848;13728.45086196541;13749.725005499835;15418.922905385401;15562.299696513684;15622.29699663518;7936.2857342839425;8414.915850841413;8484.618192181366;8534.27458666008;8572.142785721378;8128.024637043474;8187;8221.260086592236;8299.087100418948;8439.198276163756;4538.750368729686;4780.737059461693;4791.233402655628;4836.685615434985;4908.141075311806;1770.9380171693929;1948.951276218106;1951.580410211783;1979.0104947526238;2015.9899200504196;961.4423634292094;1004.4124187350482;1027.1628622672497;1030.696393560407;1047.8690163729534;18885.81114188868;19820.60358792845;19972.600547988957;19996.60006799856;20318.593628127353;983.1250187333279;993.4238141877838;1018.2770233134557;1046.9790604187874;1049.459528342904;10319.690409287734;10754.838677419688;11075.72310692239;11095.611653592085;11369.374684392273;286827;370617;501313;503104;530294;94064;96522.51738741402;96998.51500742452;97318.5134074325;98240;990.5988074829705;995.571904081252;1013.4426065663708;1020.1023099672537;1029.8609687692065;17252.396166134124;17561.385351512636;17993.370232041816;18685.71971420457;18691.06544672788;46091.769541152076;46397;46654.30018549656;46733.29900051434;46948.7652561735;60850;62145.689271553354;62296.06555901756;62561;63267.050994236044;7225.205227424874;7947.086085100056;7966.601669916597;8316.41785075039;8463.195996380335;11046.33721976684;13033.47866085346;13033.608991730263;13187.406566704329;13723.931380343034;11176.441177940907;11330.94334528322;11600.245984011011;11896.881031189923;12034;11203.887961120285;11327.886721132683;11451.312921224753;11665.59170429031;11795.823062653895;11988.46051927648;12066.517339306329;12080.21478603888;12402.75194496087;12423.37883105823;7489.28851759082;7593.5823529706395;7696.692132314644;7770.184130666199;7789.104253010976;11425.31448113116;11552.364619945984;11681.474333654836;11682.357470339213;11807.055435565306 23:25:37 INFO - PROCESS | 26843 | |3;mootools.html;1481.6666250093726;1511.3576729889799;1639.1886016421865;1771.5039788859124;1792.659394715005;8673.69642062528;9208.171264586186;9330.973592904784;9333.766655833608;9342.626294948202;7960.601969901496;8531.829363412728;8781.209691127797;8833.867491987625;9133.908660913388;1654.3051918194387;2057.4547744847628;2057.722207501983;2057.86623869448;2291.6447950567604;2238.6865838782583;2296.1504243429954;2296.850704704189;2338.8362814602983;2339.356676913845;2047.3960181746347;2109.947251318714;2111.102781317941;2132.115172203534;2225.332400279926;2272.9090836366527;2330.790228879409;2335.8948847301913;2338.8128949683983;2340.6254999200046;2300.2179259052004;2301.873396963166;2306.169778879602;2350.659154422599;2351.036075209156;9039.81920361589;9056.864147037733;9086.409383390059;9114.817703645956;9115.316351273681;4956.033573453178;5095.0574143783515;5113.411957624883;5136.075506408845;5140.023395554833;3035.666076731558;3121.297708015701;3188.1392024153347;3191.69678880506;3199.3281410903737;1065.6217042949718;1095.8794532601407;1100.5322737836389;1115.4088333183427;1129.706276368142;12425.689357766038;12434.37828108609;12443.502259909503;12449.93775031119;12463.688407789878;4104.220198162399;4329.913401732011;4399.406080179199;4474.440694913136;4488.12481566098;10319.896801031893;10324.741881453023;10325.9483702581;10331.896681033244;10339.276250662531;5146.279520867081;5147.202183661539;5151.871203219949;5154.53609175176;5164.948350516522;4703.200455922433;4733.573978341966;4736.052789442126;4739.218029025173;4740.810367585258;3976.8011599419915;3989.2646698686162;3996.780177090288;4088.182363527247;4114.0948991221885;1209.23451760429;1209.866914639389;1211.4790640024698;1223.3699644682995;1225.546547777328;848.6859861851032;918.2149262380702;973.9464329461806;1008.1078245752561;1056.060106505211;6077.544184186204;6267.811965641038;6394.1687580614225;6424.775132870327;6593.109930159463;983.1741337276721;1012.9848052279222;1013.2856336282903;1030.6601418156367;1036.0778906772978;4229.302165142779;4360.389545463638;4378.321360189176;4442.511323754385;4517.232070548015;11367.317960922372;11775.352355620524;11792;11808.94095529517;11847.170698051053;11724.88275117255;11735.178537502294;11739.47172377245;11741.589044383576;11742.823857642143;8099.635516401776;8482.830343392974;8491.617877195418;8650.653973840976;8663;5320.787168513216;5420.864478388072;5921.526277897672;6134.6625935573975;6150.907736384047;10167.288289819642;10345.844812327972;10351.482425878525;10358.792824143324;10479.476026198812;10130.493475326351;10276.588936442458;10533.42066186367;10574.947125264325;10709.410982395731;8109.878351824609;8320.542370169698;8326.45878017927;8333.291670207858;8334;7360.227176146427;7763.4953728007495;8514.574271286534;8929.06244844282;9015.504147271962;7853.803654908673;7879.763607091796;7884.960575197088;7906;7943.24539168778;7715.074191097105;7747.883781743391;7764.456488045783;7786.377089832687;8030.718924837603;7229.457790665616;7247.383972362408;7276.345128938209;7281.8179545509665;7348.3386495213545;5323.30796996388;5356.651817631841;5380.623356365017;5478.67127972307;5610.719464026701;5484.396716361117;5627.831165065055;5651.971740141273;5740.282464691913;5787.652740835563 23:25:37 INFO - PROCESS | 26843 | |4;prototype.html;305.9510478323469;314.67274035003595;318.1473650616348;323.27747484372424;328.06501470808183;5014.749262536877;5130.8460746177625;5142.974285128569;5206.277511579225;5215.322008138942;5127.205283181103;5140.254663073862;5142.768575414106;5154.27840102385;5166.535011848933;4037.2732908076537;4042.555318914917;4047.8583249586272;4049.777262250575;4058.3620646579666;3838.6161383861668;3947.6447119759214;4037.091654377756;4078.775667338295;4082.8775136745944;3935.5474120476083;3952.189801090784;3967.6230758077936;3972.2651309507687;3990.1620659661507;2927.3706153177063;3495.423255162895;3518.677672735982;3531.805750683724;3867.7292589518743;3475.8435870385892;3488.883557261677;3493.825308734553;3496.5629296337956;3508.15804206991;4897;4965.478624744422;5041.848744537633;5065.088284108859;5131.640785145041;4480.775961201959;4504.166729155117;4516.36770852081;4534.863954081383;4543;5322.946770532284;5337.172738225581;5340.7716225268405;5345.705986170798;5347.331583552056;3674.2835147146316;3799.772013679188;3857.1707082977296;3881.611838816124;3885.7668539887695;5543.52880005204;5565.387807341189;5571.192177134293;5627.5238894886115;5628.409017053233;3941.3102707026155;3972.741771784825;3997.2804895118575;3999.6200360965663;4006.358982562776;3946.743461674982;4006.759594424344;4020.276350256982;4036.2129384769687;4046.393041043808;4526.479454862733;4547.15877562652;4551.38556294896;4555.658325625592;4575.81696732127;5130.512601302945;5244.423113457517;5350.3312085989255;5366.141417373202;5460.34475862899;1342.0806747378078;1367.8236716423867;1368.4321006782075;1369.8082268482422;1372.389286767399;853.8206976534873;874.4010352908278;880.3969281042379;886.8536691445968;888.2139306713605;4648.511906249795;4664.763837583043;4677.783776218208;4677.929831052537;4685.086408150378;4828.7102773833685;4846.273059041101;4875.6109506342345;4903.26451032348;4922.286268491049;4442.777861106932;4670.1512077632615;4741.620670346364;4741.767140543484;4750.809967601257;2472.3558833375964;2474.7502511231714;2499.6375525549056;2502.649629051934;2520.5715028445206;5085.296425697359;5115.544538621408;5118.059094497216;5154.716490593053;5216.21756736485;4869.565217391304;4935.703857768545;4943.41810620598;4963.205887058053;5198.324217851655;5859.619124756877;5874.735636896436;5884.911726324194;5885.205497257815;5891.381404952418;5582.469665381782;5611.943880561143;5612.242347283064;5612.522935550524;5621.803236886853;5404.567634589145;5499.807506737245;5512.173174023928;5525.834224973257;5540.972295138498;5795.768169273182;5853.765849365977;5861.9413805861395;5864.824055278348;5871.588988770745;3889.533256009297;3908.3746600543777;3919.8040097994417;3921.941170882382;3926.705497087673;5090.796368145381;5437.891242175056;5569.749361278833;5582.86042848932;5589.161625756169;5424.972875135599;5469.07025805606;5481.382992017444;5481.534069603968;5487.945120548743;5244.344456942882;5392.218128371443;5443.918341224964;5447;5464.972675136758;5336.599755018467;5357.276767636319;5360.383555890967;5363.839084827461;5384.6769193848495;5469.206964990134;5484.725763711719;5507.13628912971;5525.613207075467;5566.888662226652;5240.528352448298;5283.550898173698;5327.627066105335;5355.250264962986;5362.034833729966 23:25:37 INFO - PROCESS | 26843 | |5;yui.html;717.3543810570487;729.8905164225362;738.1769327200174;775.1086250811566;878.3500209844715;16274.593135171612;17306.56733581658;17315.13424328785;17345.04602246876;17353.739693904587;15129.167895765728;15266.465673701423;15266.923665381686;15272.923635381836;15281.388744450236;798.3932211519258;814.9348052155814;816.3713940265992;818.1205204405259;820.1183727492969;664.3157547725826;803.4897839871694;817.8078151634361;823.5923218007094;823.6046697585163;776.3556248313914;877.9561021948876;883.2713011765287;886.1315910407804;886.7960369115108;769.6267310354474;770.9074911010687;771.7993321736361;866.6576702202594;874.6982291109557;506.5668853130594;619.2383368456778;631.3938618925837;632.2318383164477;633.4045996763028;15290.159041252728;15327.233638318152;15372.692546149014;15407.229638518142;15410.306536205786;13978.370973306226;14517.419303227858;14840.10959342432;14992.625184370369;15010.47463338778;13209.933950330187;13298.335083245798;13377.799333010013;13555.322233888266;13731.931340343333;4474.082813023322;4510.25580779171;4525.864224073283;4652.325412815157;4671.065786842645;76633;78614.606926965;78720.60639696765;78913;79051;10845.728856778644;11591.362475063785;11708.648740537797;11717.296962182296;12098.576549820715;19995.200191992157;21018.894905525376;21035.474113147295;21040.15839366408;21041.158353665684;8198.508089514648;8312.584370781437;8318.292945099734;8426.705065322683;8589.484630922165;4250.681198910032;4354.738715677069;4416.1609294233995;4478.820847166142;4563.155816174019;3467.133216695826;3552.857885684595;3593.389123848952;3600.117971097098;3604.1890574621025;596.3887015808743;607.7083000159948;613.0528333724407;614.7264467312093;621.3010363341241;675.2234929830636;707.1726080485741;730.6018220070075;732.1543617122232;733.3912852332551;9376.437413755197;9887.406755594688;9955.701328960144;9992.950035249924;10133.695989120191;548.9972550137304;568.5650477384804;625.2403329954128;655.5837043477426;737.189091998797;4471.61991230749;4760.547747963938;4771.785269662804;4779.689320194177;4968.105740966588;62189;62230;64123.35876641174;67014;117647.41176294064;60280.39719602748;101337;103103;106324;106625.46687266514;88102;89189;89627.55186224288;91895;93691.06308936959;9301.581428835854;9360.53197340144;9426.151646351587;9454.101860323259;9539.236861051239;52313.47686523086;52937.735311323195;53008.20487692765;53240.46759532355;53947;49827.501724982285;60520.69739651449;63735;66983.33016669966;69421;12668.556600518938;12960.870391295966;12962.675933101747;13024.413901374272;13876.514321998682;14173.574792756233;15092.54722358331;15106.471273505374;15174.924125379302;15421.922890385476;7625.389968802593;12342.75314493687;13977.650558736113;14207.431702731776;14436.278186090443;14004.929975350058;14346.139231646135;14480.275986200859;14489.637759056108;14599.343029563483;12251.448684809027;12330.81503777462;13692.726145477234;13936.790948135584;13945.023848330926;11333.943330283295;11569.537218511501;11734.706632333919;11867.287962722265;12276.324802135969;11068.557257709923;11607.825882611598;11968.820467692818;11992.64022079339;12076.154669173073 23:25:37 INFO - PROCESS | 26843 | __end_tp_report 23:25:37 INFO - PROCESS | 26843 | __start_cc_report 23:25:37 INFO - PROCESS | 26843 | _x_x_mozilla_cycle_collect,1105 23:25:37 INFO - PROCESS | 26843 | __end_cc_report 23:25:37 INFO - PROCESS | 26843 | __startTimestamp1470291937297__endTimestamp 23:25:37 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | ------- Summary: start ------- 23:25:37 INFO - PROCESS | 26843 | Number of tests: 6 23:25:37 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | [#0] dojo.html Cycles:165 Average:5196.89 Median:5383.11 stddev:581.20 (10.8%) stddev-sans-first:557.55 23:25:37 INFO - PROCESS | 26843 | Values: 3029.2 3036.2 3055.0 3080.9 3098.5 5125.3 5176.1 5219.7 5265.2 5277.7 5200.7 5214.4 5236.8 5261.0 5319.7 4763.5 4789.7 4821.4 4822.8 4872.8 4838.5 4870.5 4877.3 4901.0 4923.7 4630.1 4649.6 4665.8 4778.4 4789.2 4721.4 4728.5 4736.1 4736.2 4737.2 4688.5 4688.6 4700.2 4710.5 4714.8 5148.2 5154.4 5165.4 5199.7 5208.6 5562.7 5597.5 5604.6 5607.3 5609.6 5440.8 5556.2 5590.9 5629.3 5643.7 5243.7 5262.5 5287.1 5292.0 5292.4 5752.7 5759.7 5764.7 5766.1 5769.5 5277.6 5379.8 5382.2 5384.9 5540.7 5496.5 5532.2 5538.4 5545.4 5550.0 5464.1 5466.8 5472.8 5475.1 5476.7 5387.2 5434.7 5462.4 5467.0 5468.8 4308.0 4309.8 4312.4 4348.6 4351.3 3830.0 3851.2 3853.7 3877.9 3883.7 5184.2 5233.5 5236.4 5310.8 5348.3 5636.3 5657.8 5661.7 5663.3 5692.1 5360.3 5365.4 5370.7 5378.1 5378.5 4734.5 4804.4 4825.2 4841.8 4851.3 5864.5 5925.3 5925.8 5926.1 5966.2 5583.1 5583.9 5591.5 5653.2 5655.6 5709.7 5801.4 5834.4 5839.5 5913.4 5487.4 5529.6 5530.3 5537.4 5584.5 5602.4 5609.0 5610.4 5615.5 5616.4 5286.8 5383.1 5424.8 5429.1 5539.4 5467.7 5469.1 5481.5 5485.6 5517.5 5378.8 5404.8 5407.5 5409.4 5468.8 5287.8 5418.8 5451.5 5453.3 5544.7 5378.9 5385.0 5386.1 5386.4 5417.3 23:25:37 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | [#1] ext.html Cycles:180 Average:60787.51 Median:42307.87 stddev:120587.32 (285.0%) stddev-sans-first:120840.86 23:25:37 INFO - PROCESS | 26843 | Values: 577.8 605.1 606.2 616.4 628.5 32276.8 32878.7 41780.2 42856.0 43441.3 41089.0 45025.1 45051.1 45051.5 45057.5 8837.6 8962.8 8979.1 8982.6 8983.8 8834.3 8921.5 8926.0 8930.7 8931.6 8917.1 8976.3 8982.8 8987.0 8991.1 8880.8 8885.0 8893.3 8924.3 8934.4 8787.8 8836.7 8838.6 8847.0 8854.3 42354.2 42751.1 42797.8 42849.0 42856.4 3470.9 3610.3 3649.7 3711.3 3754.4 28451.9 29294.1 32476.8 33052.3 33144.8 4008.9 4345.3 4404.3 4454.1 4496.5 331805.0 333027.0 336793.0 336876.0 338441.0 55714.4 56003.4 56007.4 56042.7 56078.0 58595.4 58643.0 58667.1 58706.5 58714.4 16930.8 17177.0 17183.2 17192.1 17193.0 13294.9 13303.7 13379.7 13380.9 13385.0 14739.1 15692.4 15709.3 15745.5 15779.1 6302.3 6387.8 6418.4 6547.9 6556.1 990.7 1073.2 1090.5 1100.0 1103.9 31966.8 32271.4 32335.4 32645.7 32851.2 1088.0 1127.3 1148.8 1150.3 1163.6 16361.3 16978.7 17043.9 17150.2 17298.7 544740.0 544832.0 547816.0 547833.0 547916.0 57875.4 57999.0 58149.0 58466.7 58580.7 1262.2 1359.5 1369.2 1383.9 1396.3 31540.8 33626.7 33731.3 33910.5 34627.1 49401.5 50156.2 50162.7 50169.5 50199.2 454381.0 456795.0 457141.0 457616.0 457868.0 35731.6 41159.8 41536.4 42404.8 42525.0 48302.0 48705.3 48755.3 49231.8 50255.0 40078.8 40331.2 40821.0 41104.4 42261.6 40306.2 40891.2 41448.8 42109.2 42400.8 40512.6 40677.8 41140.8 41243.2 42104.0 34063.0 36550.6 36959.4 37438.0 37859.0 27335.3 27956.4 28162.7 28196.4 28232.0 23:25:37 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | [#2] jquery.html Cycles:180 Average:27697.69 Median:328722.00 stddev:74504.90 (22.7%) stddev-sans-first:74685.68 23:25:37 INFO - PROCESS | 26843 | Values: 382.3 384.3 389.6 394.0 415.6 18643.6 20483.7 20560.7 20635.2 20677.2 19291.4 19391.3 19753.8 19916.3 20055.4 4944.2 5084.5 5276.6 5909.4 5961.6 5824.2 5901.9 5907.5 5910.3 5910.4 5576.8 5852.5 5863.9 5872.5 5873.1 5650.5 5811.2 5841.5 5853.9 5857.4 5600.6 5630.4 5637.2 5639.5 5641.3 13219.4 13268.6 13390.3 13428.1 13542.8 2286.8 2529.8 2685.0 2730.6 2800.9 9321.4 9476.6 9486.0 9791.1 9815.5 1887.8 1907.0 1918.4 1966.4 1983.4 79082.6 79216.2 80319.6 81248.6 82610.0 10874.6 10928.3 11206.4 11222.3 11287.9 13728.5 13749.7 15418.9 15562.3 15622.3 7936.3 8414.9 8484.6 8534.3 8572.1 8128.0 8187.0 8221.3 8299.1 8439.2 4538.8 4780.7 4791.2 4836.7 4908.1 1770.9 1949.0 1951.6 1979.0 2016.0 961.4 1004.4 1027.2 1030.7 1047.9 18885.8 19820.6 19972.6 19996.6 20318.6 983.1 993.4 1018.3 1047.0 1049.5 10319.7 10754.8 11075.7 11095.6 11369.4 286827.0 370617.0 501313.0 503104.0 530294.0 94064.0 96522.5 96998.5 97318.5 98240.0 990.6 995.6 1013.4 1020.1 1029.9 17252.4 17561.4 17993.4 18685.7 18691.1 46091.8 46397.0 46654.3 46733.3 46948.8 60850.0 62145.7 62296.1 62561.0 63267.1 7225.2 7947.1 7966.6 8316.4 8463.2 11046.3 13033.5 13033.6 13187.4 13723.9 11176.4 11330.9 11600.2 11896.9 12034.0 11203.9 11327.9 11451.3 11665.6 11795.8 11988.5 12066.5 12080.2 12402.8 12423.4 7489.3 7593.6 7696.7 7770.2 7789.1 11425.3 11552.4 11681.5 11682.4 11807.1 23:25:37 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | [#3] mootools.html Cycles:180 Average:5920.42 Median:4388.86 stddev:3449.15 (78.6%) stddev-sans-first:3442.70 23:25:37 INFO - PROCESS | 26843 | Values: 1481.7 1511.4 1639.2 1771.5 1792.7 8673.7 9208.2 9331.0 9333.8 9342.6 7960.6 8531.8 8781.2 8833.9 9133.9 1654.3 2057.5 2057.7 2057.9 2291.6 2238.7 2296.2 2296.9 2338.8 2339.4 2047.4 2109.9 2111.1 2132.1 2225.3 2272.9 2330.8 2335.9 2338.8 2340.6 2300.2 2301.9 2306.2 2350.7 2351.0 9039.8 9056.9 9086.4 9114.8 9115.3 4956.0 5095.1 5113.4 5136.1 5140.0 3035.7 3121.3 3188.1 3191.7 3199.3 1065.6 1095.9 1100.5 1115.4 1129.7 12425.7 12434.4 12443.5 12449.9 12463.7 4104.2 4329.9 4399.4 4474.4 4488.1 10319.9 10324.7 10325.9 10331.9 10339.3 5146.3 5147.2 5151.9 5154.5 5164.9 4703.2 4733.6 4736.1 4739.2 4740.8 3976.8 3989.3 3996.8 4088.2 4114.1 1209.2 1209.9 1211.5 1223.4 1225.5 848.7 918.2 973.9 1008.1 1056.1 6077.5 6267.8 6394.2 6424.8 6593.1 983.2 1013.0 1013.3 1030.7 1036.1 4229.3 4360.4 4378.3 4442.5 4517.2 11367.3 11775.4 11792.0 11808.9 11847.2 11724.9 11735.2 11739.5 11741.6 11742.8 8099.6 8482.8 8491.6 8650.7 8663.0 5320.8 5420.9 5921.5 6134.7 6150.9 10167.3 10345.8 10351.5 10358.8 10479.5 10130.5 10276.6 10533.4 10574.9 10709.4 8109.9 8320.5 8326.5 8333.3 8334.0 7360.2 7763.5 8514.6 8929.1 9015.5 7853.8 7879.8 7885.0 7906.0 7943.2 7715.1 7747.9 7764.5 7786.4 8030.7 7229.5 7247.4 7276.3 7281.8 7348.3 5323.3 5356.7 5380.6 5478.7 5610.7 5484.4 5627.8 5652.0 5740.3 5787.7 23:25:37 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | [#4] prototype.html Cycles:180 Average:4445.47 Median:4990.11 stddev:1339.47 (26.8%) stddev-sans-first:1306.69 23:25:37 INFO - PROCESS | 26843 | Values: 306.0 314.7 318.1 323.3 328.1 5014.7 5130.8 5143.0 5206.3 5215.3 5127.2 5140.3 5142.8 5154.3 5166.5 4037.3 4042.6 4047.9 4049.8 4058.4 3838.6 3947.6 4037.1 4078.8 4082.9 3935.5 3952.2 3967.6 3972.3 3990.2 2927.4 3495.4 3518.7 3531.8 3867.7 3475.8 3488.9 3493.8 3496.6 3508.2 4897.0 4965.5 5041.8 5065.1 5131.6 4480.8 4504.2 4516.4 4534.9 4543.0 5322.9 5337.2 5340.8 5345.7 5347.3 3674.3 3799.8 3857.2 3881.6 3885.8 5543.5 5565.4 5571.2 5627.5 5628.4 3941.3 3972.7 3997.3 3999.6 4006.4 3946.7 4006.8 4020.3 4036.2 4046.4 4526.5 4547.2 4551.4 4555.7 4575.8 5130.5 5244.4 5350.3 5366.1 5460.3 1342.1 1367.8 1368.4 1369.8 1372.4 853.8 874.4 880.4 886.9 888.2 4648.5 4664.8 4677.8 4677.9 4685.1 4828.7 4846.3 4875.6 4903.3 4922.3 4442.8 4670.2 4741.6 4741.8 4750.8 2472.4 2474.8 2499.6 2502.6 2520.6 5085.3 5115.5 5118.1 5154.7 5216.2 4869.6 4935.7 4943.4 4963.2 5198.3 5859.6 5874.7 5884.9 5885.2 5891.4 5582.5 5611.9 5612.2 5612.5 5621.8 5404.6 5499.8 5512.2 5525.8 5541.0 5795.8 5853.8 5861.9 5864.8 5871.6 3889.5 3908.4 3919.8 3921.9 3926.7 5090.8 5437.9 5569.7 5582.9 5589.2 5425.0 5469.1 5481.4 5481.5 5487.9 5244.3 5392.2 5443.9 5447.0 5465.0 5336.6 5357.3 5360.4 5363.8 5384.7 5469.2 5484.7 5507.1 5525.6 5566.9 5240.5 5283.6 5327.6 5355.3 5362.0 23:25:37 INFO - PROCESS | 26843 | 23:25:37 INFO - PROCESS | 26843 | [#5] yui.html Cycles:180 Average:19604.60 Median:4715.81 stddev:26941.19 (571.3%) stddev-sans-first:26979.44 23:25:37 INFO - PROCESS | 26843 | Values: 717.4 729.9 738.2 775.1 878.4 16274.6 17306.6 17315.1 17345.0 17353.7 15129.2 15266.5 15266.9 15272.9 15281.4 798.4 814.9 816.4 818.1 820.1 664.3 803.5 817.8 823.6 823.6 776.4 878.0 883.3 886.1 886.8 769.6 770.9 771.8 866.7 874.7 506.6 619.2 631.4 632.2 633.4 15290.2 15327.2 15372.7 15407.2 15410.3 13978.4 14517.4 14840.1 14992.6 15010.5 13209.9 13298.3 13377.8 13555.3 13731.9 4474.1 4510.3 4525.9 4652.3 4671.1 76633.0 78614.6 78720.6 78913.0 79051.0 10845.7 11591.4 11708.6 11717.3 12098.6 19995.2 21018.9 21035.5 21040.2 21041.2 8198.5 8312.6 8318.3 8426.7 8589.5 4250.7 4354.7 4416.2 4478.8 4563.2 3467.1 3552.9 3593.4 3600.1 3604.2 596.4 607.7 613.1 614.7 621.3 675.2 707.2 730.6 732.2 733.4 9376.4 9887.4 9955.7 9993.0 10133.7 549.0 568.6 625.2 655.6 737.2 4471.6 4760.5 4771.8 4779.7 4968.1 62189.0 62230.0 64123.4 67014.0 117647.4 60280.4 101337.0 103103.0 106324.0 106625.5 88102.0 89189.0 89627.6 91895.0 93691.1 9301.6 9360.5 9426.2 9454.1 9539.2 52313.5 52937.7 53008.2 53240.5 53947.0 49827.5 60520.7 63735.0 66983.3 69421.0 12668.6 12960.9 12962.7 13024.4 13876.5 14173.6 15092.5 15106.5 15174.9 15421.9 7625.4 12342.8 13977.7 14207.4 14436.3 14004.9 14346.1 14480.3 14489.6 14599.3 12251.4 12330.8 13692.7 13936.8 13945.0 11333.9 11569.5 11734.7 11867.3 12276.3 11068.6 11607.8 11968.8 11992.6 12076.2 23:25:37 INFO - PROCESS | 26843 | -------- Summary: end -------- 23:25:37 INFO - PROCESS | 26843 | 23:25:38 INFO - TEST-INFO | 26843: exit 0 23:25:38 INFO - TEST-OK | dromaeo_css | took 1152955ms 23:25:38 INFO - TEST-START | kraken 23:25:38 INFO - operating with platform_type : linux_ 23:25:38 INFO - Initialising browser for kraken test... 23:25:38 INFO - TEST-INFO | started process 27052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpav96na/profile http://localhost:43143/getInfo.html) 23:25:42 INFO - PROCESS | 27052 | __metrics Screen width/height:1600/1200 23:25:42 INFO - PROCESS | 27052 | colorDepth:24 23:25:42 INFO - PROCESS | 27052 | Browser inner width/height: 1024/697 23:25:42 INFO - PROCESS | 27052 | __metrics 23:25:42 INFO - PROCESS | 27052 | 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" 23:25:42 INFO - PROCESS | 27052 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:25:43 INFO - TEST-INFO | 27052: exit 0 23:25:43 INFO - Browser initialized. 23:25:43 INFO - Running cycle 1/1 for kraken test... 23:25:43 INFO - TEST-INFO | started process 27133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpav96na/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:55 INFO - PROCESS | 27133 | RSS: Main: 156450816 23:25:55 INFO - PROCESS | 27133 | 23:25:58 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43143/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:58 INFO - PROCESS | 27133 | RSS: Main: 212381696 23:25:58 INFO - PROCESS | 27133 | 23:26:09 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43143/tests/kraken/driver.html?testName=audio-dft) 23:26:09 INFO - PROCESS | 27133 | RSS: Main: 180928512 23:26:09 INFO - PROCESS | 27133 | 23:26:12 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43143/tests/kraken/driver.html?testName=audio-fft) 23:26:13 INFO - PROCESS | 27133 | RSS: Main: 278720512 23:26:13 INFO - PROCESS | 27133 | 23:26:15 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43143/tests/kraken/driver.html?testName=audio-oscillator) 23:26:16 INFO - PROCESS | 27133 | RSS: Main: 185577472 23:26:16 INFO - PROCESS | 27133 | 23:26:25 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:26:26 INFO - PROCESS | 27133 | RSS: Main: 181882880 23:26:26 INFO - PROCESS | 27133 | 23:26:29 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43143/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:30 INFO - PROCESS | 27133 | RSS: Main: 221646848 23:26:30 INFO - PROCESS | 27133 | 23:26:33 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43143/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:33 INFO - PROCESS | 27133 | RSS: Main: 220856320 23:26:33 INFO - PROCESS | 27133 | 23:26:36 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43143/tests/kraken/driver.html?testName=json-parse-financial) 23:26:37 INFO - PROCESS | 27133 | RSS: Main: 221401088 23:26:37 INFO - PROCESS | 27133 | 23:26:38 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:39 INFO - PROCESS | 27133 | RSS: Main: 185610240 23:26:39 INFO - PROCESS | 27133 | 23:26:41 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43143/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:41 INFO - PROCESS | 27133 | RSS: Main: 192323584 23:26:41 INFO - PROCESS | 27133 | 23:26:43 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:44 INFO - PROCESS | 27133 | RSS: Main: 199880704 23:26:44 INFO - PROCESS | 27133 | 23:26:45 INFO - PROCESS | 27133 | 1470292005493 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] 23:26:47 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:47 INFO - PROCESS | 27133 | RSS: Main: 194572288 23:26:47 INFO - PROCESS | 27133 | 23:26:50 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:51 INFO - PROCESS | 27133 | RSS: Main: 198877184 23:26:51 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | Cycle 1(1): loaded http://localhost:43143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43143/tests/kraken/driver.html?testName=ai-astar) 23:26:52 INFO - PROCESS | 27133 | RSS: Main: 250593280 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | __start_tp_report 23:26:52 INFO - PROCESS | 27133 | _x_x_mozilla_page_load 23:26:52 INFO - PROCESS | 27133 | _x_x_mozilla_page_load_details 23:26:52 INFO - PROCESS | 27133 | |i|pagename|runs| 23:26:52 INFO - PROCESS | 27133 | |0;ai-astar;102;112;111;114;112;110;112;109;111;112 23:26:52 INFO - PROCESS | 27133 | |1;audio-beat-detection;143;118;119;174;119;122;157;134;154;121 23:26:52 INFO - PROCESS | 27133 | |2;audio-dft;162;162;160;161;160;161;162;159;161;160 23:26:52 INFO - PROCESS | 27133 | |3;audio-fft;76;75;75;130;75;76;77;76;117;75 23:26:52 INFO - PROCESS | 27133 | |4;audio-oscillator;84;83;121;84;84;84;120;85;95;128 23:26:52 INFO - PROCESS | 27133 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;116;117 23:26:52 INFO - PROCESS | 27133 | |6;imaging-darkroom;145;145;146;145;145;145;146;145;145;146 23:26:52 INFO - PROCESS | 27133 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;94;94 23:26:52 INFO - PROCESS | 27133 | |8;json-parse-financial;53;50;51;50;50;58;50;50;48;49 23:26:52 INFO - PROCESS | 27133 | |9;json-stringify-tinderbox;59;59;60;58;60;59;59;59;59;59 23:26:52 INFO - PROCESS | 27133 | |10;stanford-crypto-aes;83;77;86;82;75;76;77;76;76;76 23:26:52 INFO - PROCESS | 27133 | |11;stanford-crypto-ccm;124;119;135;124;123;120;119;120;204;128 23:26:52 INFO - PROCESS | 27133 | |12;stanford-crypto-pbkdf2;160;163;164;160;159;162;158;157;155;156 23:26:52 INFO - PROCESS | 27133 | |13;stanford-crypto-sha256-iterative;67;63;64;64;63;63;67;63;62;62 23:26:52 INFO - PROCESS | 27133 | __end_tp_report 23:26:52 INFO - PROCESS | 27133 | __start_cc_report 23:26:52 INFO - PROCESS | 27133 | _x_x_mozilla_cycle_collect,1651 23:26:52 INFO - PROCESS | 27133 | __end_cc_report 23:26:52 INFO - PROCESS | 27133 | __startTimestamp1470292012925__endTimestamp 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | ------- Summary: start ------- 23:26:52 INFO - PROCESS | 27133 | Number of tests: 14 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.27 (2.9%) stddev-sans-first:1.42 23:26:52 INFO - PROCESS | 27133 | Values: 102.0 112.0 111.0 114.0 112.0 110.0 112.0 109.0 111.0 112.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:138.50 stddev:19.96 (14.4%) stddev-sans-first:21.01 23:26:52 INFO - PROCESS | 27133 | Values: 143.0 118.0 119.0 174.0 119.0 122.0 157.0 134.0 154.0 121.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 23:26:52 INFO - PROCESS | 27133 | Values: 162.0 162.0 160.0 161.0 160.0 161.0 162.0 159.0 161.0 160.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.50 stddev:20.43 (27.1%) stddev-sans-first:21.39 23:26:52 INFO - PROCESS | 27133 | Values: 76.0 75.0 75.0 130.0 75.0 76.0 77.0 76.0 117.0 75.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.00 stddev:18.52 (22.0%) stddev-sans-first:19.05 23:26:52 INFO - PROCESS | 27133 | Values: 84.0 83.0 121.0 84.0 84.0 84.0 120.0 85.0 95.0 128.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:26:52 INFO - PROCESS | 27133 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:26:52 INFO - PROCESS | 27133 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 23:26:52 INFO - PROCESS | 27133 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:50.00 stddev:2.81 (5.6%) stddev-sans-first:2.87 23:26:52 INFO - PROCESS | 27133 | Values: 53.0 50.0 51.0 50.0 50.0 58.0 50.0 50.0 48.0 49.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 23:26:52 INFO - PROCESS | 27133 | Values: 59.0 59.0 60.0 58.0 60.0 59.0 59.0 59.0 59.0 59.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:77.00 stddev:3.81 (4.9%) stddev-sans-first:3.66 23:26:52 INFO - PROCESS | 27133 | Values: 83.0 77.0 86.0 82.0 75.0 76.0 77.0 76.0 76.0 76.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:124.00 stddev:25.91 (20.9%) stddev-sans-first:27.34 23:26:52 INFO - PROCESS | 27133 | Values: 124.0 119.0 135.0 124.0 123.0 120.0 119.0 120.0 204.0 128.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:160.00 stddev:2.99 (1.9%) stddev-sans-first:3.16 23:26:52 INFO - PROCESS | 27133 | Values: 160.0 163.0 164.0 160.0 159.0 162.0 158.0 157.0 155.0 156.0 23:26:52 INFO - PROCESS | 27133 | 23:26:52 INFO - PROCESS | 27133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.81 (2.9%) stddev-sans-first:1.51 23:26:52 INFO - PROCESS | 27133 | Values: 67.0 63.0 64.0 64.0 63.0 63.0 67.0 63.0 62.0 62.0 23:26:52 INFO - PROCESS | 27133 | -------- Summary: end -------- 23:26:52 INFO - PROCESS | 27133 | 23:26:53 INFO - TEST-INFO | 27133: exit 0 23:26:53 INFO - TEST-OK | kraken | took 75709ms 23:26:53 INFO - SUITE-END | took 1228s 23:26:54 INFO - Completed test suite (00:20:28) 23:26:54 INFO - javascript benchmark 23:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.182120827377, 3036.1802313375388, 3054.954175687365, 3080.9075727728177, 3098.45776989027, 5125.282460455539, 5176.120059589869, 5219.660722053064, 5265.18389649604, 5277.736113194339, 5200.739963001844, 5214.374275086985, 5236.816711415101, 5261.0, 5319.707416092114, 4763.54746299101, 4789.688670236441, 4821.445533763609, 4822.807087716487, 4872.829450969217, 4838.467768545457, 4870.512948705119, 4877.292792545079, 4900.950990490103, 4923.704577725348, 4630.097131059445, 4649.628029757611, 4665.813367465297, 4778.4265888093305, 4789.233722604384, 4721.3862197914395, 4728.4798672146035, 4736.100140973204, 4736.194846876039, 4737.194676904935, 4688.484266730657, 4688.5545873142, 4700.177468942956, 4710.505396933307, 4714.811407543694, 5148.150555158394, 5154.433012368637, 5165.354330708661, 5199.740012999335, 5208.609354298443, 5562.694051827148, 5597.524210442118, 5604.607677462579, 5607.271054762896, 5609.635373700697, 5440.755166017539, 5556.249906262643, 5590.91613625796, 5629.324481062299, 5643.746031428595, 5243.659162154486, 5262.473752624707, 5287.127623942045, 5292.02097611943, 5292.364916210079, 5752.654840709487, 5759.712014399347, 5764.74058667361, 5766.106253530709, 5769.480746732815, 5277.577793776489, 5379.811706590329, 5382.165764306539, 5384.9461505385225, 5540.722963851872, 5496.477834605706, 5532.170174473861, 5538.363088244822, 5545.417731138253, 5550.028744969614, 5464.0711079116645, 5466.781328746885, 5472.808451704172, 5475.123980163155, 5476.698781567052, 5387.191921211849, 5434.70109143993, 5462.426445223195, 5466.972665136649, 5468.781248750085, 4308.0, 4309.762963037063, 4312.396264522969, 4348.608625223745, 4351.26028575143, 3830.0, 3851.1912498375095, 3853.7109716771356, 3877.933568268749, 3883.689304855605, 5184.170532714747, 5233.528982391527, 5236.423993360727, 5310.8141215057285, 5348.304720386325, 5636.323641163005, 5657.830265092054, 5661.745221465044, 5663.263775709132, 5692.089265717465, 5360.3299587551555, 5365.436629153961, 5370.70461124634, 5378.085725426687, 5378.51593356592, 4734.479207287196, 4804.42346918372, 4825.179719447702, 4841.806327746851, 4851.34506841579, 5864.472197502075, 5925.318588362394, 5925.762969481172, 5926.140709597084, 5966.194563733927, 5583.050881350261, 5583.860403489783, 5591.4688104629995, 5653.236813030188, 5655.604107712421, 5709.68596727184, 5801.390853960443, 5834.416558344302, 5839.5036421904615, 5913.379095195115, 5487.368952570506, 5529.640573362719, 5530.281063461724, 5537.446255374431, 5584.525315348241, 5602.3837377887585, 5608.96234196675, 5610.382857885547, 5615.466530679579, 5616.410276920865, 5286.788528458818, 5383.1117865553315, 5424.783008679608, 5429.131338985743, 5539.446055394428, 5467.7266136692215, 5469.097598896137, 5481.534069603968, 5485.588580856532, 5517.531009864046, 5378.838634840961, 5404.7567859445635, 5407.513323800877, 5409.350877894678, 5468.753906074316, 5287.8149264777085, 5418.810341638024, 5451.48210919962, 5453.26380938584, 5544.667319960815, 5378.946210538001, 5385.0, 5386.13821788512, 5386.407495175606, 5417.295751552273], "value": 5158.438116354974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8266520043986, 605.1407002057081, 606.2179788073386, 616.35898665388, 628.4563852267788, 32276.83861580692, 32878.67121328786, 41780.16439671205, 42856.0, 43441.34837977433, 41089.0, 45025.0994980101, 45051.09897802042, 45051.54948450514, 45057.54942450574, 8837.60230789616, 8962.820743585124, 8979.146981036823, 8982.59578318974, 8983.820323593523, 8834.337424693174, 8921.509316987564, 8926.0, 8930.732078037669, 8931.598078086501, 8917.063708310632, 8976.281897448222, 8982.775430614254, 8987.0, 8991.100889911022, 8880.822383552326, 8884.955575222082, 8893.333000024959, 8924.33067519932, 8934.374593778439, 8787.824243515093, 8836.690715824916, 8838.602262898185, 8846.955765221133, 8854.335924805666, 42354.1529169418, 42751.144977100594, 42797.78601107006, 42849.0, 42856.357154642705, 3470.880451334287, 3610.29599228148, 3649.7445178837493, 3711.2948539777626, 3754.436834474823, 28451.857740711162, 29294.121176364744, 32476.837615811768, 33052.33895322104, 33144.83427582871, 4008.8797336079965, 4345.283028300327, 4404.273294906337, 4454.0646464242545, 4496.460424749051, 331805.0, 333027.0, 336792.99999999756, 336876.0, 338441.0, 55714.44285557174, 56003.439965600635, 56007.43992560022, 56042.719786400805, 56078.0, 58595.414045859, 58643.0, 58667.11999320013, 58706.477611342605, 58714.41285587175, 16930.830691693172, 17177.0, 17183.226754796066, 17192.140392980302, 17193.0, 13294.933525332312, 13303.733925321632, 13379.732405351839, 13380.866191337962, 13385.0, 14739.115653060851, 15692.372305107669, 15709.293081811345, 15745.527634170992, 15779.05325680463, 6302.306746257908, 6387.828138432955, 6418.432626949164, 6547.9017814732815, 6556.114924485133, 990.7374545745383, 1073.1575713065363, 1090.487470888681, 1099.999000909169, 1103.9236744174527, 31966.840165799487, 32271.35457290841, 32335.35329293401, 32645.673543264264, 32851.19318437461, 1087.9945600272106, 1127.2729089737074, 1148.8276758486127, 1150.263831148066, 1163.6160067177811, 16361.263743131587, 16978.745318820227, 17043.914780426017, 17150.228239728993, 17298.65402691939, 544740.0, 544832.0, 547816.0, 547833.0, 547916.0, 57875.421245787846, 57999.0, 58149.0, 58466.707666462244, 58580.70709646425, 1262.1669697999275, 1359.4562175129631, 1369.2195448594405, 1383.8685324894118, 1396.2809153286269, 31540.842295788374, 33626.66373336333, 33731.32537349288, 33910.491342629386, 34627.13432164216, 49401.50598494113, 50156.23515765996, 50162.74918625384, 50169.49830501648, 50199.24701129413, 454381.0, 456795.0, 457141.0, 457616.0, 457868.0, 35731.642683572834, 41159.7942010288, 41536.37695434631, 42404.787976059924, 42525.0, 48302.0, 48705.26942095801, 48755.26867096926, 49231.753841230566, 50255.0, 40078.79960600295, 40331.19337613173, 40821.0, 41104.38343424911, 42261.57738422576, 40306.1938761229, 40891.18217635571, 41448.792756036026, 42109.157816844105, 42400.78799605982, 40512.59487405088, 40677.796611016754, 41140.794296028325, 41243.1751364977, 42104.0, 34063.0, 36550.634493654725, 36959.44560831643, 37438.0, 37859.0, 27335.316617084733, 27956.44087118287, 28162.718372816827, 28196.43607127887, 28232.0], "value": 20198.333704219025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.2755877611927, 384.2890652293257, 389.60649743758796, 394.0287192071543, 415.6051750836706, 18643.62712745746, 20483.69274460884, 20560.69158962613, 20635.17459301626, 20677.172913083497, 19291.4212573623, 19391.321303754372, 19753.802461975374, 19916.302929397472, 20055.398338049847, 4944.159492886218, 5084.516970887769, 5276.577873770108, 5909.379515150912, 5961.642301461926, 5824.155497452867, 5901.852453688649, 5907.497862681677, 5910.34986151523, 5910.379410161936, 5576.832695019156, 5852.502537284336, 5863.882722345551, 5872.530197584183, 5873.0603103503445, 5650.491455769001, 5811.244538210027, 5841.47426731592, 5853.853653658672, 5857.3849745776715, 5600.60795744294, 5630.4369563043365, 5637.210790489335, 5639.4642508962, 5641.266635337421, 13219.405126769318, 13268.601941941757, 13390.263535505543, 13428.127171733806, 13542.796858047137, 2286.8056215221727, 2529.7723204911645, 2684.9731502684917, 2730.645016147908, 2800.8739606717745, 9321.44071355721, 9476.620935162655, 9485.952570237174, 9791.069848364394, 9815.460149691764, 1887.8489720822301, 1906.9618607627908, 1918.386116442739, 1966.429735376739, 1983.3950645053253, 79082.6045869767, 79216.20783792147, 80319.59840200761, 81248.59375703143, 82610.0, 10874.565017399374, 10928.289661172157, 11206.439678016066, 11222.270552414067, 11287.887121128848, 13728.45086196541, 13749.725005499835, 15418.922905385401, 15562.299696513684, 15622.29699663518, 7936.2857342839425, 8414.915850841413, 8484.618192181366, 8534.27458666008, 8572.142785721378, 8128.024637043474, 8187.0, 8221.260086592236, 8299.087100418948, 8439.198276163756, 4538.750368729686, 4780.737059461693, 4791.233402655628, 4836.685615434985, 4908.141075311806, 1770.9380171693929, 1948.951276218106, 1951.580410211783, 1979.0104947526238, 2015.9899200504196, 961.4423634292094, 1004.4124187350482, 1027.1628622672497, 1030.696393560407, 1047.8690163729534, 18885.81114188868, 19820.60358792845, 19972.600547988957, 19996.60006799856, 20318.593628127353, 983.1250187333279, 993.4238141877838, 1018.2770233134557, 1046.9790604187874, 1049.459528342904, 10319.690409287734, 10754.838677419688, 11075.72310692239, 11095.611653592085, 11369.374684392273, 286827.0, 370617.0, 501313.0, 503104.0, 530294.0, 94064.0, 96522.51738741402, 96998.51500742452, 97318.5134074325, 98240.0, 990.5988074829705, 995.571904081252, 1013.4426065663708, 1020.1023099672537, 1029.8609687692065, 17252.396166134124, 17561.385351512636, 17993.370232041816, 18685.71971420457, 18691.06544672788, 46091.769541152076, 46397.0, 46654.30018549656, 46733.29900051434, 46948.7652561735, 60850.0, 62145.689271553354, 62296.06555901756, 62561.0, 63267.050994236044, 7225.205227424874, 7947.086085100056, 7966.601669916597, 8316.41785075039, 8463.195996380335, 11046.33721976684, 13033.47866085346, 13033.608991730263, 13187.406566704329, 13723.931380343034, 11176.441177940907, 11330.94334528322, 11600.245984011011, 11896.881031189923, 12034.0, 11203.887961120285, 11327.886721132683, 11451.312921224753, 11665.59170429031, 11795.823062653895, 11988.46051927648, 12066.517339306329, 12080.21478603888, 12402.75194496087, 12423.37883105823, 7489.28851759082, 7593.5823529706395, 7696.692132314644, 7770.184130666199, 7789.104253010976, 11425.31448113116, 11552.364619945984, 11681.474333654836, 11682.357470339213, 11807.055435565306], "value": 9135.478844467405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.6666250093726, 1511.3576729889799, 1639.1886016421865, 1771.5039788859124, 1792.659394715005, 8673.69642062528, 9208.171264586186, 9330.973592904784, 9333.766655833608, 9342.626294948202, 7960.601969901496, 8531.829363412728, 8781.209691127797, 8833.867491987625, 9133.908660913388, 1654.3051918194387, 2057.4547744847628, 2057.722207501983, 2057.86623869448, 2291.6447950567604, 2238.6865838782583, 2296.1504243429954, 2296.850704704189, 2338.8362814602983, 2339.356676913845, 2047.3960181746347, 2109.947251318714, 2111.102781317941, 2132.115172203534, 2225.332400279926, 2272.9090836366527, 2330.790228879409, 2335.8948847301913, 2338.8128949683983, 2340.6254999200046, 2300.2179259052004, 2301.873396963166, 2306.169778879602, 2350.659154422599, 2351.036075209156, 9039.81920361589, 9056.864147037733, 9086.409383390059, 9114.817703645956, 9115.316351273681, 4956.033573453178, 5095.0574143783515, 5113.411957624883, 5136.075506408845, 5140.023395554833, 3035.666076731558, 3121.297708015701, 3188.1392024153347, 3191.69678880506, 3199.3281410903737, 1065.6217042949718, 1095.8794532601407, 1100.5322737836389, 1115.4088333183427, 1129.706276368142, 12425.689357766038, 12434.37828108609, 12443.502259909503, 12449.93775031119, 12463.688407789878, 4104.220198162399, 4329.913401732011, 4399.406080179199, 4474.440694913136, 4488.12481566098, 10319.896801031893, 10324.741881453023, 10325.9483702581, 10331.896681033244, 10339.276250662531, 5146.279520867081, 5147.202183661539, 5151.871203219949, 5154.53609175176, 5164.948350516522, 4703.200455922433, 4733.573978341966, 4736.052789442126, 4739.218029025173, 4740.810367585258, 3976.8011599419915, 3989.2646698686162, 3996.780177090288, 4088.182363527247, 4114.0948991221885, 1209.23451760429, 1209.866914639389, 1211.4790640024698, 1223.3699644682995, 1225.546547777328, 848.6859861851032, 918.2149262380702, 973.9464329461806, 1008.1078245752561, 1056.060106505211, 6077.544184186204, 6267.811965641038, 6394.1687580614225, 6424.775132870327, 6593.109930159463, 983.1741337276721, 1012.9848052279222, 1013.2856336282903, 1030.6601418156367, 1036.0778906772978, 4229.302165142779, 4360.389545463638, 4378.321360189176, 4442.511323754385, 4517.232070548015, 11367.317960922372, 11775.352355620524, 11792.0, 11808.94095529517, 11847.170698051053, 11724.88275117255, 11735.178537502294, 11739.47172377245, 11741.589044383576, 11742.823857642143, 8099.635516401776, 8482.830343392974, 8491.617877195418, 8650.653973840976, 8663.0, 5320.787168513216, 5420.864478388072, 5921.526277897672, 6134.6625935573975, 6150.907736384047, 10167.288289819642, 10345.844812327972, 10351.482425878525, 10358.792824143324, 10479.476026198812, 10130.493475326351, 10276.588936442458, 10533.42066186367, 10574.947125264325, 10709.410982395731, 8109.878351824609, 8320.542370169698, 8326.45878017927, 8333.291670207858, 8334.0, 7360.227176146427, 7763.4953728007495, 8514.574271286534, 8929.06244844282, 9015.504147271962, 7853.803654908673, 7879.763607091796, 7884.960575197088, 7906.0, 7943.24539168778, 7715.074191097105, 7747.883781743391, 7764.456488045783, 7786.377089832687, 8030.718924837603, 7229.457790665616, 7247.383972362408, 7276.345128938209, 7281.8179545509665, 7348.3386495213545, 5323.30796996388, 5356.651817631841, 5380.623356365017, 5478.67127972307, 5610.719464026701, 5484.396716361117, 5627.831165065055, 5651.971740141273, 5740.282464691913, 5787.652740835563], "value": 4685.835590873095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.9510478323469, 314.67274035003595, 318.1473650616348, 323.27747484372424, 328.06501470808183, 5014.749262536877, 5130.8460746177625, 5142.974285128569, 5206.277511579225, 5215.322008138942, 5127.205283181103, 5140.254663073862, 5142.768575414106, 5154.27840102385, 5166.535011848933, 4037.2732908076537, 4042.555318914917, 4047.8583249586272, 4049.777262250575, 4058.3620646579666, 3838.6161383861668, 3947.6447119759214, 4037.091654377756, 4078.775667338295, 4082.8775136745944, 3935.5474120476083, 3952.189801090784, 3967.6230758077936, 3972.2651309507687, 3990.1620659661507, 2927.3706153177063, 3495.423255162895, 3518.677672735982, 3531.805750683724, 3867.7292589518743, 3475.8435870385892, 3488.883557261677, 3493.825308734553, 3496.5629296337956, 3508.15804206991, 4897.0, 4965.478624744422, 5041.848744537633, 5065.088284108859, 5131.640785145041, 4480.775961201959, 4504.166729155117, 4516.36770852081, 4534.863954081383, 4543.0, 5322.946770532284, 5337.172738225581, 5340.7716225268405, 5345.705986170798, 5347.331583552056, 3674.2835147146316, 3799.772013679188, 3857.1707082977296, 3881.611838816124, 3885.7668539887695, 5543.52880005204, 5565.387807341189, 5571.192177134293, 5627.5238894886115, 5628.409017053233, 3941.3102707026155, 3972.741771784825, 3997.2804895118575, 3999.6200360965663, 4006.358982562776, 3946.743461674982, 4006.759594424344, 4020.276350256982, 4036.2129384769687, 4046.393041043808, 4526.479454862733, 4547.15877562652, 4551.38556294896, 4555.658325625592, 4575.81696732127, 5130.512601302945, 5244.423113457517, 5350.3312085989255, 5366.141417373202, 5460.34475862899, 1342.0806747378078, 1367.8236716423867, 1368.4321006782075, 1369.8082268482422, 1372.389286767399, 853.8206976534873, 874.4010352908278, 880.3969281042379, 886.8536691445968, 888.2139306713605, 4648.511906249795, 4664.763837583043, 4677.783776218208, 4677.929831052537, 4685.086408150378, 4828.7102773833685, 4846.273059041101, 4875.6109506342345, 4903.26451032348, 4922.286268491049, 4442.777861106932, 4670.1512077632615, 4741.620670346364, 4741.767140543484, 4750.809967601257, 2472.3558833375964, 2474.7502511231714, 2499.6375525549056, 2502.649629051934, 2520.5715028445206, 5085.296425697359, 5115.544538621408, 5118.059094497216, 5154.716490593053, 5216.21756736485, 4869.565217391304, 4935.703857768545, 4943.41810620598, 4963.205887058053, 5198.324217851655, 5859.619124756877, 5874.735636896436, 5884.911726324194, 5885.205497257815, 5891.381404952418, 5582.469665381782, 5611.943880561143, 5612.242347283064, 5612.522935550524, 5621.803236886853, 5404.567634589145, 5499.807506737245, 5512.173174023928, 5525.834224973257, 5540.972295138498, 5795.768169273182, 5853.765849365977, 5861.9413805861395, 5864.824055278348, 5871.588988770745, 3889.533256009297, 3908.3746600543777, 3919.8040097994417, 3921.941170882382, 3926.705497087673, 5090.796368145381, 5437.891242175056, 5569.749361278833, 5582.86042848932, 5589.161625756169, 5424.972875135599, 5469.07025805606, 5481.382992017444, 5481.534069603968, 5487.945120548743, 5244.344456942882, 5392.218128371443, 5443.918341224964, 5447.0, 5464.972675136758, 5336.599755018467, 5357.276767636319, 5360.383555890967, 5363.839084827461, 5384.6769193848495, 5469.206964990134, 5484.725763711719, 5507.13628912971, 5525.613207075467, 5566.888662226652, 5240.528352448298, 5283.550898173698, 5327.627066105335, 5355.250264962986, 5362.034833729966], "value": 4018.3526845745864, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.3543810570487, 729.8905164225362, 738.1769327200174, 775.1086250811566, 878.3500209844715, 16274.593135171612, 17306.56733581658, 17315.13424328785, 17345.04602246876, 17353.739693904587, 15129.167895765728, 15266.465673701423, 15266.923665381686, 15272.923635381836, 15281.388744450236, 798.3932211519258, 814.9348052155814, 816.3713940265992, 818.1205204405259, 820.1183727492969, 664.3157547725826, 803.4897839871694, 817.8078151634361, 823.5923218007094, 823.6046697585163, 776.3556248313914, 877.9561021948876, 883.2713011765287, 886.1315910407804, 886.7960369115108, 769.6267310354474, 770.9074911010687, 771.7993321736361, 866.6576702202594, 874.6982291109557, 506.5668853130594, 619.2383368456778, 631.3938618925837, 632.2318383164477, 633.4045996763028, 15290.159041252728, 15327.233638318152, 15372.692546149014, 15407.229638518142, 15410.306536205786, 13978.370973306226, 14517.419303227858, 14840.10959342432, 14992.625184370369, 15010.47463338778, 13209.933950330187, 13298.335083245798, 13377.799333010013, 13555.322233888266, 13731.931340343333, 4474.082813023322, 4510.25580779171, 4525.864224073283, 4652.325412815157, 4671.065786842645, 76633.0, 78614.606926965, 78720.60639696765, 78913.0, 79051.0, 10845.728856778644, 11591.362475063785, 11708.648740537797, 11717.296962182296, 12098.576549820715, 19995.200191992157, 21018.894905525376, 21035.474113147295, 21040.15839366408, 21041.158353665684, 8198.508089514648, 8312.584370781437, 8318.292945099734, 8426.705065322683, 8589.484630922165, 4250.681198910032, 4354.738715677069, 4416.1609294233995, 4478.820847166142, 4563.155816174019, 3467.133216695826, 3552.857885684595, 3593.389123848952, 3600.117971097098, 3604.1890574621025, 596.3887015808743, 607.7083000159948, 613.0528333724407, 614.7264467312093, 621.3010363341241, 675.2234929830636, 707.1726080485741, 730.6018220070075, 732.1543617122232, 733.3912852332551, 9376.437413755197, 9887.406755594688, 9955.701328960144, 9992.950035249924, 10133.695989120191, 548.9972550137304, 568.5650477384804, 625.2403329954128, 655.5837043477426, 737.189091998797, 4471.61991230749, 4760.547747963938, 4771.785269662804, 4779.689320194177, 4968.105740966588, 62189.0, 62230.0, 64123.35876641174, 67014.0, 117647.41176294064, 60280.39719602748, 101337.0, 103103.0, 106324.0, 106625.46687266514, 88102.0, 89189.0, 89627.55186224288, 91895.0, 93691.06308936959, 9301.581428835854, 9360.53197340144, 9426.151646351587, 9454.101860323259, 9539.236861051239, 52313.47686523086, 52937.735311323195, 53008.20487692765, 53240.46759532355, 53947.0, 49827.501724982285, 60520.69739651449, 63735.0, 66983.33016669966, 69421.0, 12668.556600518938, 12960.870391295966, 12962.675933101747, 13024.413901374272, 13876.514321998682, 14173.574792756233, 15092.54722358331, 15106.471273505374, 15174.924125379302, 15421.922890385476, 7625.389968802593, 12342.75314493687, 13977.650558736113, 14207.431702731776, 14436.278186090443, 14004.929975350058, 14346.139231646135, 14480.275986200859, 14489.637759056108, 14599.343029563483, 12251.448684809027, 12330.81503777462, 13692.726145477234, 13936.790948135584, 13945.023848330926, 11333.943330283295, 11569.537218511501, 11734.706632333919, 11867.287962722265, 12276.324802135969, 11068.557257709923, 11607.825882611598, 11968.820467692818, 11992.64022079339, 12076.154669173073], "value": 7496.981165275381, "unit": "score"}], "name": "dromaeo_css", "value": 7156.858038723134, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 114.0, 112.0, 110.0, 112.0, 109.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 119.0, 174.0, 119.0, 122.0, 157.0, 134.0, 154.0, 121.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 160.0, 161.0, 162.0, 159.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 130.0, 75.0, 76.0, 77.0, 76.0, 117.0, 75.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 121.0, 84.0, 84.0, 84.0, 120.0, 85.0, 95.0, 128.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 50.0, 50.0, 58.0, 50.0, 50.0, 48.0, 49.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 86.0, 82.0, 75.0, 76.0, 77.0, 76.0, 76.0, 76.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 119.0, 135.0, 124.0, 123.0, 120.0, 119.0, 120.0, 204.0, 128.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 164.0, 160.0, 159.0, 162.0, 158.0, 157.0, 155.0, 156.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 64.0, 63.0, 63.0, 67.0, 63.0, 62.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1489.6, "alertThreshold": 2.0}]} 23:26:54 INFO - Return code: 0 23:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:26:54 INFO - # TBPL SUCCESS # 23:26:54 INFO - Running post-action listener: _resource_record_post_action 23:26:54 INFO - [mozharness: 2016-08-04 06:26:54.255460Z] Finished run-tests step (success) 23:26:54 INFO - Running post-run listener: _resource_record_post_run 23:26:54 INFO - Total resource usage - Wall time: 1246s; CPU: 14.0%; Read bytes: 4096; Write bytes: 551178240; Read time: 8; Write time: 471492 23:26:54 INFO - TinderboxPrint: CPU usage
14.1% 23:26:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:26:54 INFO - TinderboxPrint: I/O write bytes / time
551,178,240 / 471,492 23:26:54 INFO - TinderboxPrint: CPU idle
8,539.4 (85.9%) 23:26:54 INFO - TinderboxPrint: CPU user
1,269.2 (12.8%) 23:26:54 INFO - TinderboxPrint: Swap in / out
0 / 0 23:26:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247681024; Read time: 0; Write time: 258352 23:26:54 INFO - run-tests - Wall time: 1229s; CPU: 14.0%; Read bytes: 0; Write bytes: 303075328; Read time: 0; Write time: 213068 23:26:54 INFO - Running post-run listener: _upload_blobber_files 23:26:54 INFO - Blob upload gear active. 23:26:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:54 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 23:26:54 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:26:54 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:26:55 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:56 INFO - (blobuploader) - INFO - Done attempting. 23:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:56 INFO - (blobuploader) - INFO - Done attempting. 23:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:27:00 INFO - (blobuploader) - INFO - Done attempting. 23:27:00 INFO - (blobuploader) - INFO - Iteration through files over. 23:27:00 INFO - Return code: 0 23:27:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:27:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:27:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8eb6ccdba865ab43a035feb5bfd89d9efa1f70b716083f6dedf0da0fd5694bc8795f1e4fbbb19c6c0e32a959dd2ab9ac5db410db8f70c7788a720a7f82ad5cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2862f0b459dcf95d4bacf6cf21307f651a243ed64644c81f691465b188c77a51f7e24425096c2d0d545683cee4f3158f470df66e6441302316aec5f618bc14a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/062ed908839b2bc5e8d91697314e7433d39602bdb2e378429eb85c9e6d759b90e69d0331abb463b2aa7036189593f5f8ccf9e82a03ade947f6b4dcdba099ce7b"} 23:27:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:27:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:27:00 INFO - Contents: 23:27:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8eb6ccdba865ab43a035feb5bfd89d9efa1f70b716083f6dedf0da0fd5694bc8795f1e4fbbb19c6c0e32a959dd2ab9ac5db410db8f70c7788a720a7f82ad5cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2862f0b459dcf95d4bacf6cf21307f651a243ed64644c81f691465b188c77a51f7e24425096c2d0d545683cee4f3158f470df66e6441302316aec5f618bc14a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/062ed908839b2bc5e8d91697314e7433d39602bdb2e378429eb85c9e6d759b90e69d0331abb463b2aa7036189593f5f8ccf9e82a03ade947f6b4dcdba099ce7b"} 23:27:00 INFO - Running post-run listener: copy_logs_to_upload_dir 23:27:00 INFO - Copying logs to upload dir... 23:27:00 INFO - mkdir: /builds/slave/test/build/upload/logs 23:27:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1297.023967 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-08-03 23:27:00.333420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 23:27:00.336978) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8eb6ccdba865ab43a035feb5bfd89d9efa1f70b716083f6dedf0da0fd5694bc8795f1e4fbbb19c6c0e32a959dd2ab9ac5db410db8f70c7788a720a7f82ad5cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2862f0b459dcf95d4bacf6cf21307f651a243ed64644c81f691465b188c77a51f7e24425096c2d0d545683cee4f3158f470df66e6441302316aec5f618bc14a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/062ed908839b2bc5e8d91697314e7433d39602bdb2e378429eb85c9e6d759b90e69d0331abb463b2aa7036189593f5f8ccf9e82a03ade947f6b4dcdba099ce7b"} build_url:https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/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/Fx-Team/sha512/8eb6ccdba865ab43a035feb5bfd89d9efa1f70b716083f6dedf0da0fd5694bc8795f1e4fbbb19c6c0e32a959dd2ab9ac5db410db8f70c7788a720a7f82ad5cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2862f0b459dcf95d4bacf6cf21307f651a243ed64644c81f691465b188c77a51f7e24425096c2d0d545683cee4f3158f470df66e6441302316aec5f618bc14a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/062ed908839b2bc5e8d91697314e7433d39602bdb2e378429eb85c9e6d759b90e69d0331abb463b2aa7036189593f5f8ccf9e82a03ade947f6b4dcdba099ce7b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 23:27:00.363350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:27:00.363759) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470289577.72081-1954739126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:27:00.449104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 23:27:00.449526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 23:27:00.449905) ========= ========= Total master_lag: 0.19 =========