builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1466605704.3 results: success (0) buildid: 20160622043110 builduid: 024d4dd2e17f4ce1b96411424cfb37ea revision: f96486bb6405877f4d8687325615562d4daa9290 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.297669) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.298162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.298458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.317588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.317896) ========= 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=33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 07:28:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-06-22 07:28:24 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182533 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.514217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.514558) ========= 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=33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019222 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.564741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:24.565102) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f96486bb6405877f4d8687325615562d4daa9290 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f96486bb6405877f4d8687325615562d4daa9290 --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=33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 07:28:24,831 truncating revision to first 12 chars 2016-06-22 07:28:24,831 Setting DEBUG logging. 2016-06-22 07:28:24,831 attempt 1/10 2016-06-22 07:28:24,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f96486bb6405?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 07:28:25,191 unpacking tar archive at: mozilla-inbound-f96486bb6405/testing/mozharness/ program finished with exit code 0 elapsedTime=0.735971 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:25.376955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:25.377236) ========= script_repo_revision: f96486bb6405877f4d8687325615562d4daa9290 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:25.377633) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:25.377906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 07:28:25.388276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-22 07:28:25.388585) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:25 INFO - MultiFileLogger online at 20160622 07:28:25 in /builds/slave/test 07:28:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:28:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:25 INFO - {'append_to_log': False, 07:28:25 INFO - 'base_work_dir': '/builds/slave/test', 07:28:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:28:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:25 INFO - 'branch': 'Mozilla-Inbound', 07:28:25 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:25 INFO - 'config_files': ('talos/linux_config.py',), 07:28:25 INFO - 'default_actions': ('clobber', 07:28:25 INFO - 'read-buildbot-config', 07:28:25 INFO - 'download-and-extract', 07:28:25 INFO - 'populate-webroot', 07:28:25 INFO - 'create-virtualenv', 07:28:25 INFO - 'install', 07:28:25 INFO - 'run-tests'), 07:28:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:25 INFO - 'download_minidump_stackwalk': True, 07:28:25 INFO - 'download_symbols': 'ondemand', 07:28:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:25 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:25 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:25 INFO - 'installer_path': 'installer.exe', 07:28:25 INFO - 'log_level': 'info', 07:28:25 INFO - 'log_name': 'talos', 07:28:25 INFO - 'log_to_console': True, 07:28:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:25 INFO - 'opt_config_files': (), 07:28:25 INFO - 'pip_index': False, 07:28:25 INFO - 'sps_profile': False, 07:28:25 INFO - 'sps_profile_interval': 0, 07:28:25 INFO - 'suite': 'dromaeojs', 07:28:25 INFO - 'system_bits': '32', 07:28:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:25 INFO - 'title': 'talos-linux64-ix-063', 07:28:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:25 INFO - 'use_talos_json': True, 07:28:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:25 INFO - 'work_dir': 'build'} 07:28:25 INFO - ##### 07:28:25 INFO - ##### Running clobber step. 07:28:25 INFO - ##### 07:28:25 INFO - Running pre-action listener: _resource_record_pre_action 07:28:25 INFO - Running main action method: clobber 07:28:25 INFO - rmtree: /builds/slave/test/build 07:28:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:26 INFO - Running post-action listener: _resource_record_post_action 07:28:26 INFO - ##### 07:28:26 INFO - ##### Finished clobber step (success) 07:28:26 INFO - ##### 07:28:26 INFO - ##### 07:28:26 INFO - ##### Running read-buildbot-config step. 07:28:26 INFO - ##### 07:28:26 INFO - Running pre-action listener: _resource_record_pre_action 07:28:26 INFO - Running main action method: read_buildbot_config 07:28:26 INFO - Using buildbot properties: 07:28:26 INFO - { 07:28:26 INFO - "project": "", 07:28:26 INFO - "product": "firefox", 07:28:26 INFO - "script_repo_revision": "production", 07:28:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:28:26 INFO - "repository": "", 07:28:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:28:26 INFO - "buildid": "20160622043110", 07:28:26 INFO - "pgo_build": "True", 07:28:26 INFO - "basedir": "/builds/slave/test", 07:28:26 INFO - "buildnumber": 1148, 07:28:26 INFO - "slavename": "talos-linux64-ix-063", 07:28:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:28:26 INFO - "platform": "ubuntu64_hw", 07:28:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:28:26 INFO - "branch": "mozilla-inbound", 07:28:26 INFO - "repo_path": "integration/mozilla-inbound", 07:28:26 INFO - "revision": "f96486bb6405877f4d8687325615562d4daa9290", 07:28:26 INFO - "stage_platform": "linux64-pgo", 07:28:26 INFO - "builduid": "024d4dd2e17f4ce1b96411424cfb37ea", 07:28:26 INFO - "slavebuilddir": "test" 07:28:26 INFO - } 07:28:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:28:26 INFO - Running post-action listener: _resource_record_post_action 07:28:26 INFO - ##### 07:28:26 INFO - ##### Finished read-buildbot-config step (success) 07:28:26 INFO - ##### 07:28:26 INFO - ##### 07:28:26 INFO - ##### Running download-and-extract step. 07:28:26 INFO - ##### 07:28:26 INFO - Running pre-action listener: _resource_record_pre_action 07:28:26 INFO - Running main action method: download_and_extract 07:28:26 INFO - mkdir: /builds/slave/test/build/tests 07:28:26 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')]} 07:28:26 INFO - https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:28:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:28:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:28:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:28:27 INFO - Downloaded 1361 bytes. 07:28:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:28:27 INFO - Using the following test package requirements: 07:28:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:28:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:27 INFO - u'jsshell-linux-x86_64.zip'], 07:28:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28:27 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')]} 07:28:27 INFO - https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:28 INFO - Downloaded 24226587 bytes. 07:28:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:28:30 INFO - Return code: 0 07:28:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:28:30 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')]} 07:28:30 INFO - https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:28:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:28:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:28:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:35 INFO - Downloaded 24226587 bytes. 07:28:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:28:36 INFO - Return code: 0 07:28:36 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')]} 07:28:36 INFO - https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:28:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:28:37 INFO - Downloaded 14405384 bytes. 07:28:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:28:38 INFO - Return code: 0 07:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:38 INFO - https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:28:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:28:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:28:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:28:40 INFO - Downloaded 60134662 bytes. 07:28:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:28:40 INFO - mkdir: /builds/slave/test/properties 07:28:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:28:40 INFO - Writing to file /builds/slave/test/properties/build_url 07:28:40 INFO - Contents: 07:28:40 INFO - build_url:https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:28:41 INFO - Running post-action listener: _resource_record_post_action 07:28:41 INFO - Running post-action listener: set_extra_try_arguments 07:28:41 INFO - ##### 07:28:41 INFO - ##### Finished download-and-extract step (success) 07:28:41 INFO - ##### 07:28:41 INFO - ##### 07:28:41 INFO - ##### Running populate-webroot step. 07:28:41 INFO - ##### 07:28:41 INFO - Running pre-action listener: _resource_record_pre_action 07:28:41 INFO - Running main action method: populate_webroot 07:28:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:28:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:28:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:28:41 INFO - '--tppagecycles', 07:28:41 INFO - '7'], 07:28:41 INFO - 'tests': ['tsvgm']}}, 07:28:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:28:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:28:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:28:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:28:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:41 INFO - 'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:41 INFO - 'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['damp', 'tps']}, 07:28:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:41 INFO - 'tests': ['damp', 'tps']}, 07:28:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['dromaeo_dom']}, 07:28:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:28:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['basic_compositor_video']}, 07:28:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:28:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['a11yr', 07:28:41 INFO - 'ts_paint', 07:28:41 INFO - 'tpaint', 07:28:41 INFO - 'sessionrestore', 07:28:41 INFO - 'sessionrestore_no_auto_restore', 07:28:41 INFO - 'tabpaint']}, 07:28:41 INFO - 'other-e10s': {'tests': ['a11yr', 07:28:41 INFO - 'ts_paint', 07:28:41 INFO - 'tpaint', 07:28:41 INFO - 'sessionrestore', 07:28:41 INFO - 'sessionrestore_no_auto_restore', 07:28:41 INFO - 'tabpaint']}, 07:28:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:28:41 INFO - 'ts_paint', 07:28:41 INFO - 'tpaint', 07:28:41 INFO - 'sessionrestore', 07:28:41 INFO - 'sessionrestore_no_auto_restore', 07:28:41 INFO - 'tabpaint']}, 07:28:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:28:41 INFO - 'ts_paint', 07:28:41 INFO - 'tpaint', 07:28:41 INFO - 'sessionrestore', 07:28:41 INFO - 'sessionrestore_no_auto_restore', 07:28:41 INFO - 'tabpaint']}, 07:28:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['a11yr', 07:28:41 INFO - 'ts_paint', 07:28:41 INFO - 'tpaint', 07:28:41 INFO - 'sessionrestore', 07:28:41 INFO - 'sessionrestore_no_auto_restore', 07:28:41 INFO - 'tabpaint']}, 07:28:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['a11yr', 07:28:41 INFO - 'ts_paint', 07:28:41 INFO - 'tpaint', 07:28:41 INFO - 'sessionrestore', 07:28:41 INFO - 'sessionrestore_no_auto_restore', 07:28:41 INFO - 'tabpaint']}, 07:28:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['tsvgx', 07:28:41 INFO - 'tsvgr_opacity', 07:28:41 INFO - 'tart', 07:28:41 INFO - 'tscrollx', 07:28:41 INFO - 'cart']}, 07:28:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:28:41 INFO - 'tsvgr_opacity', 07:28:41 INFO - 'tart', 07:28:41 INFO - 'tscrollx', 07:28:41 INFO - 'cart']}, 07:28:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:41 INFO - 'talos_options': ['--disable-e10s'], 07:28:41 INFO - 'tests': ['tp5o']}, 07:28:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:41 INFO - 'tests': ['tp5o']}, 07:28:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:41 INFO - 'talos_options': ['--disable-e10s', 07:28:41 INFO - '--xperf_path', 07:28:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:41 INFO - 'tests': ['tp5n']}, 07:28:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:41 INFO - 'talos_options': ['--xperf_path', 07:28:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:41 INFO - 'tests': ['tp5n']}}, 07:28:41 INFO - 'talos.zip': {'path': '', 07:28:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:28:41 INFO - Running post-action listener: _resource_record_post_action 07:28:41 INFO - ##### 07:28:41 INFO - ##### Finished populate-webroot step (success) 07:28:41 INFO - ##### 07:28:41 INFO - ##### 07:28:41 INFO - ##### Running create-virtualenv step. 07:28:41 INFO - ##### 07:28:41 INFO - Running pre-action listener: _resource_record_pre_action 07:28:41 INFO - Running main action method: create_virtualenv 07:28:41 INFO - Creating virtualenv /builds/slave/test/build/venv 07:28:41 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 07:28:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:28:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:28:41 INFO - Using real prefix '/usr' 07:28:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:28:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:28:43 INFO - Installing pip.................done. 07:28:43 INFO - Return code: 0 07:28:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:43 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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:28:43 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 07:28:43 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 07:28:43 INFO - Using env: {'DISPLAY': ':0', 07:28:43 INFO - 'HOME': '/home/cltbld', 07:28:43 INFO - 'LANG': 'en_US.UTF-8', 07:28:43 INFO - 'LANGUAGE': 'en_US:en', 07:28:43 INFO - 'LOGNAME': 'cltbld', 07:28:43 INFO - 'MAIL': '/var/mail/cltbld', 07:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:43 INFO - 'MOZ_NO_REMOTE': '1', 07:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:43 INFO - 'NO_EM_RESTART': '1', 07:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:43 INFO - 'PWD': '/builds/slave/test', 07:28:43 INFO - 'SHELL': '/bin/bash', 07:28:43 INFO - 'SHLVL': '1', 07:28:43 INFO - 'TERM': 'linux', 07:28:43 INFO - 'TMOUT': '86400', 07:28:43 INFO - 'USER': 'cltbld', 07:28:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:43 INFO - '_': '/tools/buildbot/bin/python'} 07:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:44 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 07:28:44 INFO - Cleaning up... 07:28:44 INFO - Return code: 0 07:28:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:44 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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:28:44 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 07:28:44 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 07:28:44 INFO - Using env: {'DISPLAY': ':0', 07:28:44 INFO - 'HOME': '/home/cltbld', 07:28:44 INFO - 'LANG': 'en_US.UTF-8', 07:28:44 INFO - 'LANGUAGE': 'en_US:en', 07:28:44 INFO - 'LOGNAME': 'cltbld', 07:28:44 INFO - 'MAIL': '/var/mail/cltbld', 07:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:44 INFO - 'MOZ_NO_REMOTE': '1', 07:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:44 INFO - 'NO_EM_RESTART': '1', 07:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:44 INFO - 'PWD': '/builds/slave/test', 07:28:44 INFO - 'SHELL': '/bin/bash', 07:28:44 INFO - 'SHLVL': '1', 07:28:44 INFO - 'TERM': 'linux', 07:28:44 INFO - 'TMOUT': '86400', 07:28:44 INFO - 'USER': 'cltbld', 07:28:44 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:44 INFO - '_': '/tools/buildbot/bin/python'} 07:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:44 INFO - Downloading/unpacking psutil>=3.1.1 07:28:44 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 07:28:44 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 07:28:44 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 07:28:44 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 07:28:44 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 07:28:44 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 07:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:46 INFO - Installing collected packages: psutil 07:28:46 INFO - Running setup.py install for psutil 07:28:46 INFO - building 'psutil._psutil_linux' extension 07:28:46 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 07:28:46 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 07:28:46 INFO - building 'psutil._psutil_posix' extension 07:28:46 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 07:28:46 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 07:28:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:46 INFO - Successfully installed psutil 07:28:46 INFO - Cleaning up... 07:28:46 INFO - Return code: 0 07:28:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:46 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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:28:46 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 07:28:46 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 07:28:46 INFO - Using env: {'DISPLAY': ':0', 07:28:46 INFO - 'HOME': '/home/cltbld', 07:28:46 INFO - 'LANG': 'en_US.UTF-8', 07:28:46 INFO - 'LANGUAGE': 'en_US:en', 07:28:46 INFO - 'LOGNAME': 'cltbld', 07:28:46 INFO - 'MAIL': '/var/mail/cltbld', 07:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:46 INFO - 'MOZ_NO_REMOTE': '1', 07:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:46 INFO - 'NO_EM_RESTART': '1', 07:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:46 INFO - 'PWD': '/builds/slave/test', 07:28:46 INFO - 'SHELL': '/bin/bash', 07:28:46 INFO - 'SHLVL': '1', 07:28:46 INFO - 'TERM': 'linux', 07:28:46 INFO - 'TMOUT': '86400', 07:28:46 INFO - 'USER': 'cltbld', 07:28:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:46 INFO - '_': '/tools/buildbot/bin/python'} 07:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:28:47 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 07:28:47 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 07:28:47 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 07:28:47 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 07:28:47 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 07:28:47 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 07:28:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:28:49 INFO - Installing collected packages: mozsystemmonitor 07:28:49 INFO - Running setup.py install for mozsystemmonitor 07:28:49 INFO - Successfully installed mozsystemmonitor 07:28:49 INFO - Cleaning up... 07:28:49 INFO - Return code: 0 07:28:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:49 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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:28:49 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 07:28:49 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 07:28:49 INFO - Using env: {'DISPLAY': ':0', 07:28:49 INFO - 'HOME': '/home/cltbld', 07:28:49 INFO - 'LANG': 'en_US.UTF-8', 07:28:49 INFO - 'LANGUAGE': 'en_US:en', 07:28:49 INFO - 'LOGNAME': 'cltbld', 07:28:49 INFO - 'MAIL': '/var/mail/cltbld', 07:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:49 INFO - 'MOZ_NO_REMOTE': '1', 07:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:49 INFO - 'NO_EM_RESTART': '1', 07:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:49 INFO - 'PWD': '/builds/slave/test', 07:28:49 INFO - 'SHELL': '/bin/bash', 07:28:49 INFO - 'SHLVL': '1', 07:28:49 INFO - 'TERM': 'linux', 07:28:49 INFO - 'TMOUT': '86400', 07:28:49 INFO - 'USER': 'cltbld', 07:28:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:49 INFO - '_': '/tools/buildbot/bin/python'} 07:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:49 INFO - Downloading/unpacking jsonschema==2.5.1 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:51 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:51 INFO - warning: no files found matching '*.txt' 07:28:51 INFO - no previously-included directories found matching 'build' 07:28:51 INFO - no previously-included directories found matching 'dist' 07:28:51 INFO - no previously-included directories found matching '.git*' 07:28:51 INFO - Installing collected packages: jsonschema, functools32 07:28:51 INFO - Running setup.py install for functools32 07:28:51 INFO - warning: no files found matching '*.txt' 07:28:51 INFO - no previously-included directories found matching 'build' 07:28:51 INFO - no previously-included directories found matching 'dist' 07:28:51 INFO - no previously-included directories found matching '.git*' 07:28:51 INFO - Successfully installed jsonschema functools32 07:28:51 INFO - Cleaning up... 07:28:51 INFO - Return code: 0 07:28:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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', '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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:28: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 blobuploader==1.2.4 07:28:51 INFO - Using env: {'DISPLAY': ':0', 07:28:51 INFO - 'HOME': '/home/cltbld', 07:28:51 INFO - 'LANG': 'en_US.UTF-8', 07:28:51 INFO - 'LANGUAGE': 'en_US:en', 07:28:51 INFO - 'LOGNAME': 'cltbld', 07:28:51 INFO - 'MAIL': '/var/mail/cltbld', 07:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:51 INFO - 'MOZ_NO_REMOTE': '1', 07:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:51 INFO - 'NO_EM_RESTART': '1', 07:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:51 INFO - 'PWD': '/builds/slave/test', 07:28:51 INFO - 'SHELL': '/bin/bash', 07:28:51 INFO - 'SHLVL': '1', 07:28:51 INFO - 'TERM': 'linux', 07:28:51 INFO - 'TMOUT': '86400', 07:28:51 INFO - 'USER': 'cltbld', 07:28:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:51 INFO - '_': '/tools/buildbot/bin/python'} 07:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:51 INFO - Downloading/unpacking blobuploader==1.2.4 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:53 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:53 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 07:28:53 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 07:28:53 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 07:28:53 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 07:28:53 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 07:28:53 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 07:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:54 INFO - Downloading docopt-0.6.1.tar.gz 07:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:54 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:54 INFO - Running setup.py install for blobuploader 07:28:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:54 INFO - Running setup.py install for requests 07:28:55 INFO - Running setup.py install for docopt 07:28:55 INFO - Successfully installed blobuploader requests docopt 07:28:55 INFO - Cleaning up... 07:28:55 INFO - Return code: 0 07:28:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:55 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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:28:55 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 07:28:55 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 07:28:55 INFO - Using env: {'DISPLAY': ':0', 07:28:55 INFO - 'HOME': '/home/cltbld', 07:28:55 INFO - 'LANG': 'en_US.UTF-8', 07:28:55 INFO - 'LANGUAGE': 'en_US:en', 07:28:55 INFO - 'LOGNAME': 'cltbld', 07:28:55 INFO - 'MAIL': '/var/mail/cltbld', 07:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:55 INFO - 'MOZ_NO_REMOTE': '1', 07:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:55 INFO - 'NO_EM_RESTART': '1', 07:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:55 INFO - 'PWD': '/builds/slave/test', 07:28:55 INFO - 'SHELL': '/bin/bash', 07:28:55 INFO - 'SHLVL': '1', 07:28:55 INFO - 'TERM': 'linux', 07:28:55 INFO - 'TMOUT': '86400', 07:28:55 INFO - 'USER': 'cltbld', 07:28:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:55 INFO - '_': '/tools/buildbot/bin/python'} 07:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:55 INFO - Running setup.py (path:/tmp/pip-WjnQsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:55 INFO - Running setup.py (path:/tmp/pip-weobIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:55 INFO - Running setup.py (path:/tmp/pip-XK91Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:55 INFO - Running setup.py (path:/tmp/pip-jCSzWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:55 INFO - Running setup.py (path:/tmp/pip-VeharL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:55 INFO - Running setup.py (path:/tmp/pip-RVNC2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:55 INFO - Running setup.py (path:/tmp/pip-HiJiDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:55 INFO - Running setup.py (path:/tmp/pip-a98tx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:56 INFO - Running setup.py (path:/tmp/pip-iBdBWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:56 INFO - Running setup.py (path:/tmp/pip-8GGXz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:56 INFO - Running setup.py (path:/tmp/pip-yvL0nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:56 INFO - Running setup.py (path:/tmp/pip-oqTOTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:56 INFO - Running setup.py (path:/tmp/pip-WCHeZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:56 INFO - Running setup.py (path:/tmp/pip-07SAMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:56 INFO - Running setup.py (path:/tmp/pip-6KpWGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:56 INFO - Running setup.py (path:/tmp/pip-4tpj1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:56 INFO - Running setup.py (path:/tmp/pip-Az_PcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:56 INFO - Running setup.py install for manifestparser 07:28:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:56 INFO - Running setup.py install for mozcrash 07:28:56 INFO - Running setup.py install for mozdebug 07:28:56 INFO - Running setup.py install for mozdevice 07:28:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Running setup.py install for mozfile 07:28:57 INFO - Running setup.py install for mozhttpd 07:28:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Running setup.py install for mozinfo 07:28:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Running setup.py install for mozInstall 07:28:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Running setup.py install for mozleak 07:28:57 INFO - Running setup.py install for mozlog 07:28:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Running setup.py install for moznetwork 07:28:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:57 INFO - Running setup.py install for mozprocess 07:28:57 INFO - Running setup.py install for mozprofile 07:28:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:58 INFO - Running setup.py install for mozrunner 07:28:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:58 INFO - Running setup.py install for mozscreenshot 07:28:58 INFO - Running setup.py install for moztest 07:28:58 INFO - Running setup.py install for mozversion 07:28:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:58 INFO - Cleaning up... 07:28:58 INFO - Return code: 0 07:28:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:58 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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:28:58 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 07:28:58 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 07:28:58 INFO - Using env: {'DISPLAY': ':0', 07:28:58 INFO - 'HOME': '/home/cltbld', 07:28:58 INFO - 'LANG': 'en_US.UTF-8', 07:28:58 INFO - 'LANGUAGE': 'en_US:en', 07:28:58 INFO - 'LOGNAME': 'cltbld', 07:28:58 INFO - 'MAIL': '/var/mail/cltbld', 07:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:58 INFO - 'MOZ_NO_REMOTE': '1', 07:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:58 INFO - 'NO_EM_RESTART': '1', 07:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:58 INFO - 'PWD': '/builds/slave/test', 07:28:58 INFO - 'SHELL': '/bin/bash', 07:28:58 INFO - 'SHLVL': '1', 07:28:58 INFO - 'TERM': 'linux', 07:28:58 INFO - 'TMOUT': '86400', 07:28:58 INFO - 'USER': 'cltbld', 07:28:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:58 INFO - '_': '/tools/buildbot/bin/python'} 07:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:58 INFO - Running setup.py (path:/tmp/pip-on6RND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:58 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)) 07:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:58 INFO - Running setup.py (path:/tmp/pip-5SKfEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:58 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)) 07:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:58 INFO - Running setup.py (path:/tmp/pip-bWXXeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:58 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)) 07:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:58 INFO - Running setup.py (path:/tmp/pip-7LVGK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:59 INFO - Running setup.py (path:/tmp/pip-pHXkG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:59 INFO - Running setup.py (path:/tmp/pip-WvBgpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:59 INFO - Running setup.py (path:/tmp/pip-ygxM6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:59 INFO - Running setup.py (path:/tmp/pip-bBkvZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:59 INFO - Running setup.py (path:/tmp/pip-V5sCyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:59 INFO - Running setup.py (path:/tmp/pip-3n7kx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:59 INFO - Running setup.py (path:/tmp/pip-dhilUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:59 INFO - Running setup.py (path:/tmp/pip-fMsgqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:59 INFO - Running setup.py (path:/tmp/pip-Ao1WwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:59 INFO - Running setup.py (path:/tmp/pip-KgYNKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:59 INFO - Running setup.py (path:/tmp/pip-SlFwMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:59 INFO - Running setup.py (path:/tmp/pip-zYZsyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:59 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)) 07:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:59 INFO - Running setup.py (path:/tmp/pip-EOLZC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:59 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)) 07:28:59 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)) 07:28:59 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)) 07:28:59 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)) 07:28:59 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)) 07:28:59 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)) 07:28:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:29:01 INFO - Downloading blessings-1.6.tar.gz 07:29:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:01 INFO - Installing collected packages: blessings 07:29:01 INFO - Running setup.py install for blessings 07:29:02 INFO - Successfully installed blessings 07:29:02 INFO - Cleaning up... 07:29:02 INFO - Return code: 0 07:29:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:02 INFO - Reading from file tmpfile_stdout 07:29:02 INFO - Current package versions: 07:29:02 INFO - argparse == 1.2.1 07:29:02 INFO - blessings == 1.6 07:29:02 INFO - blobuploader == 1.2.4 07:29:02 INFO - docopt == 0.6.1 07:29:02 INFO - functools32 == 3.2.3-2 07:29:02 INFO - jsonschema == 2.5.1 07:29:02 INFO - manifestparser == 1.1 07:29:02 INFO - mozInstall == 1.12 07:29:02 INFO - mozcrash == 0.17 07:29:02 INFO - mozdebug == 0.1 07:29:02 INFO - mozdevice == 0.48 07:29:02 INFO - mozfile == 1.2 07:29:02 INFO - mozhttpd == 0.7 07:29:02 INFO - mozinfo == 0.9 07:29:02 INFO - mozleak == 0.1 07:29:02 INFO - mozlog == 3.2 07:29:02 INFO - moznetwork == 0.27 07:29:02 INFO - mozprocess == 0.22 07:29:02 INFO - mozprofile == 0.28 07:29:02 INFO - mozrunner == 6.11 07:29:02 INFO - mozscreenshot == 0.1 07:29:02 INFO - mozsystemmonitor == 0.3 07:29:02 INFO - moztest == 0.7 07:29:02 INFO - mozversion == 1.4 07:29:02 INFO - psutil == 3.1.1 07:29:02 INFO - requests == 1.2.3 07:29:02 INFO - wsgiref == 0.1.2 07:29:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:02 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')]} 07:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:02 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')]} 07:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:02 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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:29:02 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 07:29:02 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 07:29:02 INFO - Using env: {'DISPLAY': ':0', 07:29:02 INFO - 'HOME': '/home/cltbld', 07:29:02 INFO - 'LANG': 'en_US.UTF-8', 07:29:02 INFO - 'LANGUAGE': 'en_US:en', 07:29:02 INFO - 'LOGNAME': 'cltbld', 07:29:02 INFO - 'MAIL': '/var/mail/cltbld', 07:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:02 INFO - 'MOZ_NO_REMOTE': '1', 07:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:02 INFO - 'NO_EM_RESTART': '1', 07:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:02 INFO - 'PWD': '/builds/slave/test', 07:29:02 INFO - 'SHELL': '/bin/bash', 07:29:02 INFO - 'SHLVL': '1', 07:29:02 INFO - 'TERM': 'linux', 07:29:02 INFO - 'TMOUT': '86400', 07:29:02 INFO - 'USER': 'cltbld', 07:29:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:02 INFO - '_': '/tools/buildbot/bin/python'} 07:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 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)) 07:29:02 INFO - Cleaning up... 07:29:02 INFO - Return code: 0 07:29:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:29:02 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')]} 07:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:02 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')]} 07:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:02 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 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:29:02 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 07:29:02 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 07:29:02 INFO - Using env: {'DISPLAY': ':0', 07:29:02 INFO - 'HOME': '/home/cltbld', 07:29:02 INFO - 'LANG': 'en_US.UTF-8', 07:29:02 INFO - 'LANGUAGE': 'en_US:en', 07:29:02 INFO - 'LOGNAME': 'cltbld', 07:29:02 INFO - 'MAIL': '/var/mail/cltbld', 07:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:02 INFO - 'MOZ_NO_REMOTE': '1', 07:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:02 INFO - 'NO_EM_RESTART': '1', 07:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:02 INFO - 'PWD': '/builds/slave/test', 07:29:02 INFO - 'SHELL': '/bin/bash', 07:29:02 INFO - 'SHLVL': '1', 07:29:02 INFO - 'TERM': 'linux', 07:29:02 INFO - 'TMOUT': '86400', 07:29:02 INFO - 'USER': 'cltbld', 07:29:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:02 INFO - '_': '/tools/buildbot/bin/python'} 07:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:29:02 INFO - Cleaning up... 07:29:02 INFO - Return code: 0 07:29:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:29:02 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')]} 07:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:02 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')]} 07:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89603eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, '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': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', '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 07:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:29:02 INFO - Using env: {'DISPLAY': ':0', 07:29:02 INFO - 'HOME': '/home/cltbld', 07:29:02 INFO - 'LANG': 'en_US.UTF-8', 07:29:02 INFO - 'LANGUAGE': 'en_US:en', 07:29:02 INFO - 'LOGNAME': 'cltbld', 07:29:02 INFO - 'MAIL': '/var/mail/cltbld', 07:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:02 INFO - 'MOZ_NO_REMOTE': '1', 07:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:02 INFO - 'NO_EM_RESTART': '1', 07:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:02 INFO - 'PWD': '/builds/slave/test', 07:29:02 INFO - 'SHELL': '/bin/bash', 07:29:02 INFO - 'SHLVL': '1', 07:29:02 INFO - 'TERM': 'linux', 07:29:02 INFO - 'TMOUT': '86400', 07:29:02 INFO - 'USER': 'cltbld', 07:29:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:02 INFO - '_': '/tools/buildbot/bin/python'} 07:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:02 INFO - Downloading/unpacking flake8 07:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:29:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:29:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:29:05 INFO - no previously-included directories found matching 'docs/_build' 07:29:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:29:05 INFO - Running setup.py install for pep8 07:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:29:05 INFO - no previously-included directories found matching 'docs/_build' 07:29:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:29:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:29:05 INFO - Cleaning up... 07:29:05 INFO - Return code: 0 07:29:05 INFO - Running post-action listener: _resource_record_post_action 07:29:05 INFO - Running post-action listener: _start_resource_monitoring 07:29:05 INFO - Starting resource monitoring. 07:29:05 INFO - ##### 07:29:05 INFO - ##### Finished create-virtualenv step (success) 07:29:05 INFO - ##### 07:29:05 INFO - ##### 07:29:05 INFO - ##### Running install step. 07:29:05 INFO - ##### 07:29:05 INFO - Running pre-action listener: _resource_record_pre_action 07:29:05 INFO - Running main action method: install 07:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:06 INFO - Reading from file tmpfile_stdout 07:29:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:06 INFO - Reading from file tmpfile_stdout 07:29:06 INFO - Output received: 07:29:06 INFO - Usage: mozinstall [options] installer 07:29:06 INFO - Options: 07:29:06 INFO - -h, --help show this help message and exit 07:29:06 INFO - -d DEST, --destination=DEST 07:29:06 INFO - Directory to install application into. [default: 07:29:06 INFO - "/builds/slave/test"] 07:29:06 INFO - --app=APP Application being installed. [default: firefox] 07:29:06 INFO - mkdir: /builds/slave/test/build/application 07:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:29:32 INFO - Reading from file tmpfile_stdout 07:29:34 INFO - Output received: 07:29:34 INFO - /builds/slave/test/build/application/firefox/firefox 07:29:34 INFO - Running post-action listener: _resource_record_post_action 07:29:34 INFO - ##### 07:29:34 INFO - ##### Finished install step (success) 07:29:34 INFO - ##### 07:29:34 INFO - ##### 07:29:34 INFO - ##### Running run-tests step. 07:29:34 INFO - ##### 07:29:34 INFO - Running pre-action listener: _resource_record_pre_action 07:29:34 INFO - Running main action method: run_tests 07:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:29:34 INFO - Python 2.7.3 07:29:34 INFO - Return code: 0 07:29:34 INFO - grabbing minidump binary from tooltool 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:34 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 0x1aece20>, '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 0x1af03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af0830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:29:34 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 07:29:34 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 07:29:34 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 07:29:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:34 INFO - Return code: 0 07:29:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:29:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:29:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:29:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:29:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:29:35 INFO - Return code: 0 07:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 07:29:35 INFO - Using env: {'DISPLAY': ':0', 07:29:35 INFO - 'HOME': '/home/cltbld', 07:29:35 INFO - 'LANG': 'en_US.UTF-8', 07:29:35 INFO - 'LANGUAGE': 'en_US:en', 07:29:35 INFO - 'LOGNAME': 'cltbld', 07:29:35 INFO - 'MAIL': '/var/mail/cltbld', 07:29:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:35 INFO - 'MOZ_NO_REMOTE': '1', 07:29:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:35 INFO - 'NO_EM_RESTART': '1', 07:29:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:35 INFO - 'PWD': '/builds/slave/test', 07:29:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:35 INFO - 'SHELL': '/bin/bash', 07:29:35 INFO - 'SHLVL': '1', 07:29:35 INFO - 'TERM': 'linux', 07:29:35 INFO - 'TMOUT': '86400', 07:29:35 INFO - 'USER': 'cltbld', 07:29:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924', 07:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:35 INFO - '_': '/tools/buildbot/bin/python'} 07:29:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:29:35 INFO - mozversion application_buildid: 20160622043110 07:29:35 INFO - mozversion application_changeset: f96486bb6405877f4d8687325615562d4daa9290 07:29:35 INFO - mozversion application_display_name: Nightly 07:29:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:35 INFO - mozversion application_name: Firefox 07:29:35 INFO - mozversion application_remotingname: firefox 07:29:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:29:35 INFO - mozversion application_vendor: Mozilla 07:29:35 INFO - mozversion application_version: 50.0a1 07:29:35 INFO - mozversion platform_buildid: 20160622043110 07:29:35 INFO - mozversion platform_changeset: f96486bb6405877f4d8687325615562d4daa9290 07:29:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:29:35 INFO - mozversion platform_version: 50.0a1 07:29:35 INFO - using testdate: 1466605775 07:29:35 INFO - actual date: 1466605775 07:29:35 INFO - starting webserver on 'localhost:38488' 07:29:35 INFO - SUITE-START | Running 2 tests 07:29:35 INFO - TEST-START | dromaeo_css 07:29:35 INFO - operating with platform_type : linux_ 07:29:35 INFO - Initialising browser for dromaeo_css test... 07:29:35 INFO - TEST-INFO | started process 4654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyd7HhC/profile http://localhost:38488/getInfo.html) 07:29:42 INFO - PROCESS | 4654 | __metrics Screen width/height:1600/1200 07:29:42 INFO - PROCESS | 4654 | colorDepth:24 07:29:42 INFO - PROCESS | 4654 | Browser inner width/height: 1024/697 07:29:42 INFO - PROCESS | 4654 | __metrics 07:29:44 INFO - PROCESS | 4654 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:45 INFO - PROCESS | 4654 | console.error: PushService: 07:29:45 INFO - PROCESS | 4654 | stateChangeProcessEnqueue: Error transitioning state 07:29:45 INFO - PROCESS | 4654 | UnknownError 07:29:46 INFO - TEST-INFO | 4654: exit 0 07:29:46 INFO - Browser initialized. 07:29:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:29:46 INFO - TEST-INFO | started process 4740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyd7HhC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:58 INFO - PROCESS | 4740 | RSS: Main: 174329856 07:29:58 INFO - PROCESS | 4740 | 07:30:48 INFO - PROCESS | 4740 | 1466605848797 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] 07:32:58 INFO - PROCESS | 4740 | Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38488/tests/dromaeo/cssquery-ext.html) 07:32:59 INFO - PROCESS | 4740 | RSS: Main: 307085312 07:32:59 INFO - PROCESS | 4740 | 07:36:02 INFO - PROCESS | 4740 | Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-ext.html (next: http://localhost:38488/tests/dromaeo/cssquery-jquery.html) 07:36:02 INFO - PROCESS | 4740 | RSS: Main: 252510208 07:36:02 INFO - PROCESS | 4740 | 07:39:04 INFO - PROCESS | 4740 | Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38488/tests/dromaeo/cssquery-mootools.html) 07:39:05 INFO - PROCESS | 4740 | RSS: Main: 257282048 07:39:05 INFO - PROCESS | 4740 | 07:42:07 INFO - PROCESS | 4740 | Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38488/tests/dromaeo/cssquery-prototype.html) 07:42:08 INFO - PROCESS | 4740 | RSS: Main: 252076032 07:42:08 INFO - PROCESS | 4740 | 07:45:10 INFO - PROCESS | 4740 | Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38488/tests/dromaeo/cssquery-yui.html) 07:45:11 INFO - PROCESS | 4740 | RSS: Main: 241414144 07:45:11 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | Cycle 1(1): loaded http://localhost:38488/tests/dromaeo/cssquery-yui.html (next: http://localhost:38488/tests/dromaeo/cssquery-dojo.html) 07:48:14 INFO - PROCESS | 4740 | RSS: Main: 306573312 07:48:14 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | __start_tp_report 07:48:14 INFO - PROCESS | 4740 | _x_x_mozilla_page_load 07:48:14 INFO - PROCESS | 4740 | _x_x_mozilla_page_load_details 07:48:14 INFO - PROCESS | 4740 | |i|pagename|runs| 07:48:14 INFO - PROCESS | 4740 | |0;dojo.html;3064.4483992881287;3087.1201707513355;3112.9066128016166;3116.3455674308393;3143.119926420603;5183.611229157819;5248.816291429801;5284.207368894663;5383.542398896094;5421.566274698024;5344.278522399475;5345.893082138355;5404.486573775494;5456.48163424474;5511.173324001392;4849.587785038276;4874.707517548941;4901.779419926112;4977.5022497750115;4986.900261994758;4907.067657145149;4958.652894297401;5068.315777370063;5072.137736584789;5074.391073071237;4730.905381892378;4949.752512374403;4954.455009948902;4981.850544483671;5011.248312753098;4752.52474752522;4830.396200474941;4839;4854.101991131617;4865.245886887538;4806.49531799163;4895.2167653175675;4897.363342765453;4903.411590609114;4946.851594452172;5175.404828444739;5300.151975683911;5351.866203344947;5353.0899747043095;5408.161734931092;5658.0381335173115;5793.4785869271545;5796.652200867961;5798.3911689272445;5810.070388737824;5752.424757524214;5833.066709326487;5843.5325173985975;5844.824655260349;5845.824625261249;5171.663841850268;5303.522682958553;5357.035733567917;5387.057264978613;5414.972925135388;5882.058870580687;5891.941080589225;5901.17383566301;5902.026165682701;5905.616134951214;5608.018596745554;5679.119736440858;5680.602357834912;5683.943160568341;5688.971555142198;5466.1527463243265;5697.3448053474385;5733.942660573424;5864.67744274069;5874.882502350015;5708.600397972185;5719.542436605062;5748.19525266463;5766.365699773021;5789.363170051291;5680.091185410397;5714.657120572779;5721.971390143022;5728.05487094633;5746.913796293059;4205.285101532686;4250.404943307939;4293.2272191005295;4342.609165175149;4344.695871288979;3873.3802591585213;3875.186210895687;3886.6113388660906;3911.6675082618294;3920.3923391874305;5356.196570514376;5372.892542149213;5374.086405311106;5374.677519348774;5386.91919621206;5549.084401073858;5626.887462250732;5638.154276858504;5649.096144616841;5678.5741069419955;5319.707416092152;5330.893382132335;5335.466453354634;5344.893102138013;5358;4710.434747830213;4768.189407800683;4770.570648641639;4782;4798.04039192163;5842.941570584325;5890.440408161217;5894.705264736746;5927.2590926134235;5945.762169513171;5694.088945768657;5731.455511726379;5776.595638305278;5787.479126878601;5789.797357092481;5625.718714064198;5778.508826749773;5786.450287222707;5794.4205579443405;5799.94200057994;5531.695756733257;5606;5608.887822243614;5609.943900560942;5650.6327088740745;5718.170865224436;5734.3692193857805;5742.712864356682;5747.4252574742195;5748.741306641127;5394.649347792538;5530.419305972976;5561.777528898799;5602.831915042555;5662.85842853932;5598.21624972496;5607.943920560905;5611.691356975405;5623.100303951348;5677.318721753416;5470.91793623104;5497.175423686319;5535.501804837423;5536;5541.196526503554;5394.973025134849;5436.972815136057;5500.642458240201;5568.248286481273;5642.7460764266525;5358.517733404013;5477.972610136924;5504;5509.311336082989;5564.4713752193475 07:48:14 INFO - PROCESS | 4740 | |1;ext.html;563.5970281248906;622.3403192615827;626.5645376463358;635.1711017122655;639.7792761497282;30381.69618303819;33667.66332336676;33671.831640841825;33679.32641347172;33775.986720398425;33650.32699346018;42972.57027429732;44275.557244427546;44291.33562996558;49020;8897.911020889773;9055.366124371296;9062.909370906305;9070.183683468487;9076.909230907706;8158.347332213439;8815.250703690162;8910.376273660846;8914.108589141098;8916.331275154356;10658.413787241698;10928.071113955324;10939.671809845717;11268.887311126908;11296.943515282412;10805.459727013656;10873.238873278873;10879.912008799136;10886.564537418493;10886.836697449544;8083.110857805636;10416.166706663449;10450.790984180274;10653.946730266376;10824.512896919658;38943;43393;43404.34893476601;43404.56595434037;43454.34818477726;3612;3625.419932810764;3644;3691.5201023866725;3973.3443981742976;32519.187020324443;32701.345973080643;33923;33961.830190849134;34541.481877771854;4417.2269852775635;4440.378347031418;4444;4482.327650852366;4683.695559788603;348982;349292;349301;349500.99999999744;349567;61199.694001530595;61319;61771.691141544004;61801;61803.38196618066;66802;66989.33010669929;67126.32873671298;67160.32839671639;67214.66392668104;16521.173941302888;17192;17222;17228.138593070296;17235.91382043082;12871.871281287255;13044.282564458856;13056;13058.542950996669;13078.803817942548;18014.5496362592;18928.24287028531;19112.23551057942;19400.288123090926;20449.795502045086;6912.723491060402;6996.6851491683;7045.8238544035785;7120.323569260912;7252.2385149559595;959.4291396619001;982.94102353859;1046.8011077895176;1114.5207560748956;1148.0356500539588;31542.684573153976;31666.683333166835;31920;32118.67881321157;32361.51457728136;1089.4716062709579;1110.6445937299986;1126.3354620773782;1143.3768596115137;1155.3760969076773;15778.68442631164;16575.17124143812;16724.414645487348;16775.91612041932;16852.662946740995;564375;567585.9724208198;569161;569305;569653;58595.12107318394;60112.69943650254;60116;60148;60150.39849601448;1245.2777389114292;1308.2542950518305;1314.5267703626878;1345.8115863779078;1384.563862383346;31259.687403125678;33005.17487062843;33319.66680333263;33429.16427089245;33833.3233335327;50110.24834627411;50653.74673126758;50771.74614126905;50898.23652645287;50941.745291273306;428548;440131;440850;441229;441357;25108.74891251064;27498.17505474839;27944.44111117807;28222;30082.69917300799;46532.30201547047;46963.530364695915;47148.52851471442;48104;48413.273800893716;39691.80154099211;40976.590234097275;41001.17997639971;41433.58566414418;42230.78884605557;40522.59477405306;41136.79431602823;41508.377374340016;41567.58432415637;41890;40467.3929891046;40905;41213.58786412217;41752.79123604484;41873.58126418697;34785.82607086949;36562.45156322604;36747.26505469822;37420.43869342017;37560.43659345058;27651.585226222025;27709.58435623427;27769.58345624777;27914.860425698553;27938.72061279361 07:48:14 INFO - PROCESS | 4740 | |2;jquery.html;363.4584469140981;373.7271791592138;380.5452484281285;383.38083994349097;394.58174335204683;18169.545761355956;18698.813011869875;19842.107105180265;19846.503837404038;19852.40442786715;11677.766444671102;12037.51849926004;12091.274523528595;12217.144799864012;12223.266604003766;5201.141811601091;5481.616286859901;5489.313835770528;5489.39616642169;5490.670559766407;3909.4526766252748;5650.265465489501;5972.283326000886;5976.432238937294;6080.969595152018;5572.5263352615075;5990.940090599103;6020.969895150518;6075.301340345851;6087.421694938996;5924.970375148118;6020.096985452174;6055.969720151371;6056.152138700563;6057.606255593394;3720.683741881943;5497.422770609109;5819.156222347736;5831.88336233273;5920.111983202511;13806.861931380658;13862.792058119136;13946.23295718735;14023.85976140246;14200.076994995292;2335.8948847301913;2343.6601692754625;2618.711941686413;2652.4827658606578;2975.1372102090368;9579.329446938717;9941.683418585668;10344.32761870476;10512.421816800073;10536.47317634123;1876.3245231716571;1894.4695485264149;1939.7963213862624;1950.5903760210372;1965.4202010406964;77909.22090779076;78579.60710196412;78984;79380;81040.18959810385;10534.789304213873;10688.732781680364;10837.67486975392;10959.287646302964;11143.609973650884;14927.925360373129;14987.625309367353;15035;15049.473268435551;15061.096334219981;7606.847863042708;7700.807479813049;7723.65243564041;7800.687972481037;7876.054873415227;7572.242775722384;7587.810304742316;7635.274648908345;7840.647170877324;7872.84254314922;4520.660950428731;4570.360149579062;4603.378543896598;4610.723356598614;4746.525347465225;1813.9727904081449;1835.0818609982698;2003.1286390420214;2018.4651067467132;2053.5995480881384;887.3078998381272;919.8540102667587;973.5278389980854;1023.81059503992;1037.9532921018572;18556.721649175273;18749.90625046866;18771;18934.147963341406;19382.321618743277;977.6089564174387;1016.1464369929295;1068.0707784227773;1076.5209481780532;1091.497910960951;10457.581696732046;10781.676549703521;10814.405207713651;10925.180611454014;10950.507227174796;339294;341316;345040;468741;474925;92516.53741731249;101723;103486;103489;103553;951.471933077135;965.4062751407834;1008.4907121903392;1060.3955745225148;1062.4581463453694;16285.918570407546;17081.31674732997;17212.225449855036;17237.74143387825;18370.448886533424;41809.16381672289;42177.78911105425;42241.15517689691;42863.571364285955;43260.567394325655;56858.7157064212;58152;58328.70835645965;59154.40845591489;59201.15192512473;8762.342824288076;8916.955415222883;9071.138241867013;9101.453912765255;9155.313351498531;10290.742731431774;12819.8462138408;13624.86375136236;13649.181049137083;14189.787153192918;11223.326600403676;11817.350045747566;11963.162578619413;12137.635870923887;12489.937550312554;9477.95261023718;11914.880851191378;11990.700232494257;12495.125341226027;12504.187227830162;12102.939485302517;12236.08229382782;12431.502739890304;12625.368731563569;12913.09608327408;8509;8667.566621669017;8770.342224333328;8852.424592401474;9017.278617710435;8833.160849719266;12045.33750643688;12543.87456125427;12590.622281331574;12695.55565555201 07:48:14 INFO - PROCESS | 4740 | |3;mootools.html;1364.6724786051338;1463.656040830405;1493.5444689369742;1610.6617610301837;1794.8474379677727;8432.578371081445;8813.559322033896;8814.162654547823;9127.908720912805;9147.77130571736;8893.510856902867;9047.592858321375;9146.496942668151;9153.22197613202;9161.45031298121;2334.9883250583725;2361.681173041643;2361.9409514762096;2364.125273648752;2364.3498038039593;2315.9768402316013;2371.1819422299277;2379.202967006055;2388.4028992751814;2394.9640755388596;2284.7715228477105;2298.643710224918;2313.7223533175957;2315.4674424882287;2336.19401306549;2298.448372390614;2302.2172461363134;2318.733345665253;2332.463533387322;2335.871527066019;2236.5079682469996;2241.0251540579898;2242.237639202679;2242.3609271357586;2255.3008567344013;8903.73288801337;9107;9184.357095003352;9186.632534698603;9240.306976976754;5167.509086636764;5279.815206467755;5282.577393808525;5293.788248470057;5297.549708274802;3266.167127382526;3301.669833016679;3341.248219150696;3349.129226401153;3376.763626546143;1046.8063408269495;1053.257453495284;1053.7365658585354;1059.3167407022427;1076.1767248055244;12646.74706505874;12819.102662813606;12833.935830320788;12842.357882105951;12848.743025139538;4316.827326906951;4334.241507736134;4380.3210502372185;4401;4401.427814384109;9961.850572241423;9992.950035249924;9999.150072243796;9999.50002499872;10014.749631259278;5104.03023425548;5106.285120083191;5113.437521872591;5113.846584602468;5124.615653825978;4177.101923086551;4687.81248750053;4734.573888350065;4865.245886887538;4905.950940490621;3746.887593372149;3771.113788259757;3834.69322454203;3878.9224215515533;3885.0675837798726;1108.2906939558688;1112.9666110016713;1119.7368618374676;1122.0911062039775;1129.717570607348;638.7061951502268;856.4732689396101;923.4874644572327;941.6186444489992;961.7980224153006;5560.77756889728;5843.620164689281;5929.525637948954;5976.731047102804;6084.269887613426;484.84727310896955;485.5654189500377;651.2770824384929;976.2775546095838;1041.7812259425605;4075.918481630351;4111;4149.668026557868;4175.164967006611;4179.6029377209115;11073.224874258725;11256.774864502664;11277.71805704864;11348.375839328752;11455.713607159722;10196.745081373025;10221.437820919771;10359;10935.28920620157;10957.83563246552;8086.353091752646;8153.796155096052;8245.175482451827;8253.380996425292;8277.710280140287;6026.306974697965;6040.607360521552;6071.696415179312;6103.08453731926;6183.3816618337805;10404.635837745642;10432.68701938943;10506.632267870587;10539.525721342405;10541.367517948947;10303.175745940456;10339.483025848527;10483.79032419332;10745.946270268598;10761.139108871115;7073.257307982588;7907.130215676386;8120.796980075545;8131.349492040741;8289.544075075928;8683.435576687496;8715.084916083973;8724.302055835646;8806.163414475615;8807.647694092164;7790.88313675284;7823.921760782319;7903.170167132368;8092.069412017693;8127.349812014906;7202.639868006683;7613.885791713018;7728.072631284282;7848.411369147451;7894.342188140555;6818.386345228953;7034.683439245348;7038.085048943604;7052.717891284291;7083.937409388633;4972.950270497248;5138.3063286457345;5186.222066690027;5231.947680523146;5402.621816472809;5054.064997975386;5079.111155547838;5200.245964335226;5277.630565860353;5399.325084364455 07:48:14 INFO - PROCESS | 4740 | |4;prototype.html;308.6913086913087;309;312.7076183768177;313.15760603975303;316.6864803844192;5365.436629153936;5371.731413429333;5417.7291135443165;5433.967546166231;5438.374586922505;5273.472652734725;5298.761555729991;5300.761465734042;5319.707416092123;5333.759980800864;3964.36570148777;4054.756714597119;4057.918841623166;4067.5322337931075;4118.238125946695;4154.709170358061;4160.771157586331;4167.354060120686;4180.51924028736;4193.119444916556;4108.5686002969705;4151.529839745362;4152.695254133954;4155.729877557964;4169.708120431571;4087.550369459357;4169;4170.811318774135;4172.311568591179;4187.350960601081;3628.600853906068;3654.853805847763;3668.779873207616;3671.504346913159;3678.2459595783066;5173.870653233662;5212.113940630102;5221.817236396708;5227.26818245446;5274.709890955995;4693.78877950493;4705.306334527414;4736.573708366263;4768.259585251393;4776.853555146775;5534.446555344473;5534.612577119603;5571.916421253684;5580.967521008586;5582.63712858667;4006.639402453764;4013.6789056875673;4016.2971479990883;4034.6570541503716;4040.8181631826346;5600.635958662715;5816.82549523515;5857.414258574108;5866.354700982931;5881.470667639933;4140.523839758406;4148.460700109027;4160.271952408317;4160.812763425653;4162.167566486714;4123.257813593522;4139.81370838313;4179.561146079679;4202.583514479125;4203.684723645739;4577.198990176706;4726.338312636165;4743.857684269477;4775.235962246094;4799.568038876518;5563.332400112013;5580.744332525231;5602.663840169603;5609.663420194802;5611.887762244733;1394.995603165719;1413.5052731544083;1423.661757947526;1431.8782903453114;1440.7681432375168;876.3925418799508;902.9051949545335;916.7845556294266;918.8989211186764;950.6292545906964;5303.390110137307;5373.328333958255;5386.865328366744;5403.621746477709;5409.459054094637;5641.153826925912;5653.886922261532;5683.930677434139;5685.516731077904;5768.625039372428;5133.563647089964;5335.87946531225;5373.838784836461;5377.924415116992;5395.21769343443;3010.9397812043635;3011.48804703201;3032.7118923702214;3042.34589563245;3058.801177923428;5686.180186725043;5772.913406298909;5824.796132135355;5836.153757705109;5842.4653084883885;5644.266245388156;5759.452851979056;5761.9135712964335;5828.854278643068;5838;5748.540116790647;5749.3963133871175;5774.797882074191;5797.768089276382;5838.7080645967535;5490.752916118704;5634.661920284796;5651.406602306699;5710.172025056427;5714.342850572238;5583.4416558345465;5609.5512359012;5645.887082258414;5649.802256920988;5656.717164141859;5751.252337196138;5808.94191058084;5883.470487656132;5887.910736513759;5899.876044624018;4001.6790261648757;4082.408050832672;4104.1586474772;4114.7119701620595;4115.382692596135;5651.6043876928225;5666.093425051972;5677.77288908439;5681.857953551194;5725.713714314351;5369.382521009978;5546.195801608664;5551.2228288040515;5552.722363881709;5573.860653483695;5607.831765047055;5630.5214056805635;5636.1545768133465;5685.573581981451;5692.829215123553;5309.415964243853;5311.150215965427;5545.863098064968;5636.126400407943;5638.633488823213;5661.575381846295;5687.1753595729215;5695.7436915338085;5699.173619825019;5704.1443783432815;5492.395836458067;5493.505584497414;5522.447755224445;5538.667679939216;5557.499825015768 07:48:14 INFO - PROCESS | 4740 | |5;yui.html;710.2400431538256;756.4024420707641;801.1667865419963;810.5460941872548;833.6832003838542;14784.186869722162;15548.378064877406;15551.066935983834;15552.922235388807;15560.45538406156;13895;14817.925910370433;14825.703485930302;14866.702665946674;14867.479638212664;678.5284227461916;815.1766715617225;825.2407784837964;831.6798032757401;834.9540775257359;792.4254915186473;817.9631916563769;818.2553875972866;819.4223072733738;824.7443292579289;854.6111519258723;854.7393045121236;858.3219256787162;858.9656413743443;859.5873980489368;706.5760543673806;831.6548632317581;853.3343991686463;853.714005808055;853.8206976534904;624.1760875644152;625.1529177963885;626.505061001808;626.6678660309998;627.3068259573151;14492.492762753252;14651.63370915725;14665.340059697339;14670.413183472649;14694.412223511046;14029.158250505003;14063.507777227747;14442.061266017676;14586.41654333836;14982.850171498363;12871.22772633645;13037.152585082034;13067.346632668328;13082.476700931951;13661.521846735317;4436.866893993185;4480.843170489017;4568.086382723435;4579.358889755437;4731.714860058751;81259.18740812576;82070.58964705138;82217.17782822155;82275.17724822735;82316.58841705813;11579.76840463186;11617.535298587962;11710.121740869468;11846.170768046153;12000.939995300143;21907.452313692283;21978.89010554969;22257.88871055667;22335.218267360564;22345;8272.710455134042;8524.616392262364;8662.653493860174;8663.393562450694;8723.302135829119;4444.2444784386735;4860.9513904861205;4888.388951381077;4920;4928;3573.76770509916;3690.7231957603285;3703.037210325335;3707.5550933887566;3709.0541911812315;658.8122385120217;688.0985908459934;694.0560837261321;696.5542053085927;702.8102412348637;639.4309064932121;684.6747794797432;714.8355878148055;727.31995584129;748.9513181643176;8762.780930476789;9527.571259293349;9635.56639951204;9880.181201584253;10068.647597334058;646.7944309903207;675.9864802703919;709.6983781892675;713.4363852556526;729.8649749796199;4511.751853648016;4702.811887524529;4703;4706.599939005155;4780.545848144421;100353;119218;126733.36633316959;131022;131370.34314828366;107049.46475267573;107111;107297.46351268193;107378.46310768396;107421;59611.70194149088;79066.6046669763;87342.56328718443;87728.56135719281;88010.11989880019;8561.91438085636;8635.784105397415;8643.481391116553;8788.209061184523;8826.382153249468;53728.194077089654;54269.72865135649;54432.727836360566;55917.16124258221;58021.70989145027;78202.6089869547;81127;81522;83646;83929.58035209785;12282.263064216175;12416.379181041093;12819.743605128031;12860;13031.934840325737;13866.722665546431;13954.860451395762;13999.720005600035;14773.92613036928;14825.629359266104;12422.875771242534;12853.614391568268;12894.226346419246;13026;13359.799603005767;12828.358582071045;13395.0623456361;13422.194668319931;13454.663633409244;13928.51250206238;12450.875491245333;12925.935370323088;12929.741405171655;13347.733045338844;13440.395182216627;9831.852522212315;9899.65351212704;10285.588576456857;10299.3820370775;10626.203034772268;9696.75758106053;9885.258605604464;9926.950365248127;10337.638182663572;10346.689599312032 07:48:14 INFO - PROCESS | 4740 | __end_tp_report 07:48:14 INFO - PROCESS | 4740 | __start_cc_report 07:48:14 INFO - PROCESS | 4740 | _x_x_mozilla_cycle_collect,1151 07:48:14 INFO - PROCESS | 4740 | __end_cc_report 07:48:14 INFO - PROCESS | 4740 | __startTimestamp1466606894481__endTimestamp 07:48:14 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | ------- Summary: start ------- 07:48:14 INFO - PROCESS | 4740 | Number of tests: 6 07:48:14 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | [#0] dojo.html Cycles:165 Average:5306.56 Median:5500.64 stddev:604.92 (11.0%) stddev-sans-first:580.64 07:48:14 INFO - PROCESS | 4740 | Values: 3064.4 3087.1 3112.9 3116.3 3143.1 5183.6 5248.8 5284.2 5383.5 5421.6 5344.3 5345.9 5404.5 5456.5 5511.2 4849.6 4874.7 4901.8 4977.5 4986.9 4907.1 4958.7 5068.3 5072.1 5074.4 4730.9 4949.8 4954.5 4981.9 5011.2 4752.5 4830.4 4839.0 4854.1 4865.2 4806.5 4895.2 4897.4 4903.4 4946.9 5175.4 5300.2 5351.9 5353.1 5408.2 5658.0 5793.5 5796.7 5798.4 5810.1 5752.4 5833.1 5843.5 5844.8 5845.8 5171.7 5303.5 5357.0 5387.1 5415.0 5882.1 5891.9 5901.2 5902.0 5905.6 5608.0 5679.1 5680.6 5683.9 5689.0 5466.2 5697.3 5733.9 5864.7 5874.9 5708.6 5719.5 5748.2 5766.4 5789.4 5680.1 5714.7 5722.0 5728.1 5746.9 4205.3 4250.4 4293.2 4342.6 4344.7 3873.4 3875.2 3886.6 3911.7 3920.4 5356.2 5372.9 5374.1 5374.7 5386.9 5549.1 5626.9 5638.2 5649.1 5678.6 5319.7 5330.9 5335.5 5344.9 5358.0 4710.4 4768.2 4770.6 4782.0 4798.0 5842.9 5890.4 5894.7 5927.3 5945.8 5694.1 5731.5 5776.6 5787.5 5789.8 5625.7 5778.5 5786.5 5794.4 5799.9 5531.7 5606.0 5608.9 5609.9 5650.6 5718.2 5734.4 5742.7 5747.4 5748.7 5394.6 5530.4 5561.8 5602.8 5662.9 5598.2 5607.9 5611.7 5623.1 5677.3 5470.9 5497.2 5535.5 5536.0 5541.2 5395.0 5437.0 5500.6 5568.2 5642.7 5358.5 5478.0 5504.0 5509.3 5564.5 07:48:14 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | [#1] ext.html Cycles:180 Average:61386.77 Median:37490.44 stddev:122316.57 (326.3%) stddev-sans-first:122574.45 07:48:14 INFO - PROCESS | 4740 | Values: 563.6 622.3 626.6 635.2 639.8 30381.7 33667.7 33671.8 33679.3 33776.0 33650.3 42972.6 44275.6 44291.3 49020.0 8897.9 9055.4 9062.9 9070.2 9076.9 8158.3 8815.3 8910.4 8914.1 8916.3 10658.4 10928.1 10939.7 11268.9 11296.9 10805.5 10873.2 10879.9 10886.6 10886.8 8083.1 10416.2 10450.8 10653.9 10824.5 38943.0 43393.0 43404.3 43404.6 43454.3 3612.0 3625.4 3644.0 3691.5 3973.3 32519.2 32701.3 33923.0 33961.8 34541.5 4417.2 4440.4 4444.0 4482.3 4683.7 348982.0 349292.0 349301.0 349501.0 349567.0 61199.7 61319.0 61771.7 61801.0 61803.4 66802.0 66989.3 67126.3 67160.3 67214.7 16521.2 17192.0 17222.0 17228.1 17235.9 12871.9 13044.3 13056.0 13058.5 13078.8 18014.5 18928.2 19112.2 19400.3 20449.8 6912.7 6996.7 7045.8 7120.3 7252.2 959.4 982.9 1046.8 1114.5 1148.0 31542.7 31666.7 31920.0 32118.7 32361.5 1089.5 1110.6 1126.3 1143.4 1155.4 15778.7 16575.2 16724.4 16775.9 16852.7 564375.0 567586.0 569161.0 569305.0 569653.0 58595.1 60112.7 60116.0 60148.0 60150.4 1245.3 1308.3 1314.5 1345.8 1384.6 31259.7 33005.2 33319.7 33429.2 33833.3 50110.2 50653.7 50771.7 50898.2 50941.7 428548.0 440131.0 440850.0 441229.0 441357.0 25108.7 27498.2 27944.4 28222.0 30082.7 46532.3 46963.5 47148.5 48104.0 48413.3 39691.8 40976.6 41001.2 41433.6 42230.8 40522.6 41136.8 41508.4 41567.6 41890.0 40467.4 40905.0 41213.6 41752.8 41873.6 34785.8 36562.5 36747.3 37420.4 37560.4 27651.6 27709.6 27769.6 27914.9 27938.7 07:48:14 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | [#2] jquery.html Cycles:180 Average:26103.08 Median:2481.19 stddev:66747.83 (2690.2%) stddev-sans-first:66907.09 07:48:14 INFO - PROCESS | 4740 | Values: 363.5 373.7 380.5 383.4 394.6 18169.5 18698.8 19842.1 19846.5 19852.4 11677.8 12037.5 12091.3 12217.1 12223.3 5201.1 5481.6 5489.3 5489.4 5490.7 3909.5 5650.3 5972.3 5976.4 6081.0 5572.5 5990.9 6021.0 6075.3 6087.4 5925.0 6020.1 6056.0 6056.2 6057.6 3720.7 5497.4 5819.2 5831.9 5920.1 13806.9 13862.8 13946.2 14023.9 14200.1 2335.9 2343.7 2618.7 2652.5 2975.1 9579.3 9941.7 10344.3 10512.4 10536.5 1876.3 1894.5 1939.8 1950.6 1965.4 77909.2 78579.6 78984.0 79380.0 81040.2 10534.8 10688.7 10837.7 10959.3 11143.6 14927.9 14987.6 15035.0 15049.5 15061.1 7606.8 7700.8 7723.7 7800.7 7876.1 7572.2 7587.8 7635.3 7840.6 7872.8 4520.7 4570.4 4603.4 4610.7 4746.5 1814.0 1835.1 2003.1 2018.5 2053.6 887.3 919.9 973.5 1023.8 1038.0 18556.7 18749.9 18771.0 18934.1 19382.3 977.6 1016.1 1068.1 1076.5 1091.5 10457.6 10781.7 10814.4 10925.2 10950.5 339294.0 341316.0 345040.0 468741.0 474925.0 92516.5 101723.0 103486.0 103489.0 103553.0 951.5 965.4 1008.5 1060.4 1062.5 16285.9 17081.3 17212.2 17237.7 18370.4 41809.2 42177.8 42241.2 42863.6 43260.6 56858.7 58152.0 58328.7 59154.4 59201.2 8762.3 8917.0 9071.1 9101.5 9155.3 10290.7 12819.8 13624.9 13649.2 14189.8 11223.3 11817.4 11963.2 12137.6 12489.9 9478.0 11914.9 11990.7 12495.1 12504.2 12102.9 12236.1 12431.5 12625.4 12913.1 8509.0 8667.6 8770.3 8852.4 9017.3 8833.2 12045.3 12543.9 12590.6 12695.6 07:48:14 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | [#3] mootools.html Cycles:180 Average:5836.91 Median:485.21 stddev:3402.88 (701.3%) stddev-sans-first:3395.83 07:48:14 INFO - PROCESS | 4740 | Values: 1364.7 1463.7 1493.5 1610.7 1794.8 8432.6 8813.6 8814.2 9127.9 9147.8 8893.5 9047.6 9146.5 9153.2 9161.5 2335.0 2361.7 2361.9 2364.1 2364.3 2316.0 2371.2 2379.2 2388.4 2395.0 2284.8 2298.6 2313.7 2315.5 2336.2 2298.4 2302.2 2318.7 2332.5 2335.9 2236.5 2241.0 2242.2 2242.4 2255.3 8903.7 9107.0 9184.4 9186.6 9240.3 5167.5 5279.8 5282.6 5293.8 5297.5 3266.2 3301.7 3341.2 3349.1 3376.8 1046.8 1053.3 1053.7 1059.3 1076.2 12646.7 12819.1 12833.9 12842.4 12848.7 4316.8 4334.2 4380.3 4401.0 4401.4 9961.9 9993.0 9999.2 9999.5 10014.7 5104.0 5106.3 5113.4 5113.8 5124.6 4177.1 4687.8 4734.6 4865.2 4906.0 3746.9 3771.1 3834.7 3878.9 3885.1 1108.3 1113.0 1119.7 1122.1 1129.7 638.7 856.5 923.5 941.6 961.8 5560.8 5843.6 5929.5 5976.7 6084.3 484.8 485.6 651.3 976.3 1041.8 4075.9 4111.0 4149.7 4175.2 4179.6 11073.2 11256.8 11277.7 11348.4 11455.7 10196.7 10221.4 10359.0 10935.3 10957.8 8086.4 8153.8 8245.2 8253.4 8277.7 6026.3 6040.6 6071.7 6103.1 6183.4 10404.6 10432.7 10506.6 10539.5 10541.4 10303.2 10339.5 10483.8 10745.9 10761.1 7073.3 7907.1 8120.8 8131.3 8289.5 8683.4 8715.1 8724.3 8806.2 8807.6 7790.9 7823.9 7903.2 8092.1 8127.3 7202.6 7613.9 7728.1 7848.4 7894.3 6818.4 7034.7 7038.1 7052.7 7083.9 4973.0 5138.3 5186.2 5231.9 5402.6 5054.1 5079.1 5200.2 5277.6 5399.3 07:48:14 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | [#4] prototype.html Cycles:180 Average:4695.55 Median:5382.39 stddev:1379.31 (25.6%) stddev-sans-first:1343.31 07:48:14 INFO - PROCESS | 4740 | Values: 308.7 309.0 312.7 313.2 316.7 5365.4 5371.7 5417.7 5434.0 5438.4 5273.5 5298.8 5300.8 5319.7 5333.8 3964.4 4054.8 4057.9 4067.5 4118.2 4154.7 4160.8 4167.4 4180.5 4193.1 4108.6 4151.5 4152.7 4155.7 4169.7 4087.6 4169.0 4170.8 4172.3 4187.4 3628.6 3654.9 3668.8 3671.5 3678.2 5173.9 5212.1 5221.8 5227.3 5274.7 4693.8 4705.3 4736.6 4768.3 4776.9 5534.4 5534.6 5571.9 5581.0 5582.6 4006.6 4013.7 4016.3 4034.7 4040.8 5600.6 5816.8 5857.4 5866.4 5881.5 4140.5 4148.5 4160.3 4160.8 4162.2 4123.3 4139.8 4179.6 4202.6 4203.7 4577.2 4726.3 4743.9 4775.2 4799.6 5563.3 5580.7 5602.7 5609.7 5611.9 1395.0 1413.5 1423.7 1431.9 1440.8 876.4 902.9 916.8 918.9 950.6 5303.4 5373.3 5386.9 5403.6 5409.5 5641.2 5653.9 5683.9 5685.5 5768.6 5133.6 5335.9 5373.8 5377.9 5395.2 3010.9 3011.5 3032.7 3042.3 3058.8 5686.2 5772.9 5824.8 5836.2 5842.5 5644.3 5759.5 5761.9 5828.9 5838.0 5748.5 5749.4 5774.8 5797.8 5838.7 5490.8 5634.7 5651.4 5710.2 5714.3 5583.4 5609.6 5645.9 5649.8 5656.7 5751.3 5808.9 5883.5 5887.9 5899.9 4001.7 4082.4 4104.2 4114.7 4115.4 5651.6 5666.1 5677.8 5681.9 5725.7 5369.4 5546.2 5551.2 5552.7 5573.9 5607.8 5630.5 5636.2 5685.6 5692.8 5309.4 5311.2 5545.9 5636.1 5638.6 5661.6 5687.2 5695.7 5699.2 5704.1 5492.4 5493.5 5522.4 5538.7 5557.5 07:48:14 INFO - PROCESS | 4740 | 07:48:14 INFO - PROCESS | 4740 | [#5] yui.html Cycles:180 Average:21454.80 Median:4756.13 stddev:31716.40 (666.9%) stddev-sans-first:31767.12 07:48:14 INFO - PROCESS | 4740 | Values: 710.2 756.4 801.2 810.5 833.7 14784.2 15548.4 15551.1 15552.9 15560.5 13895.0 14817.9 14825.7 14866.7 14867.5 678.5 815.2 825.2 831.7 835.0 792.4 818.0 818.3 819.4 824.7 854.6 854.7 858.3 859.0 859.6 706.6 831.7 853.3 853.7 853.8 624.2 625.2 626.5 626.7 627.3 14492.5 14651.6 14665.3 14670.4 14694.4 14029.2 14063.5 14442.1 14586.4 14982.9 12871.2 13037.2 13067.3 13082.5 13661.5 4436.9 4480.8 4568.1 4579.4 4731.7 81259.2 82070.6 82217.2 82275.2 82316.6 11579.8 11617.5 11710.1 11846.2 12000.9 21907.5 21978.9 22257.9 22335.2 22345.0 8272.7 8524.6 8662.7 8663.4 8723.3 4444.2 4861.0 4888.4 4920.0 4928.0 3573.8 3690.7 3703.0 3707.6 3709.1 658.8 688.1 694.1 696.6 702.8 639.4 684.7 714.8 727.3 749.0 8762.8 9527.6 9635.6 9880.2 10068.6 646.8 676.0 709.7 713.4 729.9 4511.8 4702.8 4703.0 4706.6 4780.5 100353.0 119218.0 126733.4 131022.0 131370.3 107049.5 107111.0 107297.5 107378.5 107421.0 59611.7 79066.6 87342.6 87728.6 88010.1 8561.9 8635.8 8643.5 8788.2 8826.4 53728.2 54269.7 54432.7 55917.2 58021.7 78202.6 81127.0 81522.0 83646.0 83929.6 12282.3 12416.4 12819.7 12860.0 13031.9 13866.7 13954.9 13999.7 14773.9 14825.6 12422.9 12853.6 12894.2 13026.0 13359.8 12828.4 13395.1 13422.2 13454.7 13928.5 12450.9 12925.9 12929.7 13347.7 13440.4 9831.9 9899.7 10285.6 10299.4 10626.2 9696.8 9885.3 9927.0 10337.6 10346.7 07:48:14 INFO - PROCESS | 4740 | -------- Summary: end -------- 07:48:14 INFO - PROCESS | 4740 | 07:48:15 INFO - TEST-INFO | 4740: exit 0 07:48:15 INFO - TEST-OK | dromaeo_css | took 1120145ms 07:48:15 INFO - TEST-START | kraken 07:48:15 INFO - operating with platform_type : linux_ 07:48:15 INFO - Initialising browser for kraken test... 07:48:15 INFO - TEST-INFO | started process 4926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpalANLR/profile http://localhost:38488/getInfo.html) 07:48:22 INFO - PROCESS | 4926 | __metrics Screen width/height:1600/1200 07:48:22 INFO - PROCESS | 4926 | colorDepth:24 07:48:22 INFO - PROCESS | 4926 | Browser inner width/height: 1024/697 07:48:22 INFO - PROCESS | 4926 | __metrics 07:48:24 INFO - PROCESS | 4926 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:24 INFO - PROCESS | 4926 | console.error: PushService: 07:48:24 INFO - PROCESS | 4926 | stateChangeProcessEnqueue: Error transitioning state 07:48:24 INFO - PROCESS | 4926 | UnknownError 07:48:25 INFO - TEST-INFO | 4926: exit 0 07:48:25 INFO - Browser initialized. 07:48:25 INFO - Running cycle 1/1 for kraken test... 07:48:25 INFO - TEST-INFO | started process 5013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpalANLR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:37 INFO - PROCESS | 5013 | RSS: Main: 174116864 07:48:37 INFO - PROCESS | 5013 | 07:48:39 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38488/tests/kraken/driver.html?testName=audio-beat-detection) 07:48:40 INFO - PROCESS | 5013 | RSS: Main: 232472576 07:48:40 INFO - PROCESS | 5013 | 07:48:43 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38488/tests/kraken/driver.html?testName=audio-dft) 07:48:43 INFO - PROCESS | 5013 | RSS: Main: 218243072 07:48:43 INFO - PROCESS | 5013 | 07:48:46 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38488/tests/kraken/driver.html?testName=audio-fft) 07:48:47 INFO - PROCESS | 5013 | RSS: Main: 286629888 07:48:47 INFO - PROCESS | 5013 | 07:48:49 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38488/tests/kraken/driver.html?testName=audio-oscillator) 07:48:50 INFO - PROCESS | 5013 | RSS: Main: 198148096 07:48:50 INFO - PROCESS | 5013 | 07:48:52 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:48:52 INFO - PROCESS | 5013 | RSS: Main: 202301440 07:48:52 INFO - PROCESS | 5013 | 07:48:55 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38488/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:56 INFO - PROCESS | 5013 | RSS: Main: 236752896 07:48:56 INFO - PROCESS | 5013 | 07:49:00 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38488/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:00 INFO - PROCESS | 5013 | RSS: Main: 238325760 07:49:00 INFO - PROCESS | 5013 | 07:49:03 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38488/tests/kraken/driver.html?testName=json-parse-financial) 07:49:03 INFO - PROCESS | 5013 | RSS: Main: 238530560 07:49:03 INFO - PROCESS | 5013 | 07:49:05 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:06 INFO - PROCESS | 5013 | RSS: Main: 224690176 07:49:06 INFO - PROCESS | 5013 | 07:49:07 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:08 INFO - PROCESS | 5013 | RSS: Main: 230076416 07:49:08 INFO - PROCESS | 5013 | 07:49:10 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:11 INFO - PROCESS | 5013 | RSS: Main: 236863488 07:49:11 INFO - PROCESS | 5013 | 07:49:13 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:14 INFO - PROCESS | 5013 | RSS: Main: 238387200 07:49:14 INFO - PROCESS | 5013 | 07:49:17 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:17 INFO - PROCESS | 5013 | RSS: Main: 239640576 07:49:17 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | Cycle 1(1): loaded http://localhost:38488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38488/tests/kraken/driver.html?testName=ai-astar) 07:49:19 INFO - PROCESS | 5013 | RSS: Main: 282783744 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | __start_tp_report 07:49:19 INFO - PROCESS | 5013 | _x_x_mozilla_page_load 07:49:19 INFO - PROCESS | 5013 | _x_x_mozilla_page_load_details 07:49:19 INFO - PROCESS | 5013 | |i|pagename|runs| 07:49:19 INFO - PROCESS | 5013 | |0;ai-astar;102;112;110;110;111;111;111;112;109;111 07:49:19 INFO - PROCESS | 5013 | |1;audio-beat-detection;153;131;127;179;125;133;150;123;159;130 07:49:19 INFO - PROCESS | 5013 | |2;audio-dft;161;162;163;161;162;160;162;160;163;162 07:49:19 INFO - PROCESS | 5013 | |3;audio-fft;74;76;75;116;76;76;73;73;99;76 07:49:19 INFO - PROCESS | 5013 | |4;audio-oscillator;87;85;113;86;88;85;115;84;85;131 07:49:19 INFO - PROCESS | 5013 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;117;116;117 07:49:19 INFO - PROCESS | 5013 | |6;imaging-darkroom;145;146;146;146;146;146;145;146;146;146 07:49:19 INFO - PROCESS | 5013 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 07:49:19 INFO - PROCESS | 5013 | |8;json-parse-financial;53;53;53;54;55;56;53;53;54;52 07:49:19 INFO - PROCESS | 5013 | |9;json-stringify-tinderbox;62;62;62;62;63;62;61;62;63;62 07:49:19 INFO - PROCESS | 5013 | |10;stanford-crypto-aes;87;80;80;85;80;81;80;86;94;79 07:49:19 INFO - PROCESS | 5013 | |11;stanford-crypto-ccm;123;122;124;123;121;120;123;120;126;123 07:49:19 INFO - PROCESS | 5013 | |12;stanford-crypto-pbkdf2;166;160;170;164;164;166;167;162;165;159 07:49:19 INFO - PROCESS | 5013 | |13;stanford-crypto-sha256-iterative;63;64;67;63;63;66;64;63;62;64 07:49:19 INFO - PROCESS | 5013 | __end_tp_report 07:49:19 INFO - PROCESS | 5013 | __start_cc_report 07:49:19 INFO - PROCESS | 5013 | _x_x_mozilla_cycle_collect,1609 07:49:19 INFO - PROCESS | 5013 | __end_cc_report 07:49:19 INFO - PROCESS | 5013 | __startTimestamp1466606959589__endTimestamp 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | ------- Summary: start ------- 07:49:19 INFO - PROCESS | 5013 | Number of tests: 14 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.92 (2.6%) stddev-sans-first:0.97 07:49:19 INFO - PROCESS | 5013 | Values: 102.0 112.0 110.0 110.0 111.0 111.0 111.0 112.0 109.0 111.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:141.50 stddev:18.42 (13.0%) stddev-sans-first:19.02 07:49:19 INFO - PROCESS | 5013 | Values: 153.0 131.0 127.0 179.0 125.0 133.0 150.0 123.0 159.0 130.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 07:49:19 INFO - PROCESS | 5013 | Values: 161.0 162.0 163.0 161.0 162.0 160.0 162.0 160.0 163.0 162.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:14.38 (18.9%) stddev-sans-first:15.00 07:49:19 INFO - PROCESS | 5013 | Values: 74.0 76.0 75.0 116.0 76.0 76.0 73.0 73.0 99.0 76.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.08 (20.1%) stddev-sans-first:17.81 07:49:19 INFO - PROCESS | 5013 | Values: 87.0 85.0 113.0 86.0 88.0 85.0 115.0 84.0 85.0 131.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:49:19 INFO - PROCESS | 5013 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 07:49:19 INFO - PROCESS | 5013 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:49:19 INFO - PROCESS | 5013 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:1.17 (2.2%) stddev-sans-first:1.22 07:49:19 INFO - PROCESS | 5013 | Values: 53.0 53.0 53.0 54.0 55.0 56.0 53.0 53.0 54.0 52.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:49:19 INFO - PROCESS | 5013 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 61.0 62.0 63.0 62.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:4.78 (5.8%) stddev-sans-first:4.87 07:49:19 INFO - PROCESS | 5013 | Values: 87.0 80.0 80.0 85.0 80.0 81.0 80.0 86.0 94.0 79.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:123.00 stddev:1.84 (1.5%) stddev-sans-first:1.94 07:49:19 INFO - PROCESS | 5013 | Values: 123.0 122.0 124.0 123.0 121.0 120.0 123.0 120.0 126.0 123.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:165.50 stddev:3.30 (2.0%) stddev-sans-first:3.44 07:49:19 INFO - PROCESS | 5013 | Values: 166.0 160.0 170.0 164.0 164.0 166.0 167.0 162.0 165.0 159.0 07:49:19 INFO - PROCESS | 5013 | 07:49:19 INFO - PROCESS | 5013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.52 (2.4%) stddev-sans-first:1.58 07:49:19 INFO - PROCESS | 5013 | Values: 63.0 64.0 67.0 63.0 63.0 66.0 64.0 63.0 62.0 64.0 07:49:19 INFO - PROCESS | 5013 | -------- Summary: end -------- 07:49:19 INFO - PROCESS | 5013 | 07:49:21 INFO - TEST-INFO | 5013: exit 0 07:49:21 INFO - TEST-OK | kraken | took 65744ms 07:49:21 INFO - SUITE-END | took 1185s 07:49:21 INFO - Completed test suite (00:19:46) 07:49:21 INFO - javascript benchmark 07:49:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.4483992881287, 3087.1201707513355, 3112.9066128016166, 3116.3455674308393, 3143.119926420603, 5183.611229157819, 5248.816291429801, 5284.207368894663, 5383.542398896094, 5421.566274698024, 5344.278522399475, 5345.893082138355, 5404.486573775494, 5456.48163424474, 5511.173324001392, 4849.587785038276, 4874.707517548941, 4901.779419926112, 4977.5022497750115, 4986.900261994758, 4907.067657145149, 4958.652894297401, 5068.315777370063, 5072.137736584789, 5074.391073071237, 4730.905381892378, 4949.752512374403, 4954.455009948902, 4981.850544483671, 5011.248312753098, 4752.52474752522, 4830.396200474941, 4839.0, 4854.101991131617, 4865.245886887538, 4806.49531799163, 4895.2167653175675, 4897.363342765453, 4903.411590609114, 4946.851594452172, 5175.404828444739, 5300.151975683911, 5351.866203344947, 5353.0899747043095, 5408.161734931092, 5658.0381335173115, 5793.4785869271545, 5796.652200867961, 5798.3911689272445, 5810.070388737824, 5752.424757524214, 5833.066709326487, 5843.5325173985975, 5844.824655260349, 5845.824625261249, 5171.663841850268, 5303.522682958553, 5357.035733567917, 5387.057264978613, 5414.972925135388, 5882.058870580687, 5891.941080589225, 5901.17383566301, 5902.026165682701, 5905.616134951214, 5608.018596745554, 5679.119736440858, 5680.602357834912, 5683.943160568341, 5688.971555142198, 5466.1527463243265, 5697.3448053474385, 5733.942660573424, 5864.67744274069, 5874.882502350015, 5708.600397972185, 5719.542436605062, 5748.19525266463, 5766.365699773021, 5789.363170051291, 5680.091185410397, 5714.657120572779, 5721.971390143022, 5728.05487094633, 5746.913796293059, 4205.285101532686, 4250.404943307939, 4293.2272191005295, 4342.609165175149, 4344.695871288979, 3873.3802591585213, 3875.186210895687, 3886.6113388660906, 3911.6675082618294, 3920.3923391874305, 5356.196570514376, 5372.892542149213, 5374.086405311106, 5374.677519348774, 5386.91919621206, 5549.084401073858, 5626.887462250732, 5638.154276858504, 5649.096144616841, 5678.5741069419955, 5319.707416092152, 5330.893382132335, 5335.466453354634, 5344.893102138013, 5358.0, 4710.434747830213, 4768.189407800683, 4770.570648641639, 4782.0, 4798.04039192163, 5842.941570584325, 5890.440408161217, 5894.705264736746, 5927.2590926134235, 5945.762169513171, 5694.088945768657, 5731.455511726379, 5776.595638305278, 5787.479126878601, 5789.797357092481, 5625.718714064198, 5778.508826749773, 5786.450287222707, 5794.4205579443405, 5799.94200057994, 5531.695756733257, 5606.0, 5608.887822243614, 5609.943900560942, 5650.6327088740745, 5718.170865224436, 5734.3692193857805, 5742.712864356682, 5747.4252574742195, 5748.741306641127, 5394.649347792538, 5530.419305972976, 5561.777528898799, 5602.831915042555, 5662.85842853932, 5598.21624972496, 5607.943920560905, 5611.691356975405, 5623.100303951348, 5677.318721753416, 5470.91793623104, 5497.175423686319, 5535.501804837423, 5536.0, 5541.196526503554, 5394.973025134849, 5436.972815136057, 5500.642458240201, 5568.248286481273, 5642.7460764266525, 5358.517733404013, 5477.972610136924, 5504.0, 5509.311336082989, 5564.4713752193475], "value": 5265.704639455948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5970281248906, 622.3403192615827, 626.5645376463358, 635.1711017122655, 639.7792761497282, 30381.69618303819, 33667.66332336676, 33671.831640841825, 33679.32641347172, 33775.986720398425, 33650.32699346018, 42972.57027429732, 44275.557244427546, 44291.33562996558, 49020.0, 8897.911020889773, 9055.366124371296, 9062.909370906305, 9070.183683468487, 9076.909230907706, 8158.347332213439, 8815.250703690162, 8910.376273660846, 8914.108589141098, 8916.331275154356, 10658.413787241698, 10928.071113955324, 10939.671809845717, 11268.887311126908, 11296.943515282412, 10805.459727013656, 10873.238873278873, 10879.912008799136, 10886.564537418493, 10886.836697449544, 8083.110857805636, 10416.166706663449, 10450.790984180274, 10653.946730266376, 10824.512896919658, 38943.0, 43393.0, 43404.34893476601, 43404.56595434037, 43454.34818477726, 3612.0, 3625.419932810764, 3644.0, 3691.5201023866725, 3973.3443981742976, 32519.187020324443, 32701.345973080643, 33923.0, 33961.830190849134, 34541.481877771854, 4417.2269852775635, 4440.378347031418, 4444.0, 4482.327650852366, 4683.695559788603, 348982.0, 349292.0, 349301.0, 349500.99999999744, 349567.0, 61199.694001530595, 61319.0, 61771.691141544004, 61801.0, 61803.38196618066, 66802.0, 66989.33010669929, 67126.32873671298, 67160.32839671639, 67214.66392668104, 16521.173941302888, 17192.0, 17222.0, 17228.138593070296, 17235.91382043082, 12871.871281287255, 13044.282564458856, 13056.0, 13058.542950996669, 13078.803817942548, 18014.5496362592, 18928.24287028531, 19112.23551057942, 19400.288123090926, 20449.795502045086, 6912.723491060402, 6996.6851491683, 7045.8238544035785, 7120.323569260912, 7252.2385149559595, 959.4291396619001, 982.94102353859, 1046.8011077895176, 1114.5207560748956, 1148.0356500539588, 31542.684573153976, 31666.683333166835, 31920.0, 32118.67881321157, 32361.51457728136, 1089.4716062709579, 1110.6445937299986, 1126.3354620773782, 1143.3768596115137, 1155.3760969076773, 15778.68442631164, 16575.17124143812, 16724.414645487348, 16775.91612041932, 16852.662946740995, 564375.0, 567585.9724208198, 569161.0, 569305.0, 569653.0, 58595.12107318394, 60112.69943650254, 60116.0, 60148.0, 60150.39849601448, 1245.2777389114292, 1308.2542950518305, 1314.5267703626878, 1345.8115863779078, 1384.563862383346, 31259.687403125678, 33005.17487062843, 33319.66680333263, 33429.16427089245, 33833.3233335327, 50110.24834627411, 50653.74673126758, 50771.74614126905, 50898.23652645287, 50941.745291273306, 428548.0, 440131.0, 440850.0, 441229.0, 441357.0, 25108.74891251064, 27498.17505474839, 27944.44111117807, 28222.0, 30082.69917300799, 46532.30201547047, 46963.530364695915, 47148.52851471442, 48104.0, 48413.273800893716, 39691.80154099211, 40976.590234097275, 41001.17997639971, 41433.58566414418, 42230.78884605557, 40522.59477405306, 41136.79431602823, 41508.377374340016, 41567.58432415637, 41890.0, 40467.3929891046, 40905.0, 41213.58786412217, 41752.79123604484, 41873.58126418697, 34785.82607086949, 36562.45156322604, 36747.26505469822, 37420.43869342017, 37560.43659345058, 27651.585226222025, 27709.58435623427, 27769.58345624777, 27914.860425698553, 27938.72061279361], "value": 20497.135700304927, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.4584469140981, 373.7271791592138, 380.5452484281285, 383.38083994349097, 394.58174335204683, 18169.545761355956, 18698.813011869875, 19842.107105180265, 19846.503837404038, 19852.40442786715, 11677.766444671102, 12037.51849926004, 12091.274523528595, 12217.144799864012, 12223.266604003766, 5201.141811601091, 5481.616286859901, 5489.313835770528, 5489.39616642169, 5490.670559766407, 3909.4526766252748, 5650.265465489501, 5972.283326000886, 5976.432238937294, 6080.969595152018, 5572.5263352615075, 5990.940090599103, 6020.969895150518, 6075.301340345851, 6087.421694938996, 5924.970375148118, 6020.096985452174, 6055.969720151371, 6056.152138700563, 6057.606255593394, 3720.683741881943, 5497.422770609109, 5819.156222347736, 5831.88336233273, 5920.111983202511, 13806.861931380658, 13862.792058119136, 13946.23295718735, 14023.85976140246, 14200.076994995292, 2335.8948847301913, 2343.6601692754625, 2618.711941686413, 2652.4827658606578, 2975.1372102090368, 9579.329446938717, 9941.683418585668, 10344.32761870476, 10512.421816800073, 10536.47317634123, 1876.3245231716571, 1894.4695485264149, 1939.7963213862624, 1950.5903760210372, 1965.4202010406964, 77909.22090779076, 78579.60710196412, 78984.0, 79380.0, 81040.18959810385, 10534.789304213873, 10688.732781680364, 10837.67486975392, 10959.287646302964, 11143.609973650884, 14927.925360373129, 14987.625309367353, 15035.0, 15049.473268435551, 15061.096334219981, 7606.847863042708, 7700.807479813049, 7723.65243564041, 7800.687972481037, 7876.054873415227, 7572.242775722384, 7587.810304742316, 7635.274648908345, 7840.647170877324, 7872.84254314922, 4520.660950428731, 4570.360149579062, 4603.378543896598, 4610.723356598614, 4746.525347465225, 1813.9727904081449, 1835.0818609982698, 2003.1286390420214, 2018.4651067467132, 2053.5995480881384, 887.3078998381272, 919.8540102667587, 973.5278389980854, 1023.81059503992, 1037.9532921018572, 18556.721649175273, 18749.90625046866, 18771.0, 18934.147963341406, 19382.321618743277, 977.6089564174387, 1016.1464369929295, 1068.0707784227773, 1076.5209481780532, 1091.497910960951, 10457.581696732046, 10781.676549703521, 10814.405207713651, 10925.180611454014, 10950.507227174796, 339294.0, 341316.0, 345040.0, 468741.0, 474925.0, 92516.53741731249, 101723.0, 103486.0, 103489.0, 103553.0, 951.471933077135, 965.4062751407834, 1008.4907121903392, 1060.3955745225148, 1062.4581463453694, 16285.918570407546, 17081.31674732997, 17212.225449855036, 17237.74143387825, 18370.448886533424, 41809.16381672289, 42177.78911105425, 42241.15517689691, 42863.571364285955, 43260.567394325655, 56858.7157064212, 58152.0, 58328.70835645965, 59154.40845591489, 59201.15192512473, 8762.342824288076, 8916.955415222883, 9071.138241867013, 9101.453912765255, 9155.313351498531, 10290.742731431774, 12819.8462138408, 13624.86375136236, 13649.181049137083, 14189.787153192918, 11223.326600403676, 11817.350045747566, 11963.162578619413, 12137.635870923887, 12489.937550312554, 9477.95261023718, 11914.880851191378, 11990.700232494257, 12495.125341226027, 12504.187227830162, 12102.939485302517, 12236.08229382782, 12431.502739890304, 12625.368731563569, 12913.09608327408, 8509.0, 8667.566621669017, 8770.342224333328, 8852.424592401474, 9017.278617710435, 8833.160849719266, 12045.33750643688, 12543.87456125427, 12590.622281331574, 12695.55565555201], "value": 8947.305697735266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.6724786051338, 1463.656040830405, 1493.5444689369742, 1610.6617610301837, 1794.8474379677727, 8432.578371081445, 8813.559322033896, 8814.162654547823, 9127.908720912805, 9147.77130571736, 8893.510856902867, 9047.592858321375, 9146.496942668151, 9153.22197613202, 9161.45031298121, 2334.9883250583725, 2361.681173041643, 2361.9409514762096, 2364.125273648752, 2364.3498038039593, 2315.9768402316013, 2371.1819422299277, 2379.202967006055, 2388.4028992751814, 2394.9640755388596, 2284.7715228477105, 2298.643710224918, 2313.7223533175957, 2315.4674424882287, 2336.19401306549, 2298.448372390614, 2302.2172461363134, 2318.733345665253, 2332.463533387322, 2335.871527066019, 2236.5079682469996, 2241.0251540579898, 2242.237639202679, 2242.3609271357586, 2255.3008567344013, 8903.73288801337, 9107.0, 9184.357095003352, 9186.632534698603, 9240.306976976754, 5167.509086636764, 5279.815206467755, 5282.577393808525, 5293.788248470057, 5297.549708274802, 3266.167127382526, 3301.669833016679, 3341.248219150696, 3349.129226401153, 3376.763626546143, 1046.8063408269495, 1053.257453495284, 1053.7365658585354, 1059.3167407022427, 1076.1767248055244, 12646.74706505874, 12819.102662813606, 12833.935830320788, 12842.357882105951, 12848.743025139538, 4316.827326906951, 4334.241507736134, 4380.3210502372185, 4401.0, 4401.427814384109, 9961.850572241423, 9992.950035249924, 9999.150072243796, 9999.50002499872, 10014.749631259278, 5104.03023425548, 5106.285120083191, 5113.437521872591, 5113.846584602468, 5124.615653825978, 4177.101923086551, 4687.81248750053, 4734.573888350065, 4865.245886887538, 4905.950940490621, 3746.887593372149, 3771.113788259757, 3834.69322454203, 3878.9224215515533, 3885.0675837798726, 1108.2906939558688, 1112.9666110016713, 1119.7368618374676, 1122.0911062039775, 1129.717570607348, 638.7061951502268, 856.4732689396101, 923.4874644572327, 941.6186444489992, 961.7980224153006, 5560.77756889728, 5843.620164689281, 5929.525637948954, 5976.731047102804, 6084.269887613426, 484.84727310896955, 485.5654189500377, 651.2770824384929, 976.2775546095838, 1041.7812259425605, 4075.918481630351, 4111.0, 4149.668026557868, 4175.164967006611, 4179.6029377209115, 11073.224874258725, 11256.774864502664, 11277.71805704864, 11348.375839328752, 11455.713607159722, 10196.745081373025, 10221.437820919771, 10359.0, 10935.28920620157, 10957.83563246552, 8086.353091752646, 8153.796155096052, 8245.175482451827, 8253.380996425292, 8277.710280140287, 6026.306974697965, 6040.607360521552, 6071.696415179312, 6103.08453731926, 6183.3816618337805, 10404.635837745642, 10432.68701938943, 10506.632267870587, 10539.525721342405, 10541.367517948947, 10303.175745940456, 10339.483025848527, 10483.79032419332, 10745.946270268598, 10761.139108871115, 7073.257307982588, 7907.130215676386, 8120.796980075545, 8131.349492040741, 8289.544075075928, 8683.435576687496, 8715.084916083973, 8724.302055835646, 8806.163414475615, 8807.647694092164, 7790.88313675284, 7823.921760782319, 7903.170167132368, 8092.069412017693, 8127.349812014906, 7202.639868006683, 7613.885791713018, 7728.072631284282, 7848.411369147451, 7894.342188140555, 6818.386345228953, 7034.683439245348, 7038.085048943604, 7052.717891284291, 7083.937409388633, 4972.950270497248, 5138.3063286457345, 5186.222066690027, 5231.947680523146, 5402.621816472809, 5054.064997975386, 5079.111155547838, 5200.245964335226, 5277.630565860353, 5399.325084364455], "value": 4585.280337926374, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.6913086913087, 309.0, 312.7076183768177, 313.15760603975303, 316.6864803844192, 5365.436629153936, 5371.731413429333, 5417.7291135443165, 5433.967546166231, 5438.374586922505, 5273.472652734725, 5298.761555729991, 5300.761465734042, 5319.707416092123, 5333.759980800864, 3964.36570148777, 4054.756714597119, 4057.918841623166, 4067.5322337931075, 4118.238125946695, 4154.709170358061, 4160.771157586331, 4167.354060120686, 4180.51924028736, 4193.119444916556, 4108.5686002969705, 4151.529839745362, 4152.695254133954, 4155.729877557964, 4169.708120431571, 4087.550369459357, 4169.0, 4170.811318774135, 4172.311568591179, 4187.350960601081, 3628.600853906068, 3654.853805847763, 3668.779873207616, 3671.504346913159, 3678.2459595783066, 5173.870653233662, 5212.113940630102, 5221.817236396708, 5227.26818245446, 5274.709890955995, 4693.78877950493, 4705.306334527414, 4736.573708366263, 4768.259585251393, 4776.853555146775, 5534.446555344473, 5534.612577119603, 5571.916421253684, 5580.967521008586, 5582.63712858667, 4006.639402453764, 4013.6789056875673, 4016.2971479990883, 4034.6570541503716, 4040.8181631826346, 5600.635958662715, 5816.82549523515, 5857.414258574108, 5866.354700982931, 5881.470667639933, 4140.523839758406, 4148.460700109027, 4160.271952408317, 4160.812763425653, 4162.167566486714, 4123.257813593522, 4139.81370838313, 4179.561146079679, 4202.583514479125, 4203.684723645739, 4577.198990176706, 4726.338312636165, 4743.857684269477, 4775.235962246094, 4799.568038876518, 5563.332400112013, 5580.744332525231, 5602.663840169603, 5609.663420194802, 5611.887762244733, 1394.995603165719, 1413.5052731544083, 1423.661757947526, 1431.8782903453114, 1440.7681432375168, 876.3925418799508, 902.9051949545335, 916.7845556294266, 918.8989211186764, 950.6292545906964, 5303.390110137307, 5373.328333958255, 5386.865328366744, 5403.621746477709, 5409.459054094637, 5641.153826925912, 5653.886922261532, 5683.930677434139, 5685.516731077904, 5768.625039372428, 5133.563647089964, 5335.87946531225, 5373.838784836461, 5377.924415116992, 5395.21769343443, 3010.9397812043635, 3011.48804703201, 3032.7118923702214, 3042.34589563245, 3058.801177923428, 5686.180186725043, 5772.913406298909, 5824.796132135355, 5836.153757705109, 5842.4653084883885, 5644.266245388156, 5759.452851979056, 5761.9135712964335, 5828.854278643068, 5838.0, 5748.540116790647, 5749.3963133871175, 5774.797882074191, 5797.768089276382, 5838.7080645967535, 5490.752916118704, 5634.661920284796, 5651.406602306699, 5710.172025056427, 5714.342850572238, 5583.4416558345465, 5609.5512359012, 5645.887082258414, 5649.802256920988, 5656.717164141859, 5751.252337196138, 5808.94191058084, 5883.470487656132, 5887.910736513759, 5899.876044624018, 4001.6790261648757, 4082.408050832672, 4104.1586474772, 4114.7119701620595, 4115.382692596135, 5651.6043876928225, 5666.093425051972, 5677.77288908439, 5681.857953551194, 5725.713714314351, 5369.382521009978, 5546.195801608664, 5551.2228288040515, 5552.722363881709, 5573.860653483695, 5607.831765047055, 5630.5214056805635, 5636.1545768133465, 5685.573581981451, 5692.829215123553, 5309.415964243853, 5311.150215965427, 5545.863098064968, 5636.126400407943, 5638.633488823213, 5661.575381846295, 5687.1753595729215, 5695.7436915338085, 5699.173619825019, 5704.1443783432815, 5492.395836458067, 5493.505584497414, 5522.447755224445, 5538.667679939216, 5557.499825015768], "value": 4245.433017605314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.2400431538256, 756.4024420707641, 801.1667865419963, 810.5460941872548, 833.6832003838542, 14784.186869722162, 15548.378064877406, 15551.066935983834, 15552.922235388807, 15560.45538406156, 13895.0, 14817.925910370433, 14825.703485930302, 14866.702665946674, 14867.479638212664, 678.5284227461916, 815.1766715617225, 825.2407784837964, 831.6798032757401, 834.9540775257359, 792.4254915186473, 817.9631916563769, 818.2553875972866, 819.4223072733738, 824.7443292579289, 854.6111519258723, 854.7393045121236, 858.3219256787162, 858.9656413743443, 859.5873980489368, 706.5760543673806, 831.6548632317581, 853.3343991686463, 853.714005808055, 853.8206976534904, 624.1760875644152, 625.1529177963885, 626.505061001808, 626.6678660309998, 627.3068259573151, 14492.492762753252, 14651.63370915725, 14665.340059697339, 14670.413183472649, 14694.412223511046, 14029.158250505003, 14063.507777227747, 14442.061266017676, 14586.41654333836, 14982.850171498363, 12871.22772633645, 13037.152585082034, 13067.346632668328, 13082.476700931951, 13661.521846735317, 4436.866893993185, 4480.843170489017, 4568.086382723435, 4579.358889755437, 4731.714860058751, 81259.18740812576, 82070.58964705138, 82217.17782822155, 82275.17724822735, 82316.58841705813, 11579.76840463186, 11617.535298587962, 11710.121740869468, 11846.170768046153, 12000.939995300143, 21907.452313692283, 21978.89010554969, 22257.88871055667, 22335.218267360564, 22345.0, 8272.710455134042, 8524.616392262364, 8662.653493860174, 8663.393562450694, 8723.302135829119, 4444.2444784386735, 4860.9513904861205, 4888.388951381077, 4920.0, 4928.0, 3573.76770509916, 3690.7231957603285, 3703.037210325335, 3707.5550933887566, 3709.0541911812315, 658.8122385120217, 688.0985908459934, 694.0560837261321, 696.5542053085927, 702.8102412348637, 639.4309064932121, 684.6747794797432, 714.8355878148055, 727.31995584129, 748.9513181643176, 8762.780930476789, 9527.571259293349, 9635.56639951204, 9880.181201584253, 10068.647597334058, 646.7944309903207, 675.9864802703919, 709.6983781892675, 713.4363852556526, 729.8649749796199, 4511.751853648016, 4702.811887524529, 4703.0, 4706.599939005155, 4780.545848144421, 100353.0, 119218.0, 126733.36633316959, 131022.0, 131370.34314828366, 107049.46475267573, 107111.0, 107297.46351268193, 107378.46310768396, 107421.0, 59611.70194149088, 79066.6046669763, 87342.56328718443, 87728.56135719281, 88010.11989880019, 8561.91438085636, 8635.784105397415, 8643.481391116553, 8788.209061184523, 8826.382153249468, 53728.194077089654, 54269.72865135649, 54432.727836360566, 55917.16124258221, 58021.70989145027, 78202.6089869547, 81127.0, 81522.0, 83646.0, 83929.58035209785, 12282.263064216175, 12416.379181041093, 12819.743605128031, 12860.0, 13031.934840325737, 13866.722665546431, 13954.860451395762, 13999.720005600035, 14773.92613036928, 14825.629359266104, 12422.875771242534, 12853.614391568268, 12894.226346419246, 13026.0, 13359.799603005767, 12828.358582071045, 13395.0623456361, 13422.194668319931, 13454.663633409244, 13928.51250206238, 12450.875491245333, 12925.935370323088, 12929.741405171655, 13347.733045338844, 13440.395182216627, 9831.852522212315, 9899.65351212704, 10285.588576456857, 10299.3820370775, 10626.203034772268, 9696.75758106053, 9885.258605604464, 9926.950365248127, 10337.638182663572, 10346.689599312032], "value": 7611.273283673784, "unit": "score"}], "name": "dromaeo_css", "value": 7232.229270747634, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 110.0, 111.0, 111.0, 111.0, 112.0, 109.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 127.0, 179.0, 125.0, 133.0, 150.0, 123.0, 159.0, 130.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 162.0, 160.0, 162.0, 160.0, 163.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 116.0, 76.0, 76.0, 73.0, 73.0, 99.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 113.0, 86.0, 88.0, 85.0, 115.0, 84.0, 85.0, 131.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 55.0, 56.0, 53.0, 53.0, 54.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 62.0, 63.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 80.0, 85.0, 80.0, 81.0, 80.0, 86.0, 94.0, 79.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 124.0, 123.0, 121.0, 120.0, 123.0, 120.0, 126.0, 123.0], "value": 122.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 160.0, 170.0, 164.0, 164.0, 166.0, 167.0, 162.0, 165.0, 159.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 67.0, 63.0, 63.0, 66.0, 64.0, 63.0, 62.0, 64.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1496.9, "alertThreshold": 2.0}]} 07:49:21 INFO - Return code: 0 07:49:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:49:21 INFO - # TBPL SUCCESS # 07:49:21 INFO - Running post-action listener: _resource_record_post_action 07:49:21 INFO - ##### 07:49:21 INFO - ##### Finished run-tests step (success) 07:49:21 INFO - ##### 07:49:21 INFO - Running post-run listener: _resource_record_post_run 07:49:21 INFO - Total resource usage - Wall time: 1215s; CPU: 14.0%; Read bytes: 0; Write bytes: 555753472; Read time: 0; Write time: 4104628 07:49:21 INFO - TinderboxPrint: CPU usage
13.5% 07:49:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:49:21 INFO - TinderboxPrint: I/O write bytes / time
555,753,472 / 4,104,628 07:49:21 INFO - TinderboxPrint: CPU idle
8,383.6 (86.5%) 07:49:21 INFO - TinderboxPrint: CPU user
1,209.7 (12.5%) 07:49:21 INFO - TinderboxPrint: Swap in / out
0 / 0 07:49:21 INFO - install - Wall time: 28s; CPU: 20.0%; Read bytes: 0; Write bytes: 261988352; Read time: 0; Write time: 2771592 07:49:21 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293187584; Read time: 0; Write time: 1324028 07:49:22 INFO - Running post-run listener: _upload_blobber_files 07:49:22 INFO - Blob upload gear active. 07:49:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:49:22 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 07:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:49:22 INFO - (blobuploader) - INFO - Open directory for files ... 07:49:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:49:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:49:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:23 INFO - (blobuploader) - INFO - Done attempting. 07:49:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:49:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:49:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:26 INFO - (blobuploader) - INFO - Done attempting. 07:49:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:49:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:49:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:27 INFO - (blobuploader) - INFO - Done attempting. 07:49:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:49:27 INFO - Return code: 0 07:49:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:49:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:49:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57a269a747fb83dfc1c9bf7127528868a5a91164d981ef672ec8a55764d04613feb61a35acbdfee3177aca9143150d7b21b9928cf86ff44e7c510fa425b0c181", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b9555dbb6ebb70d142a5f15b467dd56dbc84036111fedb7193c89b40fe766aebe0416fd132411b974cceb0e02eb082606e87663558f65059343f5dfcba50d6a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f2673c4d6ab9bb1fa7a8541ff61f94b2914cf78aa36280f9b94f6751cb8de518b5a1384e082a9eb08d3fceecbc16940439a3d7dccd53c5c0ee5e4e8a6c8bb05"} 07:49:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:49:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:49:27 INFO - Contents: 07:49:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57a269a747fb83dfc1c9bf7127528868a5a91164d981ef672ec8a55764d04613feb61a35acbdfee3177aca9143150d7b21b9928cf86ff44e7c510fa425b0c181", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b9555dbb6ebb70d142a5f15b467dd56dbc84036111fedb7193c89b40fe766aebe0416fd132411b974cceb0e02eb082606e87663558f65059343f5dfcba50d6a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f2673c4d6ab9bb1fa7a8541ff61f94b2914cf78aa36280f9b94f6751cb8de518b5a1384e082a9eb08d3fceecbc16940439a3d7dccd53c5c0ee5e4e8a6c8bb05"} 07:49:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:49:27 INFO - Copying logs to upload dir... 07:49:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:49:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.190564 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-22 07:49:27.588666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 07:49:27.591922) ========= 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=33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57a269a747fb83dfc1c9bf7127528868a5a91164d981ef672ec8a55764d04613feb61a35acbdfee3177aca9143150d7b21b9928cf86ff44e7c510fa425b0c181", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b9555dbb6ebb70d142a5f15b467dd56dbc84036111fedb7193c89b40fe766aebe0416fd132411b974cceb0e02eb082606e87663558f65059343f5dfcba50d6a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f2673c4d6ab9bb1fa7a8541ff61f94b2914cf78aa36280f9b94f6751cb8de518b5a1384e082a9eb08d3fceecbc16940439a3d7dccd53c5c0ee5e4e8a6c8bb05"} build_url:https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/BKppjsUMStWkkK9-zRf1UA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57a269a747fb83dfc1c9bf7127528868a5a91164d981ef672ec8a55764d04613feb61a35acbdfee3177aca9143150d7b21b9928cf86ff44e7c510fa425b0c181", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b9555dbb6ebb70d142a5f15b467dd56dbc84036111fedb7193c89b40fe766aebe0416fd132411b974cceb0e02eb082606e87663558f65059343f5dfcba50d6a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f2673c4d6ab9bb1fa7a8541ff61f94b2914cf78aa36280f9b94f6751cb8de518b5a1384e082a9eb08d3fceecbc16940439a3d7dccd53c5c0ee5e4e8a6c8bb05"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 07:49:27.621922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:49:27.622605) ========= 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=33d5923976266a1c518c4bf7000001ab-1466605471.83036-30617924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:49:27.705294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 07:49:27.705747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 07:49:27.706057) ========= ========= Total master_lag: 0.23 =========