builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1466755451.92 results: success (0) buildid: 20160623223004 builduid: 946fb3c30087497dba4610c27ef407da revision: c12837f42f7e1038901e32833e4adb8f46f35e65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:11.916272) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:11.916883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:11.917224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:11.935894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:11.936210) ========= 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=923d835db2ba3686ebe126b700000192-1466755345.179609-416599024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 01:04:12-- 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% 225M=0s 2016-06-24 01:04:12 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101649 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:12.055064) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:12.055472) ========= 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=923d835db2ba3686ebe126b700000192-1466755345.179609-416599024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018413 ========= master_lag: 0.34 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:12.413547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 01:04:12.413956) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c12837f42f7e1038901e32833e4adb8f46f35e65 --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 c12837f42f7e1038901e32833e4adb8f46f35e65 --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=923d835db2ba3686ebe126b700000192-1466755345.179609-416599024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 01:04:13,344 truncating revision to first 12 chars 2016-06-24 01:04:13,344 Setting DEBUG logging. 2016-06-24 01:04:13,344 attempt 1/10 2016-06-24 01:04:13,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c12837f42f7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 01:04:14,278 unpacking tar archive at: mozilla-inbound-c12837f42f7e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.260697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 01:04:13.695849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:13.696489) ========= script_repo_revision: c12837f42f7e1038901e32833e4adb8f46f35e65 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:13.697457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:13.698198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 01:04:13.709000) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-24 01:04:13.709333) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=923d835db2ba3686ebe126b700000192-1466755345.179609-416599024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:04:14 INFO - MultiFileLogger online at 20160624 01:04:14 in /builds/slave/test 01:04:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:04:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:04:14 INFO - {'append_to_log': False, 01:04:14 INFO - 'base_work_dir': '/builds/slave/test', 01:04:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:04:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:04:14 INFO - 'branch': 'Mozilla-Inbound', 01:04:14 INFO - 'buildbot_json_path': 'buildprops.json', 01:04:14 INFO - 'config_files': ('talos/linux_config.py',), 01:04:14 INFO - 'default_actions': ('clobber', 01:04:14 INFO - 'read-buildbot-config', 01:04:14 INFO - 'download-and-extract', 01:04:14 INFO - 'populate-webroot', 01:04:14 INFO - 'create-virtualenv', 01:04:14 INFO - 'install', 01:04:14 INFO - 'run-tests'), 01:04:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:04:14 INFO - 'download_minidump_stackwalk': True, 01:04:14 INFO - 'download_symbols': 'ondemand', 01:04:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:04:14 INFO - 'tooltool.py': '/tools/tooltool.py', 01:04:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:04:14 INFO - '/tools/misc-python/virtualenv.py')}, 01:04:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:04:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:04:14 INFO - 'installer_path': 'installer.exe', 01:04:14 INFO - 'log_level': 'info', 01:04:14 INFO - 'log_name': 'talos', 01:04:14 INFO - 'log_to_console': True, 01:04:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:04:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:04:14 INFO - 'opt_config_files': (), 01:04:14 INFO - 'pip_index': False, 01:04:14 INFO - 'sps_profile': False, 01:04:14 INFO - 'sps_profile_interval': 0, 01:04:14 INFO - 'suite': 'dromaeojs-e10s', 01:04:14 INFO - 'system_bits': '32', 01:04:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:04:14 INFO - 'title': 'talos-linux64-ix-007', 01:04:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:04:14 INFO - 'use_talos_json': True, 01:04:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:04:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:04:14 INFO - 'work_dir': 'build'} 01:04:14 INFO - ##### 01:04:14 INFO - ##### Running clobber step. 01:04:14 INFO - ##### 01:04:14 INFO - Running pre-action listener: _resource_record_pre_action 01:04:14 INFO - Running main action method: clobber 01:04:14 INFO - rmtree: /builds/slave/test/build 01:04:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:04:15 INFO - Running post-action listener: _resource_record_post_action 01:04:15 INFO - ##### 01:04:15 INFO - ##### Finished clobber step (success) 01:04:15 INFO - ##### 01:04:15 INFO - ##### 01:04:15 INFO - ##### Running read-buildbot-config step. 01:04:15 INFO - ##### 01:04:15 INFO - Running pre-action listener: _resource_record_pre_action 01:04:15 INFO - Running main action method: read_buildbot_config 01:04:15 INFO - Using buildbot properties: 01:04:15 INFO - { 01:04:15 INFO - "project": "", 01:04:15 INFO - "product": "firefox", 01:04:15 INFO - "script_repo_revision": "production", 01:04:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:04:15 INFO - "repository": "", 01:04:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:04:15 INFO - "buildid": "20160623223004", 01:04:15 INFO - "pgo_build": "True", 01:04:15 INFO - "basedir": "/builds/slave/test", 01:04:15 INFO - "buildnumber": 1204, 01:04:15 INFO - "slavename": "talos-linux64-ix-007", 01:04:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:04:15 INFO - "platform": "ubuntu64_hw", 01:04:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:04:15 INFO - "branch": "mozilla-inbound", 01:04:15 INFO - "repo_path": "integration/mozilla-inbound", 01:04:15 INFO - "revision": "c12837f42f7e1038901e32833e4adb8f46f35e65", 01:04:15 INFO - "stage_platform": "linux64-pgo", 01:04:15 INFO - "builduid": "946fb3c30087497dba4610c27ef407da", 01:04:15 INFO - "slavebuilddir": "test" 01:04:15 INFO - } 01:04:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:04:15 INFO - Running post-action listener: _resource_record_post_action 01:04:15 INFO - ##### 01:04:15 INFO - ##### Finished read-buildbot-config step (success) 01:04:15 INFO - ##### 01:04:15 INFO - ##### 01:04:15 INFO - ##### Running download-and-extract step. 01:04:15 INFO - ##### 01:04:15 INFO - Running pre-action listener: _resource_record_pre_action 01:04:15 INFO - Running main action method: download_and_extract 01:04:15 INFO - mkdir: /builds/slave/test/build/tests 01:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:15 INFO - https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:04:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:04:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:04:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:16 INFO - Downloaded 1361 bytes. 01:04:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:04:16 INFO - Using the following test package requirements: 01:04:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:04:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:04:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:04:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:16 INFO - u'jsshell-linux-x86_64.zip'], 01:04:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:04:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:04:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:04:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:04:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:04:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:04:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:04:16 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')]} 01:04:16 INFO - https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:17 INFO - Downloaded 24270977 bytes. 01:04:17 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'] 01:04:17 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 01:04:18 INFO - Return code: 0 01:04:18 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 01:04:18 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')]} 01:04:18 INFO - https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:04:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:04:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:04:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:20 INFO - Downloaded 24270977 bytes. 01:04:20 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'] 01:04:20 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 01:04:21 INFO - Return code: 0 01:04:21 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')]} 01:04:21 INFO - https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:04:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:04:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:04:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:22 INFO - Downloaded 14405518 bytes. 01:04:22 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'] 01:04:22 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 01:04:23 INFO - Return code: 0 01:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:23 INFO - https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3iG28F2SCiHusE2eBolKQ/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 01:04:25 INFO - Downloaded 60174562 bytes. 01:04:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:04:25 INFO - mkdir: /builds/slave/test/properties 01:04:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:04:25 INFO - Writing to file /builds/slave/test/properties/build_url 01:04:25 INFO - Contents: 01:04:25 INFO - build_url:https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:04:26 INFO - Running post-action listener: _resource_record_post_action 01:04:26 INFO - Running post-action listener: set_extra_try_arguments 01:04:26 INFO - ##### 01:04:26 INFO - ##### Finished download-and-extract step (success) 01:04:26 INFO - ##### 01:04:26 INFO - ##### 01:04:26 INFO - ##### Running populate-webroot step. 01:04:26 INFO - ##### 01:04:26 INFO - Running pre-action listener: _resource_record_pre_action 01:04:26 INFO - Running main action method: populate_webroot 01:04:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:04:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:04:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:04:26 INFO - '--tppagecycles', 01:04:26 INFO - '7'], 01:04:26 INFO - 'tests': ['tsvgm']}}, 01:04:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:04:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:04:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:04:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:04:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:26 INFO - 'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:04:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:04:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:26 INFO - 'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['damp', 'tps']}, 01:04:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:26 INFO - 'tests': ['damp', 'tps']}, 01:04:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['dromaeo_dom']}, 01:04:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:04:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['basic_compositor_video']}, 01:04:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:04:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['a11yr', 01:04:26 INFO - 'ts_paint', 01:04:26 INFO - 'tpaint', 01:04:26 INFO - 'sessionrestore', 01:04:26 INFO - 'sessionrestore_no_auto_restore', 01:04:26 INFO - 'tabpaint']}, 01:04:26 INFO - 'other-e10s': {'tests': ['a11yr', 01:04:26 INFO - 'ts_paint', 01:04:26 INFO - 'tpaint', 01:04:26 INFO - 'sessionrestore', 01:04:26 INFO - 'sessionrestore_no_auto_restore', 01:04:26 INFO - 'tabpaint']}, 01:04:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:04:26 INFO - 'ts_paint', 01:04:26 INFO - 'tpaint', 01:04:26 INFO - 'sessionrestore', 01:04:26 INFO - 'sessionrestore_no_auto_restore', 01:04:26 INFO - 'tabpaint']}, 01:04:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:04:26 INFO - 'ts_paint', 01:04:26 INFO - 'tpaint', 01:04:26 INFO - 'sessionrestore', 01:04:26 INFO - 'sessionrestore_no_auto_restore', 01:04:26 INFO - 'tabpaint']}, 01:04:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['a11yr', 01:04:26 INFO - 'ts_paint', 01:04:26 INFO - 'tpaint', 01:04:26 INFO - 'sessionrestore', 01:04:26 INFO - 'sessionrestore_no_auto_restore', 01:04:26 INFO - 'tabpaint']}, 01:04:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['a11yr', 01:04:26 INFO - 'ts_paint', 01:04:26 INFO - 'tpaint', 01:04:26 INFO - 'sessionrestore', 01:04:26 INFO - 'sessionrestore_no_auto_restore', 01:04:26 INFO - 'tabpaint']}, 01:04:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['tsvgx', 01:04:26 INFO - 'tsvgr_opacity', 01:04:26 INFO - 'tart', 01:04:26 INFO - 'tscrollx', 01:04:26 INFO - 'cart']}, 01:04:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:04:26 INFO - 'tsvgr_opacity', 01:04:26 INFO - 'tart', 01:04:26 INFO - 'tscrollx', 01:04:26 INFO - 'cart']}, 01:04:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:26 INFO - 'talos_options': ['--disable-e10s'], 01:04:26 INFO - 'tests': ['tp5o']}, 01:04:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:26 INFO - 'tests': ['tp5o']}, 01:04:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:26 INFO - 'talos_options': ['--disable-e10s', 01:04:26 INFO - '--xperf_path', 01:04:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:04:26 INFO - 'tests': ['tp5n']}, 01:04:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:26 INFO - 'talos_options': ['--xperf_path', 01:04:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:04:26 INFO - 'tests': ['tp5n']}}, 01:04:26 INFO - 'talos.zip': {'path': '', 01:04:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:04:26 INFO - Running post-action listener: _resource_record_post_action 01:04:26 INFO - ##### 01:04:26 INFO - ##### Finished populate-webroot step (success) 01:04:26 INFO - ##### 01:04:26 INFO - ##### 01:04:26 INFO - ##### Running create-virtualenv step. 01:04:26 INFO - ##### 01:04:26 INFO - Running pre-action listener: _resource_record_pre_action 01:04:26 INFO - Running main action method: create_virtualenv 01:04:26 INFO - Creating virtualenv /builds/slave/test/build/venv 01:04:26 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 01:04:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:04:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:04:26 INFO - Using real prefix '/usr' 01:04:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:04:27 INFO - Installing distribute.............................................................................................................................................................................................done. 01:04:29 INFO - Installing pip.................done. 01:04:29 INFO - Return code: 0 01:04:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:04:29 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')]} 01:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:29 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')]} 01:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:29 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 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:29 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 01:04:29 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 01:04:29 INFO - Using env: {'DISPLAY': ':0', 01:04:29 INFO - 'HOME': '/home/cltbld', 01:04:29 INFO - 'LANG': 'en_US.UTF-8', 01:04:29 INFO - 'LANGUAGE': 'en_US:en', 01:04:29 INFO - 'LOGNAME': 'cltbld', 01:04:29 INFO - 'MAIL': '/var/mail/cltbld', 01:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:29 INFO - 'MOZ_NO_REMOTE': '1', 01:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:29 INFO - 'NO_EM_RESTART': '1', 01:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:29 INFO - 'PWD': '/builds/slave/test', 01:04:29 INFO - 'SHELL': '/bin/bash', 01:04:29 INFO - 'SHLVL': '1', 01:04:29 INFO - 'TERM': 'linux', 01:04:29 INFO - 'TMOUT': '86400', 01:04:29 INFO - 'USER': 'cltbld', 01:04:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:29 INFO - '_': '/tools/buildbot/bin/python'} 01:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:29 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 01:04:29 INFO - Cleaning up... 01:04:29 INFO - Return code: 0 01:04:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:04:29 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')]} 01:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:29 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')]} 01:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:29 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 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:29 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 01:04:29 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 01:04:29 INFO - Using env: {'DISPLAY': ':0', 01:04:29 INFO - 'HOME': '/home/cltbld', 01:04:29 INFO - 'LANG': 'en_US.UTF-8', 01:04:29 INFO - 'LANGUAGE': 'en_US:en', 01:04:29 INFO - 'LOGNAME': 'cltbld', 01:04:29 INFO - 'MAIL': '/var/mail/cltbld', 01:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:29 INFO - 'MOZ_NO_REMOTE': '1', 01:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:29 INFO - 'NO_EM_RESTART': '1', 01:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:29 INFO - 'PWD': '/builds/slave/test', 01:04:29 INFO - 'SHELL': '/bin/bash', 01:04:29 INFO - 'SHLVL': '1', 01:04:29 INFO - 'TERM': 'linux', 01:04:29 INFO - 'TMOUT': '86400', 01:04:29 INFO - 'USER': 'cltbld', 01:04:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:29 INFO - '_': '/tools/buildbot/bin/python'} 01:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:29 INFO - Downloading/unpacking psutil>=3.1.1 01:04:29 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 01:04:29 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 01:04:29 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 01:04:29 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 01:04:29 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 01:04:29 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 01:04:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:04:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:04:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:04:31 INFO - Installing collected packages: psutil 01:04:31 INFO - Running setup.py install for psutil 01:04:31 INFO - building 'psutil._psutil_linux' extension 01:04:31 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 01:04:32 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 01:04:32 INFO - building 'psutil._psutil_posix' extension 01:04:32 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 01:04:32 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 01:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:04:32 INFO - Successfully installed psutil 01:04:32 INFO - Cleaning up... 01:04:32 INFO - Return code: 0 01:04:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:04:32 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')]} 01:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:32 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')]} 01:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:32 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 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:32 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 01:04:32 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 01:04:32 INFO - Using env: {'DISPLAY': ':0', 01:04:32 INFO - 'HOME': '/home/cltbld', 01:04:32 INFO - 'LANG': 'en_US.UTF-8', 01:04:32 INFO - 'LANGUAGE': 'en_US:en', 01:04:32 INFO - 'LOGNAME': 'cltbld', 01:04:32 INFO - 'MAIL': '/var/mail/cltbld', 01:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:32 INFO - 'MOZ_NO_REMOTE': '1', 01:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:32 INFO - 'NO_EM_RESTART': '1', 01:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:32 INFO - 'PWD': '/builds/slave/test', 01:04:32 INFO - 'SHELL': '/bin/bash', 01:04:32 INFO - 'SHLVL': '1', 01:04:32 INFO - 'TERM': 'linux', 01:04:32 INFO - 'TMOUT': '86400', 01:04:32 INFO - 'USER': 'cltbld', 01:04:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:32 INFO - '_': '/tools/buildbot/bin/python'} 01:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:04:32 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 01:04:32 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 01:04:32 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 01:04:32 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 01:04:32 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 01:04:32 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 01:04:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:04:34 INFO - Installing collected packages: mozsystemmonitor 01:04:34 INFO - Running setup.py install for mozsystemmonitor 01:04:34 INFO - Successfully installed mozsystemmonitor 01:04:34 INFO - Cleaning up... 01:04:34 INFO - Return code: 0 01:04:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:04: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')]} 01:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04: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')]} 01:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:34 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 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:34 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 01:04:34 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 01:04:34 INFO - Using env: {'DISPLAY': ':0', 01:04:34 INFO - 'HOME': '/home/cltbld', 01:04:34 INFO - 'LANG': 'en_US.UTF-8', 01:04:34 INFO - 'LANGUAGE': 'en_US:en', 01:04:34 INFO - 'LOGNAME': 'cltbld', 01:04:34 INFO - 'MAIL': '/var/mail/cltbld', 01:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:34 INFO - 'MOZ_NO_REMOTE': '1', 01:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:34 INFO - 'NO_EM_RESTART': '1', 01:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:34 INFO - 'PWD': '/builds/slave/test', 01:04:34 INFO - 'SHELL': '/bin/bash', 01:04:34 INFO - 'SHLVL': '1', 01:04:34 INFO - 'TERM': 'linux', 01:04:34 INFO - 'TMOUT': '86400', 01:04:34 INFO - 'USER': 'cltbld', 01:04:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:34 INFO - '_': '/tools/buildbot/bin/python'} 01:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:34 INFO - Downloading/unpacking jsonschema==2.5.1 01:04:34 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 01:04:34 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 01:04:34 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 01:04:34 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 01:04:34 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 01:04:34 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 01:04:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:04:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:36 INFO - Downloading functools32-3.2.3-2.tar.gz 01:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:04:36 INFO - warning: no files found matching '*.txt' 01:04:36 INFO - no previously-included directories found matching 'build' 01:04:36 INFO - no previously-included directories found matching 'dist' 01:04:36 INFO - no previously-included directories found matching '.git*' 01:04:36 INFO - Installing collected packages: jsonschema, functools32 01:04:37 INFO - Running setup.py install for functools32 01:04:37 INFO - warning: no files found matching '*.txt' 01:04:37 INFO - no previously-included directories found matching 'build' 01:04:37 INFO - no previously-included directories found matching 'dist' 01:04:37 INFO - no previously-included directories found matching '.git*' 01:04:37 INFO - Successfully installed jsonschema functools32 01:04:37 INFO - Cleaning up... 01:04:37 INFO - Return code: 0 01:04:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:04:37 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')]} 01:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:37 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')]} 01:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:37 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 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:37 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 01:04:37 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 01:04:37 INFO - Using env: {'DISPLAY': ':0', 01:04:37 INFO - 'HOME': '/home/cltbld', 01:04:37 INFO - 'LANG': 'en_US.UTF-8', 01:04:37 INFO - 'LANGUAGE': 'en_US:en', 01:04:37 INFO - 'LOGNAME': 'cltbld', 01:04:37 INFO - 'MAIL': '/var/mail/cltbld', 01:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:37 INFO - 'MOZ_NO_REMOTE': '1', 01:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:37 INFO - 'NO_EM_RESTART': '1', 01:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:37 INFO - 'PWD': '/builds/slave/test', 01:04:37 INFO - 'SHELL': '/bin/bash', 01:04:37 INFO - 'SHLVL': '1', 01:04:37 INFO - 'TERM': 'linux', 01:04:37 INFO - 'TMOUT': '86400', 01:04:37 INFO - 'USER': 'cltbld', 01:04:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:37 INFO - '_': '/tools/buildbot/bin/python'} 01:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:37 INFO - Downloading/unpacking blobuploader==1.2.4 01:04:37 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 01:04:37 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 01:04:37 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 01:04:37 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 01:04:37 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 01:04:37 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 01:04:39 INFO - Downloading blobuploader-1.2.4.tar.gz 01:04:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:04:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:04:39 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 01:04:39 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 01:04:39 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 01:04:39 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 01:04:39 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 01:04:39 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 01:04:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:04:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:04:39 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 01:04:39 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 01:04:39 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 01:04:39 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 01:04:39 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 01:04:39 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 01:04:40 INFO - Downloading docopt-0.6.1.tar.gz 01:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:04:40 INFO - Installing collected packages: blobuploader, requests, docopt 01:04:40 INFO - Running setup.py install for blobuploader 01:04:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:04:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:04:40 INFO - Running setup.py install for requests 01:04:40 INFO - Running setup.py install for docopt 01:04:40 INFO - Successfully installed blobuploader requests docopt 01:04:40 INFO - Cleaning up... 01:04:40 INFO - Return code: 0 01:04:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:04:40 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')]} 01:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:40 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')]} 01:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:40 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 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:40 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 01:04:40 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 01:04:40 INFO - Using env: {'DISPLAY': ':0', 01:04:40 INFO - 'HOME': '/home/cltbld', 01:04:40 INFO - 'LANG': 'en_US.UTF-8', 01:04:40 INFO - 'LANGUAGE': 'en_US:en', 01:04:40 INFO - 'LOGNAME': 'cltbld', 01:04:40 INFO - 'MAIL': '/var/mail/cltbld', 01:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:40 INFO - 'MOZ_NO_REMOTE': '1', 01:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:40 INFO - 'NO_EM_RESTART': '1', 01:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:40 INFO - 'PWD': '/builds/slave/test', 01:04:40 INFO - 'SHELL': '/bin/bash', 01:04:40 INFO - 'SHLVL': '1', 01:04:40 INFO - 'TERM': 'linux', 01:04:40 INFO - 'TMOUT': '86400', 01:04:40 INFO - 'USER': 'cltbld', 01:04:40 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:40 INFO - '_': '/tools/buildbot/bin/python'} 01:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:04:41 INFO - Running setup.py (path:/tmp/pip-pMTgY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:04:41 INFO - Running setup.py (path:/tmp/pip-Htd3qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:04:41 INFO - Running setup.py (path:/tmp/pip-4CPfX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:04:41 INFO - Running setup.py (path:/tmp/pip-Megifx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:04:41 INFO - Running setup.py (path:/tmp/pip-TvGeti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:04:41 INFO - Running setup.py (path:/tmp/pip-xHaqWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:04:41 INFO - Running setup.py (path:/tmp/pip-ZOD0gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:04:41 INFO - Running setup.py (path:/tmp/pip-VMflR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:04:41 INFO - Running setup.py (path:/tmp/pip-_ZMIHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:04:41 INFO - Running setup.py (path:/tmp/pip-pDEFp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:04:41 INFO - Running setup.py (path:/tmp/pip-29t_Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:04:41 INFO - Running setup.py (path:/tmp/pip-LkTUu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:04:41 INFO - Running setup.py (path:/tmp/pip-vieM2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:04:41 INFO - Running setup.py (path:/tmp/pip-uIOAtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:04:42 INFO - Running setup.py (path:/tmp/pip-XnPQHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:04:42 INFO - Running setup.py (path:/tmp/pip-H_F0Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:04:42 INFO - Running setup.py (path:/tmp/pip-8CxUmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:04:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:04:42 INFO - Running setup.py install for manifestparser 01:04:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:04:42 INFO - Running setup.py install for mozcrash 01:04:42 INFO - Running setup.py install for mozdebug 01:04:42 INFO - Running setup.py install for mozdevice 01:04:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:04:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:04:42 INFO - Running setup.py install for mozfile 01:04:42 INFO - Running setup.py install for mozhttpd 01:04:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:04:42 INFO - Running setup.py install for mozinfo 01:04:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Running setup.py install for mozInstall 01:04:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Running setup.py install for mozleak 01:04:43 INFO - Running setup.py install for mozlog 01:04:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Running setup.py install for moznetwork 01:04:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Running setup.py install for mozprocess 01:04:43 INFO - Running setup.py install for mozprofile 01:04:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Running setup.py install for mozrunner 01:04:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:04:43 INFO - Running setup.py install for mozscreenshot 01:04:43 INFO - Running setup.py install for moztest 01:04:43 INFO - Running setup.py install for mozversion 01:04:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:04:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:04:44 INFO - Cleaning up... 01:04:44 INFO - Return code: 0 01:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:04: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')]} 01:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04: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')]} 01:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:44 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 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:44 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 01:04:44 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 01:04:44 INFO - Using env: {'DISPLAY': ':0', 01:04:44 INFO - 'HOME': '/home/cltbld', 01:04:44 INFO - 'LANG': 'en_US.UTF-8', 01:04:44 INFO - 'LANGUAGE': 'en_US:en', 01:04:44 INFO - 'LOGNAME': 'cltbld', 01:04:44 INFO - 'MAIL': '/var/mail/cltbld', 01:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:44 INFO - 'MOZ_NO_REMOTE': '1', 01:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:44 INFO - 'NO_EM_RESTART': '1', 01:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:44 INFO - 'PWD': '/builds/slave/test', 01:04:44 INFO - 'SHELL': '/bin/bash', 01:04:44 INFO - 'SHLVL': '1', 01:04:44 INFO - 'TERM': 'linux', 01:04:44 INFO - 'TMOUT': '86400', 01:04:44 INFO - 'USER': 'cltbld', 01:04:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:44 INFO - '_': '/tools/buildbot/bin/python'} 01:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:04:44 INFO - Running setup.py (path:/tmp/pip-iFX_nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:04:44 INFO - Running setup.py (path:/tmp/pip-ntjiKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:04:44 INFO - Running setup.py (path:/tmp/pip-2yhJcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:04:44 INFO - Running setup.py (path:/tmp/pip-dnnPt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:04:44 INFO - Running setup.py (path:/tmp/pip-cu_g6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:04:44 INFO - Running setup.py (path:/tmp/pip-pxIhyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:04:44 INFO - Running setup.py (path:/tmp/pip-u3YnuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:04:44 INFO - Running setup.py (path:/tmp/pip-aE8vz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:04:44 INFO - Running setup.py (path:/tmp/pip-FqHlL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:04:44 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)) 01:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:04:44 INFO - Running setup.py (path:/tmp/pip-3lOAg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:04:45 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)) 01:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:04:45 INFO - Running setup.py (path:/tmp/pip-bg5jrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:04:45 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)) 01:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:04:45 INFO - Running setup.py (path:/tmp/pip-xmKAzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:04:45 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)) 01:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:04:45 INFO - Running setup.py (path:/tmp/pip-OLnpO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:04:45 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)) 01:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:04:45 INFO - Running setup.py (path:/tmp/pip-CeWyTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:04:45 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)) 01:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:04:45 INFO - Running setup.py (path:/tmp/pip-FuAHEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:04:45 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)) 01:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:04:45 INFO - Running setup.py (path:/tmp/pip-hA419k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:04:45 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)) 01:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:04:45 INFO - Running setup.py (path:/tmp/pip-YkEMSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:04:45 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)) 01:04:45 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)) 01:04:45 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)) 01:04:45 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)) 01:04:45 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)) 01:04:45 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)) 01:04:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:04:45 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 01:04:45 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 01:04:45 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 01:04:45 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 01:04:45 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 01:04:45 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 01:04:47 INFO - Downloading blessings-1.6.tar.gz 01:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:04:47 INFO - Installing collected packages: blessings 01:04:47 INFO - Running setup.py install for blessings 01:04:47 INFO - Successfully installed blessings 01:04:47 INFO - Cleaning up... 01:04:47 INFO - Return code: 0 01:04:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:04:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:04:47 INFO - Reading from file tmpfile_stdout 01:04:47 INFO - Current package versions: 01:04:47 INFO - argparse == 1.2.1 01:04:47 INFO - blessings == 1.6 01:04:47 INFO - blobuploader == 1.2.4 01:04:47 INFO - docopt == 0.6.1 01:04:47 INFO - functools32 == 3.2.3-2 01:04:47 INFO - jsonschema == 2.5.1 01:04:47 INFO - manifestparser == 1.1 01:04:47 INFO - mozInstall == 1.12 01:04:47 INFO - mozcrash == 0.17 01:04:47 INFO - mozdebug == 0.1 01:04:47 INFO - mozdevice == 0.48 01:04:47 INFO - mozfile == 1.2 01:04:47 INFO - mozhttpd == 0.7 01:04:47 INFO - mozinfo == 0.9 01:04:47 INFO - mozleak == 0.1 01:04:47 INFO - mozlog == 3.2 01:04:47 INFO - moznetwork == 0.27 01:04:47 INFO - mozprocess == 0.22 01:04:47 INFO - mozprofile == 0.28 01:04:47 INFO - mozrunner == 6.11 01:04:47 INFO - mozscreenshot == 0.1 01:04:47 INFO - mozsystemmonitor == 0.3 01:04:47 INFO - moztest == 0.7 01:04:47 INFO - mozversion == 1.4 01:04:47 INFO - psutil == 3.1.1 01:04:47 INFO - requests == 1.2.3 01:04:47 INFO - wsgiref == 0.1.2 01:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:04:47 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')]} 01:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:47 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')]} 01:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:47 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 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:47 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 01:04:47 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 01:04:47 INFO - Using env: {'DISPLAY': ':0', 01:04:47 INFO - 'HOME': '/home/cltbld', 01:04:47 INFO - 'LANG': 'en_US.UTF-8', 01:04:47 INFO - 'LANGUAGE': 'en_US:en', 01:04:47 INFO - 'LOGNAME': 'cltbld', 01:04:47 INFO - 'MAIL': '/var/mail/cltbld', 01:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:47 INFO - 'MOZ_NO_REMOTE': '1', 01:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:47 INFO - 'NO_EM_RESTART': '1', 01:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:47 INFO - 'PWD': '/builds/slave/test', 01:04:47 INFO - 'SHELL': '/bin/bash', 01:04:47 INFO - 'SHLVL': '1', 01:04:47 INFO - 'TERM': 'linux', 01:04:47 INFO - 'TMOUT': '86400', 01:04:47 INFO - 'USER': 'cltbld', 01:04:47 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:47 INFO - '_': '/tools/buildbot/bin/python'} 01:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 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)) 01:04:48 INFO - Cleaning up... 01:04:48 INFO - Return code: 0 01:04:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:04:48 INFO - Using env: {'DISPLAY': ':0', 01:04:48 INFO - 'HOME': '/home/cltbld', 01:04:48 INFO - 'LANG': 'en_US.UTF-8', 01:04:48 INFO - 'LANGUAGE': 'en_US:en', 01:04:48 INFO - 'LOGNAME': 'cltbld', 01:04:48 INFO - 'MAIL': '/var/mail/cltbld', 01:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:48 INFO - 'MOZ_NO_REMOTE': '1', 01:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:48 INFO - 'NO_EM_RESTART': '1', 01:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:48 INFO - 'PWD': '/builds/slave/test', 01:04:48 INFO - 'SHELL': '/bin/bash', 01:04:48 INFO - 'SHLVL': '1', 01:04:48 INFO - 'TERM': 'linux', 01:04:48 INFO - 'TMOUT': '86400', 01:04:48 INFO - 'USER': 'cltbld', 01:04:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:48 INFO - '_': '/tools/buildbot/bin/python'} 01:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:04:48 INFO - Cleaning up... 01:04:48 INFO - Return code: 0 01:04:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2054a1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, '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': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', '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 01:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:04:48 INFO - Using env: {'DISPLAY': ':0', 01:04:48 INFO - 'HOME': '/home/cltbld', 01:04:48 INFO - 'LANG': 'en_US.UTF-8', 01:04:48 INFO - 'LANGUAGE': 'en_US:en', 01:04:48 INFO - 'LOGNAME': 'cltbld', 01:04:48 INFO - 'MAIL': '/var/mail/cltbld', 01:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:48 INFO - 'MOZ_NO_REMOTE': '1', 01:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:48 INFO - 'NO_EM_RESTART': '1', 01:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:48 INFO - 'PWD': '/builds/slave/test', 01:04:48 INFO - 'SHELL': '/bin/bash', 01:04:48 INFO - 'SHLVL': '1', 01:04:48 INFO - 'TERM': 'linux', 01:04:48 INFO - 'TMOUT': '86400', 01:04:48 INFO - 'USER': 'cltbld', 01:04:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:48 INFO - '_': '/tools/buildbot/bin/python'} 01:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:48 INFO - Downloading/unpacking flake8 01:04:48 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 01:04:48 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 01:04:48 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 01:04:48 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 01:04:48 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 01:04:48 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 01:04:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:04:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:04:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:50 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 01:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:04:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:04:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:04:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:04:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:04:51 INFO - no previously-included directories found matching 'docs/_build' 01:04:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:04:51 INFO - Running setup.py install for pep8 01:04:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:04:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:04:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:04:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:04:51 INFO - no previously-included directories found matching 'docs/_build' 01:04:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:04:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:04:51 INFO - Cleaning up... 01:04:51 INFO - Return code: 0 01:04:51 INFO - Running post-action listener: _resource_record_post_action 01:04:51 INFO - Running post-action listener: _start_resource_monitoring 01:04:51 INFO - Starting resource monitoring. 01:04:51 INFO - ##### 01:04:51 INFO - ##### Finished create-virtualenv step (success) 01:04:51 INFO - ##### 01:04:51 INFO - ##### 01:04:51 INFO - ##### Running install step. 01:04:51 INFO - ##### 01:04:51 INFO - Running pre-action listener: _resource_record_pre_action 01:04:51 INFO - Running main action method: install 01:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:04:51 INFO - Reading from file tmpfile_stdout 01:04:51 INFO - Detecting whether we're running mozinstall >=1.0... 01:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:04:51 INFO - Reading from file tmpfile_stdout 01:04:51 INFO - Output received: 01:04:51 INFO - Usage: mozinstall [options] installer 01:04:51 INFO - Options: 01:04:51 INFO - -h, --help show this help message and exit 01:04:51 INFO - -d DEST, --destination=DEST 01:04:51 INFO - Directory to install application into. [default: 01:04:51 INFO - "/builds/slave/test"] 01:04:51 INFO - --app=APP Application being installed. [default: firefox] 01:04:51 INFO - mkdir: /builds/slave/test/build/application 01:04:51 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'] 01:04:51 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 01:05:08 INFO - Reading from file tmpfile_stdout 01:05:08 INFO - Output received: 01:05:08 INFO - /builds/slave/test/build/application/firefox/firefox 01:05:08 INFO - Running post-action listener: _resource_record_post_action 01:05:08 INFO - ##### 01:05:08 INFO - ##### Finished install step (success) 01:05:08 INFO - ##### 01:05:08 INFO - ##### 01:05:08 INFO - ##### Running run-tests step. 01:05:08 INFO - ##### 01:05:08 INFO - Running pre-action listener: _resource_record_pre_action 01:05:08 INFO - Running main action method: run_tests 01:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:05:08 INFO - Python 2.7.3 01:05:08 INFO - Return code: 0 01:05:08 INFO - grabbing minidump binary from tooltool 01:05:08 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')]} 01:05:08 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 0x1dfa1c0>, '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 0x1dfb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:05:08 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 01:05:08 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 01:05:08 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 01:05:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:05:08 INFO - Return code: 0 01:05:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:05:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:05:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:05:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:05:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:05:09 INFO - Return code: 0 01:05:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:05:09 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:05:09 INFO - Using env: {'DISPLAY': ':0', 01:05:09 INFO - 'HOME': '/home/cltbld', 01:05:09 INFO - 'LANG': 'en_US.UTF-8', 01:05:09 INFO - 'LANGUAGE': 'en_US:en', 01:05:09 INFO - 'LOGNAME': 'cltbld', 01:05:09 INFO - 'MAIL': '/var/mail/cltbld', 01:05:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:05:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:09 INFO - 'MOZ_NO_REMOTE': '1', 01:05:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:09 INFO - 'NO_EM_RESTART': '1', 01:05:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:09 INFO - 'PWD': '/builds/slave/test', 01:05:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:05:09 INFO - 'SHELL': '/bin/bash', 01:05:09 INFO - 'SHLVL': '1', 01:05:09 INFO - 'TERM': 'linux', 01:05:09 INFO - 'TMOUT': '86400', 01:05:09 INFO - 'USER': 'cltbld', 01:05:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1466755345.179609-416599024', 01:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:09 INFO - '_': '/tools/buildbot/bin/python'} 01:05:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:05:09 INFO - mozversion application_buildid: 20160623223004 01:05:09 INFO - mozversion application_changeset: c12837f42f7e1038901e32833e4adb8f46f35e65 01:05:09 INFO - mozversion application_display_name: Nightly 01:05:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:05:09 INFO - mozversion application_name: Firefox 01:05:09 INFO - mozversion application_remotingname: firefox 01:05:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:05:09 INFO - mozversion application_vendor: Mozilla 01:05:09 INFO - mozversion application_version: 50.0a1 01:05:09 INFO - mozversion platform_buildid: 20160623223004 01:05:09 INFO - mozversion platform_changeset: c12837f42f7e1038901e32833e4adb8f46f35e65 01:05:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:05:09 INFO - mozversion platform_version: 50.0a1 01:05:09 INFO - using testdate: 1466755509 01:05:09 INFO - actual date: 1466755509 01:05:09 INFO - starting webserver on 'localhost:60842' 01:05:09 INFO - SUITE-START | Running 2 tests 01:05:09 INFO - TEST-START | dromaeo_css 01:05:09 INFO - operating with platform_type : linux_ 01:05:09 INFO - Initialising browser for dromaeo_css test... 01:05:09 INFO - TEST-INFO | started process 31667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmE0Cp9/profile http://localhost:60842/getInfo.html) 01:05:14 INFO - PROCESS | 31667 | __metrics Screen width/height:1600/1200 01:05:14 INFO - PROCESS | 31667 | colorDepth:24 01:05:14 INFO - PROCESS | 31667 | Browser inner width/height: 1024/697 01:05:14 INFO - PROCESS | 31667 | __metrics 01:05:15 ERROR - PROCESS | 31667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:05:15 INFO - TEST-INFO | 31667: exit 0 01:05:15 INFO - Browser initialized. 01:05:15 INFO - Running cycle 1/1 for dromaeo_css test... 01:05:15 INFO - TEST-INFO | started process 31788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmE0Cp9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:05:27 INFO - PROCESS | 31788 | RSS: Main: 185327616 01:05:27 INFO - PROCESS | 31788 | 01:06:17 INFO - PROCESS | 31788 | 1466755577476 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] 01:08:25 INFO - PROCESS | 31788 | Cycle 1(1): loaded http://localhost:60842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60842/tests/dromaeo/cssquery-ext.html) 01:08:26 INFO - PROCESS | 31788 | RSS: Main: 187654144 01:08:26 INFO - PROCESS | 31788 | 01:11:28 INFO - PROCESS | 31788 | Cycle 1(1): loaded http://localhost:60842/tests/dromaeo/cssquery-ext.html (next: http://localhost:60842/tests/dromaeo/cssquery-jquery.html) 01:11:29 INFO - PROCESS | 31788 | RSS: Main: 187228160 01:11:29 INFO - PROCESS | 31788 | 01:14:30 INFO - PROCESS | 31788 | Cycle 1(1): loaded http://localhost:60842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60842/tests/dromaeo/cssquery-mootools.html) 01:14:31 INFO - PROCESS | 31788 | RSS: Main: 188919808 01:14:31 INFO - PROCESS | 31788 | 01:17:33 INFO - PROCESS | 31788 | Cycle 1(1): loaded http://localhost:60842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60842/tests/dromaeo/cssquery-prototype.html) 01:17:33 INFO - PROCESS | 31788 | RSS: Main: 186376192 01:17:33 INFO - PROCESS | 31788 | 01:20:36 INFO - PROCESS | 31788 | Cycle 1(1): loaded http://localhost:60842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60842/tests/dromaeo/cssquery-yui.html) 01:20:36 INFO - PROCESS | 31788 | RSS: Main: 188002304 01:20:36 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | Cycle 1(1): loaded http://localhost:60842/tests/dromaeo/cssquery-yui.html (next: http://localhost:60842/tests/dromaeo/cssquery-dojo.html) 01:23:39 INFO - PROCESS | 31788 | RSS: Main: 189648896 01:23:39 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | __start_tp_report 01:23:39 INFO - PROCESS | 31788 | _x_x_mozilla_page_load 01:23:39 INFO - PROCESS | 31788 | _x_x_mozilla_page_load_details 01:23:39 INFO - PROCESS | 31788 | |i|pagename|runs| 01:23:39 INFO - PROCESS | 31788 | |0;dojo.html;3070.9865744304375;3143.5913331266947;3158.4156930967765;3170.746340292777;3177.285110850059;5403.783848646054;5439.755211015504;5473.31583552056;5574.777008919648;5576.944230557693;5399.433059528752;5518.6688798672;5528.834134975958;5531;5574.331080270374;4986.401631804189;5012.047710934929;5145.176771716526;5203.86990325243;5218.973905130469;359.21923914768377;5031.345925029741;5123.871903202413;5171.87070323243;5180.740962951856;5046.5710414614805;5059.696418214919;5068.341115654978;5075.061113693979;5099.337086178792;5004.099262132815;5076.263941728465;5120.84637460873;5149.201873709581;5155.871103222412;4973.602111831045;5067.974660126676;5070.594352451795;5096.3884333879805;5135.537801597837;5546.889062218774;5587.441255874421;5608.719564021823;5632.04255276604;5659.830205093854;5745.2818397700285;5965.075413310944;6004.279486461609;6011.909821352683;6029.306629737549;5973.193618861442;5978.730957106941;6017.518598512109;6040.214772079602;6084.908726369108;5556.91664625031;5569.443055694439;5612.214289999403;5619.578531610146;5620.606557540974;5931.436513531207;6019.759209631566;6065.60573562717;6094.055421409688;6139.017757158833;5902.439268269508;5902.911456328158;5908.763649454059;5909.497692696169;5915.526757859361;5909.409059094056;5928.258967629046;5933.110033494924;5939.198208241918;5944.791932282349;5592.440755924375;5888.440598143256;5893.852653683693;5972.701364931736;6005.3394126646035;5661.943380566224;5908.763649453974;5916.437938395846;5935.465808077293;5999.5800293979;4531.932021019687;4545.409096817392;4552.544745525487;4559.452865656142;4582.633389328846;3906.140649057203;3955;3985.04358953849;4010.438538604598;4020.1356708307853;5660.603757736919;5719.056355701346;5727.627704199297;5744.454276843693;5752.36723960364;6027.276726792726;6043.969780151071;6047.516198704093;6062.242219722535;6065.4541091302;5478.58910581708;5583.8883222336135;5620.072688006515;5642.689652069175;5653.462921022497;5100.719460429637;5108.795648174031;5117.8464646060675;5121.4622464641425;5124.564412024945;5989.161517387569;6136.969315153396;6138.557439001831;6145.4161854623735;6147.508199344042;5945.970270148621;5987.760489580455;6027.30685971119;6058.697065146813;6097.573169878244;6209.161763161916;6210.627362358092;6212.627242365473;6213.2233470816145;6217.378262173746;5679.346875109415;5855;5946.316173640087;5958.433948774859;5998.070299103646;5948.226730525004;6044.486218671462;6052.394760523913;6068.969655151696;6136.478399336106;5773.855653608525;5784;5820.883582328414;5829.621074630136;5874.530037596896;5544.3346798384455;5744.712764361849;5745.3105627324985;5820.214271073351;5840.123981402654;5471.234027236111;5610.410906854721;5644.407337229532;5646.774129034792;5779.942200577941;5846.152307915243;5878.853028674317;5880.882382352414;5894.322152952465;5898.262717160355;5553.694546799965;5670.064439367458;5697.658140511582;5764.106563482667;5778.711064446677 01:23:39 INFO - PROCESS | 31788 | |1;ext.html;569.3736889421637;607.7508221629136;614.4869034356312;626.6334194496219;634.9428551430371;42212.36681449777;43545.99999999996;43574.346384804216;43653;46692.29961550579;44968.775156124175;45457.545424545744;45578.772106139426;45589.54410455895;45599;8797.252233560155;8963.775905602379;8964.8655270171;8976.955115224415;9002.14479624438;8826.514541700204;8910.064443233465;8961.820763584725;8992.190702836744;9010.459372437643;8997.865032024525;9058.501782401965;9063;9076.546172691373;9111.134442227978;8932.374733768638;8960.820783584357;8974;9011.324150688659;9023.819523609523;8682.913170868274;8691.956540217321;8757.386982911199;8763.430377025537;8787.736367908972;42447.57552424467;42832;42902.57097429048;42958.57041429577;43005.784971075256;3345.7156141727737;3356.3622911646953;3456.3432947740102;3492.720582353431;3543.5924868640177;31044;32810.50784238215;32926;33354.6664533354;34347.828260858536;4121.258173528764;4152.6055024772595;4153.06556024895;4179.6029377209115;4312.956870431287;339782;341476;344200;344896.2755186233;347272;34564.82717586396;59644;59946.70026649926;59952;60047.09929351063;34918.825405872805;36160.457593136125;36612.450813237825;36726.816365918;36787.816060919526;14910.478133265284;15032;15058;15061.698766024618;15120.697586048218;12041.33772642513;12105.213161144497;12111.091668124925;12183.939080304543;12200.511979520898;8289.171082891784;8314.293285070717;8319.209675080858;8420.873686894702;8446.197611227046;3167.651558328582;3200.871965121369;3227.160938156096;3270.6238782539835;3299.290652509674;1000.674780696262;1035.9896401036044;1038.3147122899002;1112.666200139971;1113.4766659669942;31709.84145079306;32312.515312270334;32384.35231295408;32446.83776581102;32580.511292330633;1063.5958335832333;1071.3732466507024;1088.5808963548932;1091.2797553614575;1186.649938268213;16379.344826207056;16477.752833707505;16683.249253783608;16689.916550417413;16813.41153059637;539466;540031;542616;545397;546967;56686.43313566894;57040.71479642575;57267.42732572621;57565.712171439714;57632;1278.9232646041266;1284.9229046257256;1292.4636275945566;1297.7145028093805;1300.2523548959387;29324.266893326985;30065.398692026476;30238.69761302447;30391.54412683856;30860.84569577138;48625.75687121542;49241.50758492369;49250.75374623104;49489;49511.752441237564;438539;444286;444814;446347;451451.97096057236;28046.43907121887;28406.147815565568;28487.43025139527;28612.856935715186;28692.282692932007;46898.296525551465;47457.762711186224;47693.761531192125;48155.5184448165;49009;40355.838282433746;40882.1823563533;41457.37813932733;41755.37366939438;42179.57820421756;38760.41859372168;40175.1964960705;40643.59356406398;40818.591814081476;41236.79381603073;40767.59232407757;40776.3883541753;41433.58566414297;42359.576404235566;42395.5760442404;33108;35122.64877351194;35774.642253577134;36039.27921441504;36162.45756313605;27285.72714272832;27383;27441.72558274392;27666.308342291602;27898.44203115967 01:23:39 INFO - PROCESS | 31788 | |2;jquery.html;389.6493156159457;395.1208560951884;396.34998602292245;398.09036351935816;413.4480468574453;19072.23711051558;19711.11299991502;19730.802691973076;19934;20627.07178176982;17413.738793918103;18183.909080454614;18334.541636459096;18743.250269989217;19554.413367598958;5090.592752579803;5143.717095559743;5195.948040519594;5207.6875387476875;5399.487048730364;5107.46371630979;5144.022635699205;5154.561862241695;5166.844994650167;5179.067767801795;5173.456787037363;5328.92006619901;5333.280007199017;5339.439358867321;5386.192071189334;5334.546563542103;5343.171808369709;5356.169793681946;5374.247605335237;5387.515123638872;5011.298418221452;5183.092958732207;5211.739413029333;5213.452587478336;5240.580753539708;13345.199288042748;13928.51250206238;13974.860251397458;14131;14206.857931420656;2303.792658660712;2310.780475854791;2382.0709923129994;2479.3677612208953;2657.5880738485566;9399.295052871063;9785.657501987396;12650.493980240779;13741.90064794814;14251;1958.569114794743;1989.4031790462948;2062.5565503416838;2132.936011919645;2149.312220089572;78409;79793;80272.99999999942;80316.59841700754;81568.59215703883;10135.986401359953;10345.74135646615;10724.195685323632;10763.78472430547;11053.668389948154;14897.180655064076;15220;15282.694346113238;15298.929074964646;15313.617159570877;7668.923310766932;7851.646675899598;8062.435629505995;8068.47554908929;8248.917510824935;7832.412569057344;7839.568823714751;7842.137364889858;7923.762287131395;8088.191180881982;4619.960508885474;4646.744429056367;4647.094691176669;4715.95284047162;4724.976375118103;1964.3812199157219;1988.9403317900485;1990.3630838131949;2026.2502873936444;2033.1460786469718;945.7919257763281;960.2366118935463;1004.4977511244377;1051.553089936789;1063.6808957312776;19039.809601904082;19143.90428047851;19442.833429993963;19449.611007779764;20054.49863753418;935.7379933618598;956.4978386347084;981.8625392445064;989.1987490133015;1053.536443964653;10659;10944.890551094546;11053.668389948314;11087.944560277147;11098.889011109786;443197;449590;452423;471314;474167;85024;89286;89668.5516572426;95581.13256602314;97746.5112674432;925.6991477769752;929.159111004542;950.4344914775836;952.1763674421713;967.666155176463;17344;17827;18208.36270730518;18402.26390944347;18490;30065.849670751508;33035.834820825745;42312.36531451969;43043;43083.630400328286;53825.73087134696;57677.71161144335;59037;60286.698566506886;60854;8159.510429374256;8624.353173512138;8686.78283042929;8719.171678690514;8721.607527661143;12657.746845063231;13636.318184090558;13778.379972901042;13892.444302227797;13987.860121398655;11414.429278536207;11520.654380368602;12310.153476978167;12329.383530823243;12376.81434778497;12001.579944701894;12113.939430302793;12242.571509997108;12322.753544928872;12619.116661833583;12113.515459381526;12184.878151218374;12506.437210325375;12637.368131593568;12773.808392873929;7624.618769061635;7794.4543881929985;8679.349048821237;8789.780255493664;8957.059508751749;9003.864942026006;11964.880351196725;12310.446029928495;12345.135840491439;12485.250884946932 01:23:39 INFO - PROCESS | 31788 | |3;mootools.html;1456.6504039030633;1469.61789934617;1587.6030992251938;1712.1268153241858;1736.2100244388805;7825.56959367236;8222.671093156274;8234.629441675124;8886.866696999543;8897.199252067321;8519.74440766778;8889.68886088987;8896.644134234639;8900.065493123226;8903.688370907019;2269.614165591845;2281.6577513372963;2294.0823670531754;2301.2060839010596;2312.8034117100065;2222.733272007353;2274.4200228941595;2278.043221846828;2300.5283916797016;2316.7683231676783;2206.6248737714545;2267.4784799496124;2268.920587779428;2286.4398222435525;2303.7465878753405;2197.659362798761;2216.3240211735497;2221.6556433752635;2222.977770222293;2234.653628687556;2197.813185879202;2224.8331375146927;2231.520223152014;2232.3303009097367;2235.6646503024513;8965.462072275619;8971.461712297283;8989.865152022725;8990.460572365613;9045.728628141167;5172.586193104543;5204.68771873685;5236;5255.76349064293;5306.814261500867;3215.340855124694;3249.447593909041;3397.9490307645406;3413.7269018478464;3429.1941393772445;1099;1110.4669758515877;1130.9773804523945;1143.4511434511398;1155.624422062833;12266.141370104096;12271.57049503263;12277.263364198177;12368;12536.310502922335;4626.930596041062;4650.930236046462;4752.431697539803;4753.548412900769;4788.928166077511;10463.006014428769;10514.421706806199;10577.100946419487;10579.523921423555;10610.787784244272;5140.871478213;5143.871403214875;5152.793888244429;5153.665011774223;5164.509371609691;4248.9787551062045;4538.1377538267625;4679.99380133273;4695.413073365829;4860.246661767361;3998.6001399859783;4051.5340735815757;4058.066644671742;4064.7561146331313;4248.936265955951;1269.6571925580042;1280.4366078925243;1283.9619396996395;1288.330068364464;1308.8429388473444;847.3771777743353;879.8020445399734;921.9627918591584;926.7266156483853;949.8052899155656;5894.145348924382;5900.822975310747;5920.111983202554;6020.5740109410435;6180.381961803783;951.5765484359393;972.3582435592616;973.6154219083422;998.9712087551592;1010.6109147977934;3874.4188371744463;3982.900427489336;4000.139969906484;4005.679545636342;4039.2527382434346;10154.492275386201;10435.530401131968;10561.10230630405;10568.841467377995;10571.20715946307;10479.738006549896;10488.737781555523;10504.054635082879;10509.369437833755;10548.47257637115;7711.845763084707;7847.568383738949;7882.330001949784;7966.243206895336;7975.202479751978;5870.589058765845;5982.910256346246;6054.515638748801;6090.604110732788;6140.9692951536745;9464.053594640482;9808.558614862206;9897.55461004271;9929.751756206153;9965.950170249102;9893.455859927773;10013.048760368045;10071.899281007389;10072.84890726625;10192.541335640062;6580.1116849224745;6694.129763130762;6914.585124892523;6984.196817366068;7063.223045464892;8456.196661317164;8472.915270847212;8498.53258070812;8548.871766923377;8557.101504341954;7695.730649427243;7804.375649948104;7826.960865195865;7827.726029588937;8071.434999549975;7639.312461878458;7683.116441609063;7689.692412303669;7774.805629859299;7865.960670196612;7092.255313192247;7124.3944264736;7145.4640901931525;7156.284371562802;7169.677364518505;4938;5038.697678139323;5051.949480505295;5135.127028405254;5175.430702622633;5096.770645321044;5103.336566246364;5137.974310128426;5180.248863914787;5206.791728330976 01:23:39 INFO - PROCESS | 31788 | |4;prototype.html;317.9333336655521;325.0913696219067;325.55886773422003;332.2076846720571;332.9417351963406;5659.943400565993;5704.315482142144;5759.654420734749;5762.2797150356255;5782.624129431584;5625.268715067035;5627.7467513961865;5636.802711905084;5648.6893220872835;5652.63257888237;4162.604552567509;4210.97894510527;4290.270653988814;4315.611594956454;4316.417283666696;4262.445882035331;4287.957120428802;4287.978560107211;4305.203537345601;4320.848770293024;4286.314189729628;4286.635635970931;4294.613484786369;4306.504751953534;4319.568043195687;4043.342229685815;4240.300350442173;4251.213525497762;4256.34026725858;4339.175556644227;3665.193657395369;3689.7417180797356;3693.984154357573;3727.329080765461;3733.2720119576693;5510.724463776795;5526.944730552683;5527.198556209368;5533;5571.693556854371;4818;4857.781399837016;4894.339264199323;4924.409070911478;4945.357103576512;5804.390538993429;5839.562032847553;5865.472107510344;5890.1753754473975;5925.614835035709;4027.7986100694848;4055.574164712692;4076.9184616307507;4107.8973025674295;4123.649489793341;5928.555358348098;6134.355892631299;6141.6007959482495;6143.385661433866;6265.968670156665;4126.566710495415;4134.400511925754;4135.193637240769;4135.276326642826;4140.482439695038;4162.812673429642;4166.312558427886;4181.226473102486;4188.497380314321;4189.539150693421;4607;4886.804527818847;4896.338994235733;4901.215805471179;4913.140200464904;5888.793892213752;5909.556783241274;5913.02435098204;5926.644401335933;5951.732172052268;1413.4628841040544;1432.1192466632945;1445.1112565771975;1445.2990299704634;1448.1166488442043;875.4834647557844;923.298293297099;934.845750451168;945.9479728614992;951.3578334624101;5609.49514543693;5681.318241811009;5695.829125126253;5740.598158128891;5744.827655170351;6027.758889644453;6047.637141771508;6052.243469566304;6079.784043191379;6092.623876688095;5516.393196748354;5669.206311116447;5677.630953987978;5712.742926568314;5787.739551720183;3210.6307774605752;3223.5003574446;3249.23642943908;3260.8206548639578;3286.5234540991423;6105.786297479567;6209.130721698965;6211.09939058834;6239.656818875005;6265.8746825063245;6099.542534309856;6119.84700382494;6135.355787642234;6171.6297022178815;6178.752849885954;6076.422739839708;6220.284667263322;6229.595076320024;6250.249970003629;6252.874942501125;5963.7912673056235;5973.850653733692;5984.970075149597;6039.245094363205;6081.665508397081;5916.112583112567;5931.822045338474;6008.24896887889;6014.9097763534455;6027.517798576016;5991.670458124845;6067.908981365194;6114.38856114385;6188.226471691039;6208.348123446973;4012.632546797287;4044.2922488564973;4053.5946405359227;4057.289974254553;4072.2466343726505;5930.495907847881;6013.849653758516;6019.789307374396;6033.487153591994;6054.636721796706;5830.82507524775;5830.970845145747;5845.678487683218;5884.264466941632;5907.85230369227;5836.795712150224;5843.474087332161;5862.413758624274;5876.529877609695;5905.468507834144;5282.498162674539;5710.942890571041;5746.683932383759;5769.423057694197;5805.094694982733;5813.56398270123;5885.499732522783;5940.198073260054;5947.494462970523;5979.4917432018765;5541.226807421586;5733.168690539932;5779.797707080232;5817.621854579439;5856.770078283608 01:23:39 INFO - PROCESS | 31788 | |5;yui.html;752.5371896283783;762.9313361797438;769.8806684963832;792.5522080024786;813.304624546013;15314.770278445832;15547.844521554782;16313;16603.41888033919;16629.50111496654;14525.92737036316;14792.40830366784;14800.40798368064;14804.40782368704;14806;763.4312437234269;775.4959276470283;777.5956502618635;780.6135962698472;801.9759407217792;786.728578640371;791.8376732769797;792.8057625881638;798.4251339035885;799;831.5260301628074;832.9333653307721;835.7283882738135;836.1972506393869;839.2698352433391;820.5774026376391;823.5100115431309;825.1006403020737;828.6519661742083;833.3749687734199;600.9399060093999;605.1527860994598;607.0833042106407;607.9240094988127;609.9756009759604;15480.5355839325;15529.844701552953;15593.220338983005;15615.609609759733;15649.687006259812;14258.287085645676;14417.495387661382;14596.400259261127;14672.339744711513;14675.853241467556;11622.244554103956;11642.18504704671;11713.53145874164;11724.824127638092;11751.588694395741;3795.7153213509096;3856.633619806114;3950.9012274693364;4005.5794141615293;4068;74192;75639;75674;76211;76245;10865.402402867918;10935.945320273348;11089.112870970303;11160.665180044612;11275.210735248618;22487.66268505974;22517.32448026562;22560.323190304316;22568.21011264598;22647;8280;8374.995000599967;8407.537585432738;8543.316534677211;8551.914480855112;4581.217705006222;4635.384400167874;4657.580817726421;4686.859394218179;4892.779824907888;3720.2373513429684;3868.941965870514;3871.825767840454;3881.6312450317173;3893.0267433141717;644.887144749667;662.6355504472617;664.9035889795953;668.7057694614355;678.3928384096305;703.7783098324012;724.5362967700676;724.8006798130451;733.5484414573835;748.1770052941721;9007.504587247764;9306.208972237435;9327.860082098774;9362.438253704799;9533.713988580354;659.7558903205748;677.2414895317178;706.9505134640526;717.9317964793337;726.284609659485;4428.955710442919;4458.331250312479;4544.54793864808;4651.906961860744;4694.155052090657;108361.6303038153;110837;111563;112204;116287.41856290834;84080;84503;86646.56676716576;96224;97207.51396242973;83877;86323;86599.5670021646;87421.56289218513;87788;8910.376273660782;9672.516374181121;9694.660686875926;9773;9816.361936474392;50974.74512627413;51594.74202629113;51943.2208516865;52381.02380273868;54140.917181656936;50331.49668503268;63767.68116159389;66115.66942165258;70679;74373;11651.650450486499;11799.115066369885;11831.76336473283;11962.521499139937;12024.519019239482;14456.638584035063;14563.199024053778;14649.194294313915;14749.705005899606;14789.852101478848;13722;13919.93040034834;14098.929505352407;14547.709045818812;14560.344784484936;13947.651308717363;14092.224927629079;14100.435982560582;14115.51230795293;14304.07023543508;13080.28058456794;13540.119892206974;13575;13671.589852304447;13796.310184490936;9851.359661621971;9908.455034973145;10437.739056523647;10463.633772818219;10504.78990420172;9889.307748457539;10286.948565257126;10303.227257955834;10353.689389318333;10376.221783366127 01:23:39 INFO - PROCESS | 31788 | __end_tp_report 01:23:39 INFO - PROCESS | 31788 | __start_cc_report 01:23:39 INFO - PROCESS | 31788 | _x_x_mozilla_cycle_collect,345 01:23:39 INFO - PROCESS | 31788 | __end_cc_report 01:23:39 INFO - PROCESS | 31788 | __startTimestamp1466756619805__endTimestamp 01:23:39 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | ------- Summary: start ------- 01:23:39 INFO - PROCESS | 31788 | Number of tests: 6 01:23:39 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | [#0] dojo.html Cycles:165 Average:5501.38 Median:5719.06 stddev:758.95 (13.3%) stddev-sans-first:736.94 01:23:39 INFO - PROCESS | 31788 | Values: 3071.0 3143.6 3158.4 3170.7 3177.3 5403.8 5439.8 5473.3 5574.8 5576.9 5399.4 5518.7 5528.8 5531.0 5574.3 4986.4 5012.0 5145.2 5203.9 5219.0 359.2 5031.3 5123.9 5171.9 5180.7 5046.6 5059.7 5068.3 5075.1 5099.3 5004.1 5076.3 5120.8 5149.2 5155.9 4973.6 5068.0 5070.6 5096.4 5135.5 5546.9 5587.4 5608.7 5632.0 5659.8 5745.3 5965.1 6004.3 6011.9 6029.3 5973.2 5978.7 6017.5 6040.2 6084.9 5556.9 5569.4 5612.2 5619.6 5620.6 5931.4 6019.8 6065.6 6094.1 6139.0 5902.4 5902.9 5908.8 5909.5 5915.5 5909.4 5928.3 5933.1 5939.2 5944.8 5592.4 5888.4 5893.9 5972.7 6005.3 5661.9 5908.8 5916.4 5935.5 5999.6 4531.9 4545.4 4552.5 4559.5 4582.6 3906.1 3955.0 3985.0 4010.4 4020.1 5660.6 5719.1 5727.6 5744.5 5752.4 6027.3 6044.0 6047.5 6062.2 6065.5 5478.6 5583.9 5620.1 5642.7 5653.5 5100.7 5108.8 5117.8 5121.5 5124.6 5989.2 6137.0 6138.6 6145.4 6147.5 5946.0 5987.8 6027.3 6058.7 6097.6 6209.2 6210.6 6212.6 6213.2 6217.4 5679.3 5855.0 5946.3 5958.4 5998.1 5948.2 6044.5 6052.4 6069.0 6136.5 5773.9 5784.0 5820.9 5829.6 5874.5 5544.3 5744.7 5745.3 5820.2 5840.1 5471.2 5610.4 5644.4 5646.8 5779.9 5846.2 5878.9 5880.9 5894.3 5898.3 5553.7 5670.1 5697.7 5764.1 5778.7 01:23:39 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | [#1] ext.html Cycles:180 Average:59182.87 Median:41335.19 stddev:119951.31 (290.2%) stddev-sans-first:120207.07 01:23:39 INFO - PROCESS | 31788 | Values: 569.4 607.8 614.5 626.6 634.9 42212.4 43546.0 43574.3 43653.0 46692.3 44968.8 45457.5 45578.8 45589.5 45599.0 8797.3 8963.8 8964.9 8977.0 9002.1 8826.5 8910.1 8961.8 8992.2 9010.5 8997.9 9058.5 9063.0 9076.5 9111.1 8932.4 8960.8 8974.0 9011.3 9023.8 8682.9 8692.0 8757.4 8763.4 8787.7 42447.6 42832.0 42902.6 42958.6 43005.8 3345.7 3356.4 3456.3 3492.7 3543.6 31044.0 32810.5 32926.0 33354.7 34347.8 4121.3 4152.6 4153.1 4179.6 4313.0 339782.0 341476.0 344200.0 344896.3 347272.0 34564.8 59644.0 59946.7 59952.0 60047.1 34918.8 36160.5 36612.5 36726.8 36787.8 14910.5 15032.0 15058.0 15061.7 15120.7 12041.3 12105.2 12111.1 12183.9 12200.5 8289.2 8314.3 8319.2 8420.9 8446.2 3167.7 3200.9 3227.2 3270.6 3299.3 1000.7 1036.0 1038.3 1112.7 1113.5 31709.8 32312.5 32384.4 32446.8 32580.5 1063.6 1071.4 1088.6 1091.3 1186.6 16379.3 16477.8 16683.2 16689.9 16813.4 539466.0 540031.0 542616.0 545397.0 546967.0 56686.4 57040.7 57267.4 57565.7 57632.0 1278.9 1284.9 1292.5 1297.7 1300.3 29324.3 30065.4 30238.7 30391.5 30860.8 48625.8 49241.5 49250.8 49489.0 49511.8 438539.0 444286.0 444814.0 446347.0 451452.0 28046.4 28406.1 28487.4 28612.9 28692.3 46898.3 47457.8 47693.8 48155.5 49009.0 40355.8 40882.2 41457.4 41755.4 42179.6 38760.4 40175.2 40643.6 40818.6 41236.8 40767.6 40776.4 41433.6 42359.6 42395.6 33108.0 35122.6 35774.6 36039.3 36162.5 27285.7 27383.0 27441.7 27666.3 27898.4 01:23:39 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | [#2] jquery.html Cycles:180 Average:27781.92 Median:397.22 stddev:75750.17 (19070.1%) stddev-sans-first:75934.74 01:23:39 INFO - PROCESS | 31788 | Values: 389.6 395.1 396.3 398.1 413.4 19072.2 19711.1 19730.8 19934.0 20627.1 17413.7 18183.9 18334.5 18743.3 19554.4 5090.6 5143.7 5195.9 5207.7 5399.5 5107.5 5144.0 5154.6 5166.8 5179.1 5173.5 5328.9 5333.3 5339.4 5386.2 5334.5 5343.2 5356.2 5374.2 5387.5 5011.3 5183.1 5211.7 5213.5 5240.6 13345.2 13928.5 13974.9 14131.0 14206.9 2303.8 2310.8 2382.1 2479.4 2657.6 9399.3 9785.7 12650.5 13741.9 14251.0 1958.6 1989.4 2062.6 2132.9 2149.3 78409.0 79793.0 80273.0 80316.6 81568.6 10136.0 10345.7 10724.2 10763.8 11053.7 14897.2 15220.0 15282.7 15298.9 15313.6 7668.9 7851.6 8062.4 8068.5 8248.9 7832.4 7839.6 7842.1 7923.8 8088.2 4620.0 4646.7 4647.1 4716.0 4725.0 1964.4 1988.9 1990.4 2026.3 2033.1 945.8 960.2 1004.5 1051.6 1063.7 19039.8 19143.9 19442.8 19449.6 20054.5 935.7 956.5 981.9 989.2 1053.5 10659.0 10944.9 11053.7 11087.9 11098.9 443197.0 449590.0 452423.0 471314.0 474167.0 85024.0 89286.0 89668.6 95581.1 97746.5 925.7 929.2 950.4 952.2 967.7 17344.0 17827.0 18208.4 18402.3 18490.0 30065.8 33035.8 42312.4 43043.0 43083.6 53825.7 57677.7 59037.0 60286.7 60854.0 8159.5 8624.4 8686.8 8719.2 8721.6 12657.7 13636.3 13778.4 13892.4 13987.9 11414.4 11520.7 12310.2 12329.4 12376.8 12001.6 12113.9 12242.6 12322.8 12619.1 12113.5 12184.9 12506.4 12637.4 12773.8 7624.6 7794.5 8679.3 8789.8 8957.1 9003.9 11964.9 12310.4 12345.1 12485.3 01:23:39 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | [#3] mootools.html Cycles:180 Average:5733.33 Median:4988.35 stddev:3253.08 (65.2%) stddev-sans-first:3246.33 01:23:39 INFO - PROCESS | 31788 | Values: 1456.7 1469.6 1587.6 1712.1 1736.2 7825.6 8222.7 8234.6 8886.9 8897.2 8519.7 8889.7 8896.6 8900.1 8903.7 2269.6 2281.7 2294.1 2301.2 2312.8 2222.7 2274.4 2278.0 2300.5 2316.8 2206.6 2267.5 2268.9 2286.4 2303.7 2197.7 2216.3 2221.7 2223.0 2234.7 2197.8 2224.8 2231.5 2232.3 2235.7 8965.5 8971.5 8989.9 8990.5 9045.7 5172.6 5204.7 5236.0 5255.8 5306.8 3215.3 3249.4 3397.9 3413.7 3429.2 1099.0 1110.5 1131.0 1143.5 1155.6 12266.1 12271.6 12277.3 12368.0 12536.3 4626.9 4650.9 4752.4 4753.5 4788.9 10463.0 10514.4 10577.1 10579.5 10610.8 5140.9 5143.9 5152.8 5153.7 5164.5 4249.0 4538.1 4680.0 4695.4 4860.2 3998.6 4051.5 4058.1 4064.8 4248.9 1269.7 1280.4 1284.0 1288.3 1308.8 847.4 879.8 922.0 926.7 949.8 5894.1 5900.8 5920.1 6020.6 6180.4 951.6 972.4 973.6 999.0 1010.6 3874.4 3982.9 4000.1 4005.7 4039.3 10154.5 10435.5 10561.1 10568.8 10571.2 10479.7 10488.7 10504.1 10509.4 10548.5 7711.8 7847.6 7882.3 7966.2 7975.2 5870.6 5982.9 6054.5 6090.6 6141.0 9464.1 9808.6 9897.6 9929.8 9966.0 9893.5 10013.0 10071.9 10072.8 10192.5 6580.1 6694.1 6914.6 6984.2 7063.2 8456.2 8472.9 8498.5 8548.9 8557.1 7695.7 7804.4 7827.0 7827.7 8071.4 7639.3 7683.1 7689.7 7774.8 7866.0 7092.3 7124.4 7145.5 7156.3 7169.7 4938.0 5038.7 5051.9 5135.1 5175.4 5096.8 5103.3 5138.0 5180.2 5206.8 01:23:39 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | [#4] prototype.html Cycles:180 Average:4912.05 Median:5711.84 stddev:1485.66 (26.0%) stddev-sans-first:1449.26 01:23:39 INFO - PROCESS | 31788 | Values: 317.9 325.1 325.6 332.2 332.9 5659.9 5704.3 5759.7 5762.3 5782.6 5625.3 5627.7 5636.8 5648.7 5652.6 4162.6 4211.0 4290.3 4315.6 4316.4 4262.4 4288.0 4288.0 4305.2 4320.8 4286.3 4286.6 4294.6 4306.5 4319.6 4043.3 4240.3 4251.2 4256.3 4339.2 3665.2 3689.7 3694.0 3727.3 3733.3 5510.7 5526.9 5527.2 5533.0 5571.7 4818.0 4857.8 4894.3 4924.4 4945.4 5804.4 5839.6 5865.5 5890.2 5925.6 4027.8 4055.6 4076.9 4107.9 4123.6 5928.6 6134.4 6141.6 6143.4 6266.0 4126.6 4134.4 4135.2 4135.3 4140.5 4162.8 4166.3 4181.2 4188.5 4189.5 4607.0 4886.8 4896.3 4901.2 4913.1 5888.8 5909.6 5913.0 5926.6 5951.7 1413.5 1432.1 1445.1 1445.3 1448.1 875.5 923.3 934.8 945.9 951.4 5609.5 5681.3 5695.8 5740.6 5744.8 6027.8 6047.6 6052.2 6079.8 6092.6 5516.4 5669.2 5677.6 5712.7 5787.7 3210.6 3223.5 3249.2 3260.8 3286.5 6105.8 6209.1 6211.1 6239.7 6265.9 6099.5 6119.8 6135.4 6171.6 6178.8 6076.4 6220.3 6229.6 6250.2 6252.9 5963.8 5973.9 5985.0 6039.2 6081.7 5916.1 5931.8 6008.2 6014.9 6027.5 5991.7 6067.9 6114.4 6188.2 6208.3 4012.6 4044.3 4053.6 4057.3 4072.2 5930.5 6013.8 6019.8 6033.5 6054.6 5830.8 5831.0 5845.7 5884.3 5907.9 5836.8 5843.5 5862.4 5876.5 5905.5 5282.5 5710.9 5746.7 5769.4 5805.1 5813.6 5885.5 5940.2 5947.5 5979.5 5541.2 5733.2 5779.8 5817.6 5856.8 01:23:39 INFO - PROCESS | 31788 | 01:23:39 INFO - PROCESS | 31788 | [#5] yui.html Cycles:180 Average:20191.92 Median:4793.47 stddev:28611.36 (596.9%) stddev-sans-first:28654.39 01:23:39 INFO - PROCESS | 31788 | Values: 752.5 762.9 769.9 792.6 813.3 15314.8 15547.8 16313.0 16603.4 16629.5 14525.9 14792.4 14800.4 14804.4 14806.0 763.4 775.5 777.6 780.6 802.0 786.7 791.8 792.8 798.4 799.0 831.5 832.9 835.7 836.2 839.3 820.6 823.5 825.1 828.7 833.4 600.9 605.2 607.1 607.9 610.0 15480.5 15529.8 15593.2 15615.6 15649.7 14258.3 14417.5 14596.4 14672.3 14675.9 11622.2 11642.2 11713.5 11724.8 11751.6 3795.7 3856.6 3950.9 4005.6 4068.0 74192.0 75639.0 75674.0 76211.0 76245.0 10865.4 10935.9 11089.1 11160.7 11275.2 22487.7 22517.3 22560.3 22568.2 22647.0 8280.0 8375.0 8407.5 8543.3 8551.9 4581.2 4635.4 4657.6 4686.9 4892.8 3720.2 3868.9 3871.8 3881.6 3893.0 644.9 662.6 664.9 668.7 678.4 703.8 724.5 724.8 733.5 748.2 9007.5 9306.2 9327.9 9362.4 9533.7 659.8 677.2 707.0 717.9 726.3 4429.0 4458.3 4544.5 4651.9 4694.2 108361.6 110837.0 111563.0 112204.0 116287.4 84080.0 84503.0 86646.6 96224.0 97207.5 83877.0 86323.0 86599.6 87421.6 87788.0 8910.4 9672.5 9694.7 9773.0 9816.4 50974.7 51594.7 51943.2 52381.0 54140.9 50331.5 63767.7 66115.7 70679.0 74373.0 11651.7 11799.1 11831.8 11962.5 12024.5 14456.6 14563.2 14649.2 14749.7 14789.9 13722.0 13919.9 14098.9 14547.7 14560.3 13947.7 14092.2 14100.4 14115.5 14304.1 13080.3 13540.1 13575.0 13671.6 13796.3 9851.4 9908.5 10437.7 10463.6 10504.8 9889.3 10286.9 10303.2 10353.7 10376.2 01:23:39 INFO - PROCESS | 31788 | -------- Summary: end -------- 01:23:39 INFO - PROCESS | 31788 | 01:23:40 INFO - TEST-INFO | 31788: exit 0 01:23:40 INFO - TEST-OK | dromaeo_css | took 1110560ms 01:23:40 INFO - TEST-START | kraken 01:23:40 INFO - operating with platform_type : linux_ 01:23:40 INFO - Initialising browser for kraken test... 01:23:40 INFO - TEST-INFO | started process 32022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cndZP/profile http://localhost:60842/getInfo.html) 01:23:44 INFO - PROCESS | 32022 | __metrics Screen width/height:1600/1200 01:23:44 INFO - PROCESS | 32022 | colorDepth:24 01:23:44 INFO - PROCESS | 32022 | Browser inner width/height: 1024/697 01:23:44 INFO - PROCESS | 32022 | __metrics 01:23:45 ERROR - PROCESS | 32022 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:23:46 INFO - TEST-INFO | 32022: exit 0 01:23:46 INFO - Browser initialized. 01:23:46 INFO - Running cycle 1/1 for kraken test... 01:23:46 INFO - TEST-INFO | started process 32140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cndZP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:23:58 INFO - PROCESS | 32140 | RSS: Main: 184942592 01:23:58 INFO - PROCESS | 32140 | 01:24:00 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60842/tests/kraken/driver.html?testName=audio-beat-detection) 01:24:01 INFO - PROCESS | 32140 | RSS: Main: 190160896 01:24:01 INFO - PROCESS | 32140 | 01:24:04 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60842/tests/kraken/driver.html?testName=audio-dft) 01:24:04 INFO - PROCESS | 32140 | RSS: Main: 189333504 01:24:04 INFO - PROCESS | 32140 | 01:24:07 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60842/tests/kraken/driver.html?testName=audio-fft) 01:24:08 INFO - PROCESS | 32140 | RSS: Main: 184291328 01:24:08 INFO - PROCESS | 32140 | 01:24:10 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60842/tests/kraken/driver.html?testName=audio-oscillator) 01:24:11 INFO - PROCESS | 32140 | RSS: Main: 185212928 01:24:11 INFO - PROCESS | 32140 | 01:24:13 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:24:13 INFO - PROCESS | 32140 | RSS: Main: 185831424 01:24:13 INFO - PROCESS | 32140 | 01:24:17 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60842/tests/kraken/driver.html?testName=imaging-darkroom) 01:24:17 INFO - PROCESS | 32140 | RSS: Main: 185991168 01:24:17 INFO - PROCESS | 32140 | 01:24:21 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60842/tests/kraken/driver.html?testName=imaging-desaturate) 01:24:21 INFO - PROCESS | 32140 | RSS: Main: 183205888 01:24:21 INFO - PROCESS | 32140 | 01:24:24 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60842/tests/kraken/driver.html?testName=json-parse-financial) 01:24:25 INFO - PROCESS | 32140 | RSS: Main: 184975360 01:24:25 INFO - PROCESS | 32140 | 01:24:26 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:24:27 INFO - PROCESS | 32140 | RSS: Main: 185159680 01:24:27 INFO - PROCESS | 32140 | 01:24:29 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60842/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:24:29 INFO - PROCESS | 32140 | RSS: Main: 185577472 01:24:29 INFO - PROCESS | 32140 | 01:24:31 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:24:32 INFO - PROCESS | 32140 | RSS: Main: 185774080 01:24:32 INFO - PROCESS | 32140 | 01:24:35 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:24:35 INFO - PROCESS | 32140 | RSS: Main: 186200064 01:24:35 INFO - PROCESS | 32140 | 01:24:38 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:24:39 INFO - PROCESS | 32140 | RSS: Main: 185954304 01:24:39 INFO - PROCESS | 32140 | 01:24:40 INFO - PROCESS | 32140 | Cycle 1(1): loaded http://localhost:60842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60842/tests/kraken/driver.html?testName=ai-astar) 01:24:41 INFO - PROCESS | 32140 | RSS: Main: 186785792 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | __start_tp_report 01:24:41 INFO - PROCESS | 32140 | _x_x_mozilla_page_load 01:24:41 INFO - PROCESS | 32140 | _x_x_mozilla_page_load_details 01:24:41 INFO - PROCESS | 32140 | |i|pagename|runs| 01:24:41 INFO - PROCESS | 32140 | |0;ai-astar;102;111;105;111;111;112;113;111;112;111 01:24:41 INFO - PROCESS | 32140 | |1;audio-beat-detection;164;124;156;183;127;154;161;128;189;127 01:24:41 INFO - PROCESS | 32140 | |2;audio-dft;161;161;162;161;164;172;163;162;163;162 01:24:41 INFO - PROCESS | 32140 | |3;audio-fft;75;76;77;155;79;77;74;76;169;76 01:24:41 INFO - PROCESS | 32140 | |4;audio-oscillator;85;85;146;87;86;85;136;86;85;144 01:24:41 INFO - PROCESS | 32140 | |5;imaging-gaussian-blur;125;117;116;117;118;117;118;118;118;118 01:24:41 INFO - PROCESS | 32140 | |6;imaging-darkroom;150;147;147;149;146;148;148;147;147;149 01:24:41 INFO - PROCESS | 32140 | |7;imaging-desaturate;97;96;96;96;95;95;95;96;96;95 01:24:41 INFO - PROCESS | 32140 | |8;json-parse-financial;54;55;54;53;54;53;55;54;63;54 01:24:41 INFO - PROCESS | 32140 | |9;json-stringify-tinderbox;62;61;61;64;63;62;62;62;61;62 01:24:41 INFO - PROCESS | 32140 | |10;stanford-crypto-aes;81;78;82;80;80;80;82;80;136;79 01:24:41 INFO - PROCESS | 32140 | |11;stanford-crypto-ccm;129;122;129;123;120;124;132;125;135;124 01:24:41 INFO - PROCESS | 32140 | |12;stanford-crypto-pbkdf2;162;162;161;168;164;163;161;156;159;158 01:24:41 INFO - PROCESS | 32140 | |13;stanford-crypto-sha256-iterative;68;63;63;63;64;63;63;62;64;62 01:24:41 INFO - PROCESS | 32140 | __end_tp_report 01:24:41 INFO - PROCESS | 32140 | __start_cc_report 01:24:41 INFO - PROCESS | 32140 | _x_x_mozilla_cycle_collect,885 01:24:41 INFO - PROCESS | 32140 | __end_cc_report 01:24:41 INFO - PROCESS | 32140 | __startTimestamp1466756681190__endTimestamp 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | ------- Summary: start ------- 01:24:41 INFO - PROCESS | 32140 | Number of tests: 14 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.51 (3.2%) stddev-sans-first:2.28 01:24:41 INFO - PROCESS | 32140 | Values: 102.0 111.0 105.0 111.0 111.0 112.0 113.0 111.0 112.0 111.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:158.50 stddev:23.99 (15.1%) stddev-sans-first:25.00 01:24:41 INFO - PROCESS | 32140 | Values: 164.0 124.0 156.0 183.0 127.0 154.0 161.0 128.0 189.0 127.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:3.28 (2.0%) stddev-sans-first:3.39 01:24:41 INFO - PROCESS | 32140 | Values: 161.0 161.0 162.0 161.0 164.0 172.0 163.0 162.0 163.0 162.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:36.33 (47.8%) stddev-sans-first:37.92 01:24:41 INFO - PROCESS | 32140 | Values: 75.0 76.0 77.0 155.0 79.0 77.0 74.0 76.0 169.0 76.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:27.38 (32.2%) stddev-sans-first:28.30 01:24:41 INFO - PROCESS | 32140 | Values: 85.0 85.0 146.0 87.0 86.0 85.0 136.0 86.0 85.0 144.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:2.49 (2.1%) stddev-sans-first:0.73 01:24:41 INFO - PROCESS | 32140 | Values: 125.0 117.0 116.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:1.01 01:24:41 INFO - PROCESS | 32140 | Values: 150.0 147.0 147.0 149.0 146.0 148.0 148.0 147.0 147.0 149.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 01:24:41 INFO - PROCESS | 32140 | Values: 97.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:2.92 (5.4%) stddev-sans-first:3.08 01:24:41 INFO - PROCESS | 32140 | Values: 54.0 55.0 54.0 53.0 54.0 53.0 55.0 54.0 63.0 54.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 01:24:41 INFO - PROCESS | 32140 | Values: 62.0 61.0 61.0 64.0 63.0 62.0 62.0 62.0 61.0 62.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:80.00 stddev:17.68 (22.1%) stddev-sans-first:18.67 01:24:41 INFO - PROCESS | 32140 | Values: 81.0 78.0 82.0 80.0 80.0 80.0 82.0 80.0 136.0 79.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.00 stddev:4.76 (3.7%) stddev-sans-first:4.95 01:24:41 INFO - PROCESS | 32140 | Values: 129.0 122.0 129.0 123.0 120.0 124.0 132.0 125.0 135.0 124.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:3.34 (2.1%) stddev-sans-first:3.54 01:24:41 INFO - PROCESS | 32140 | Values: 162.0 162.0 161.0 168.0 164.0 163.0 161.0 156.0 159.0 158.0 01:24:41 INFO - PROCESS | 32140 | 01:24:41 INFO - PROCESS | 32140 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:1.72 (2.7%) stddev-sans-first:0.71 01:24:41 INFO - PROCESS | 32140 | Values: 68.0 63.0 63.0 63.0 64.0 63.0 63.0 62.0 64.0 62.0 01:24:41 INFO - PROCESS | 32140 | -------- Summary: end -------- 01:24:41 INFO - PROCESS | 32140 | 01:24:42 INFO - TEST-INFO | 32140: exit 0 01:24:42 INFO - TEST-OK | kraken | took 61567ms 01:24:42 INFO - SUITE-END | took 1172s 01:24:42 INFO - Completed test suite (00:19:32) 01:24:42 INFO - javascript benchmark 01:24:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7210.478751714272, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.9865744304375, 3143.5913331266947, 3158.4156930967765, 3170.746340292777, 3177.285110850059, 5403.783848646054, 5439.755211015504, 5473.31583552056, 5574.777008919648, 5576.944230557693, 5399.433059528752, 5518.6688798672, 5528.834134975958, 5531.0, 5574.331080270374, 4986.401631804189, 5012.047710934929, 5145.176771716526, 5203.86990325243, 5218.973905130469, 359.21923914768377, 5031.345925029741, 5123.871903202413, 5171.87070323243, 5180.740962951856, 5046.5710414614805, 5059.696418214919, 5068.341115654978, 5075.061113693979, 5099.337086178792, 5004.099262132815, 5076.263941728465, 5120.84637460873, 5149.201873709581, 5155.871103222412, 4973.602111831045, 5067.974660126676, 5070.594352451795, 5096.3884333879805, 5135.537801597837, 5546.889062218774, 5587.441255874421, 5608.719564021823, 5632.04255276604, 5659.830205093854, 5745.2818397700285, 5965.075413310944, 6004.279486461609, 6011.909821352683, 6029.306629737549, 5973.193618861442, 5978.730957106941, 6017.518598512109, 6040.214772079602, 6084.908726369108, 5556.91664625031, 5569.443055694439, 5612.214289999403, 5619.578531610146, 5620.606557540974, 5931.436513531207, 6019.759209631566, 6065.60573562717, 6094.055421409688, 6139.017757158833, 5902.439268269508, 5902.911456328158, 5908.763649454059, 5909.497692696169, 5915.526757859361, 5909.409059094056, 5928.258967629046, 5933.110033494924, 5939.198208241918, 5944.791932282349, 5592.440755924375, 5888.440598143256, 5893.852653683693, 5972.701364931736, 6005.3394126646035, 5661.943380566224, 5908.763649453974, 5916.437938395846, 5935.465808077293, 5999.5800293979, 4531.932021019687, 4545.409096817392, 4552.544745525487, 4559.452865656142, 4582.633389328846, 3906.140649057203, 3955.0, 3985.04358953849, 4010.438538604598, 4020.1356708307853, 5660.603757736919, 5719.056355701346, 5727.627704199297, 5744.454276843693, 5752.36723960364, 6027.276726792726, 6043.969780151071, 6047.516198704093, 6062.242219722535, 6065.4541091302, 5478.58910581708, 5583.8883222336135, 5620.072688006515, 5642.689652069175, 5653.462921022497, 5100.719460429637, 5108.795648174031, 5117.8464646060675, 5121.4622464641425, 5124.564412024945, 5989.161517387569, 6136.969315153396, 6138.557439001831, 6145.4161854623735, 6147.508199344042, 5945.970270148621, 5987.760489580455, 6027.30685971119, 6058.697065146813, 6097.573169878244, 6209.161763161916, 6210.627362358092, 6212.627242365473, 6213.2233470816145, 6217.378262173746, 5679.346875109415, 5855.0, 5946.316173640087, 5958.433948774859, 5998.070299103646, 5948.226730525004, 6044.486218671462, 6052.394760523913, 6068.969655151696, 6136.478399336106, 5773.855653608525, 5784.0, 5820.883582328414, 5829.621074630136, 5874.530037596896, 5544.3346798384455, 5744.712764361849, 5745.3105627324985, 5820.214271073351, 5840.123981402654, 5471.234027236111, 5610.410906854721, 5644.407337229532, 5646.774129034792, 5779.942200577941, 5846.152307915243, 5878.853028674317, 5880.882382352414, 5894.322152952465, 5898.262717160355, 5553.694546799965, 5670.064439367458, 5697.658140511582, 5764.106563482667, 5778.711064446677], "value": 5451.145852460637, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3736889421637, 607.7508221629136, 614.4869034356312, 626.6334194496219, 634.9428551430371, 42212.36681449777, 43545.99999999996, 43574.346384804216, 43653.0, 46692.29961550579, 44968.775156124175, 45457.545424545744, 45578.772106139426, 45589.54410455895, 45599.0, 8797.252233560155, 8963.775905602379, 8964.8655270171, 8976.955115224415, 9002.14479624438, 8826.514541700204, 8910.064443233465, 8961.820763584725, 8992.190702836744, 9010.459372437643, 8997.865032024525, 9058.501782401965, 9063.0, 9076.546172691373, 9111.134442227978, 8932.374733768638, 8960.820783584357, 8974.0, 9011.324150688659, 9023.819523609523, 8682.913170868274, 8691.956540217321, 8757.386982911199, 8763.430377025537, 8787.736367908972, 42447.57552424467, 42832.0, 42902.57097429048, 42958.57041429577, 43005.784971075256, 3345.7156141727737, 3356.3622911646953, 3456.3432947740102, 3492.720582353431, 3543.5924868640177, 31044.0, 32810.50784238215, 32926.0, 33354.6664533354, 34347.828260858536, 4121.258173528764, 4152.6055024772595, 4153.06556024895, 4179.6029377209115, 4312.956870431287, 339782.0, 341476.0, 344200.0, 344896.2755186233, 347272.0, 34564.82717586396, 59644.0, 59946.70026649926, 59952.0, 60047.09929351063, 34918.825405872805, 36160.457593136125, 36612.450813237825, 36726.816365918, 36787.816060919526, 14910.478133265284, 15032.0, 15058.0, 15061.698766024618, 15120.697586048218, 12041.33772642513, 12105.213161144497, 12111.091668124925, 12183.939080304543, 12200.511979520898, 8289.171082891784, 8314.293285070717, 8319.209675080858, 8420.873686894702, 8446.197611227046, 3167.651558328582, 3200.871965121369, 3227.160938156096, 3270.6238782539835, 3299.290652509674, 1000.674780696262, 1035.9896401036044, 1038.3147122899002, 1112.666200139971, 1113.4766659669942, 31709.84145079306, 32312.515312270334, 32384.35231295408, 32446.83776581102, 32580.511292330633, 1063.5958335832333, 1071.3732466507024, 1088.5808963548932, 1091.2797553614575, 1186.649938268213, 16379.344826207056, 16477.752833707505, 16683.249253783608, 16689.916550417413, 16813.41153059637, 539466.0, 540031.0, 542616.0, 545397.0, 546967.0, 56686.43313566894, 57040.71479642575, 57267.42732572621, 57565.712171439714, 57632.0, 1278.9232646041266, 1284.9229046257256, 1292.4636275945566, 1297.7145028093805, 1300.2523548959387, 29324.266893326985, 30065.398692026476, 30238.69761302447, 30391.54412683856, 30860.84569577138, 48625.75687121542, 49241.50758492369, 49250.75374623104, 49489.0, 49511.752441237564, 438539.0, 444286.0, 444814.0, 446347.0, 451451.97096057236, 28046.43907121887, 28406.147815565568, 28487.43025139527, 28612.856935715186, 28692.282692932007, 46898.296525551465, 47457.762711186224, 47693.761531192125, 48155.5184448165, 49009.0, 40355.838282433746, 40882.1823563533, 41457.37813932733, 41755.37366939438, 42179.57820421756, 38760.41859372168, 40175.1964960705, 40643.59356406398, 40818.591814081476, 41236.79381603073, 40767.59232407757, 40776.3883541753, 41433.58566414297, 42359.576404235566, 42395.5760442404, 33108.0, 35122.64877351194, 35774.642253577134, 36039.27921441504, 36162.45756313605, 27285.72714272832, 27383.0, 27441.72558274392, 27666.308342291602, 27898.44203115967], "value": 18785.16165727968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.6493156159457, 395.1208560951884, 396.34998602292245, 398.09036351935816, 413.4480468574453, 19072.23711051558, 19711.11299991502, 19730.802691973076, 19934.0, 20627.07178176982, 17413.738793918103, 18183.909080454614, 18334.541636459096, 18743.250269989217, 19554.413367598958, 5090.592752579803, 5143.717095559743, 5195.948040519594, 5207.6875387476875, 5399.487048730364, 5107.46371630979, 5144.022635699205, 5154.561862241695, 5166.844994650167, 5179.067767801795, 5173.456787037363, 5328.92006619901, 5333.280007199017, 5339.439358867321, 5386.192071189334, 5334.546563542103, 5343.171808369709, 5356.169793681946, 5374.247605335237, 5387.515123638872, 5011.298418221452, 5183.092958732207, 5211.739413029333, 5213.452587478336, 5240.580753539708, 13345.199288042748, 13928.51250206238, 13974.860251397458, 14131.0, 14206.857931420656, 2303.792658660712, 2310.780475854791, 2382.0709923129994, 2479.3677612208953, 2657.5880738485566, 9399.295052871063, 9785.657501987396, 12650.493980240779, 13741.90064794814, 14251.0, 1958.569114794743, 1989.4031790462948, 2062.5565503416838, 2132.936011919645, 2149.312220089572, 78409.0, 79793.0, 80272.99999999942, 80316.59841700754, 81568.59215703883, 10135.986401359953, 10345.74135646615, 10724.195685323632, 10763.78472430547, 11053.668389948154, 14897.180655064076, 15220.0, 15282.694346113238, 15298.929074964646, 15313.617159570877, 7668.923310766932, 7851.646675899598, 8062.435629505995, 8068.47554908929, 8248.917510824935, 7832.412569057344, 7839.568823714751, 7842.137364889858, 7923.762287131395, 8088.191180881982, 4619.960508885474, 4646.744429056367, 4647.094691176669, 4715.95284047162, 4724.976375118103, 1964.3812199157219, 1988.9403317900485, 1990.3630838131949, 2026.2502873936444, 2033.1460786469718, 945.7919257763281, 960.2366118935463, 1004.4977511244377, 1051.553089936789, 1063.6808957312776, 19039.809601904082, 19143.90428047851, 19442.833429993963, 19449.611007779764, 20054.49863753418, 935.7379933618598, 956.4978386347084, 981.8625392445064, 989.1987490133015, 1053.536443964653, 10659.0, 10944.890551094546, 11053.668389948314, 11087.944560277147, 11098.889011109786, 443197.0, 449590.0, 452423.0, 471314.0, 474167.0, 85024.0, 89286.0, 89668.5516572426, 95581.13256602314, 97746.5112674432, 925.6991477769752, 929.159111004542, 950.4344914775836, 952.1763674421713, 967.666155176463, 17344.0, 17827.0, 18208.36270730518, 18402.26390944347, 18490.0, 30065.849670751508, 33035.834820825745, 42312.36531451969, 43043.0, 43083.630400328286, 53825.73087134696, 57677.71161144335, 59037.0, 60286.698566506886, 60854.0, 8159.510429374256, 8624.353173512138, 8686.78283042929, 8719.171678690514, 8721.607527661143, 12657.746845063231, 13636.318184090558, 13778.379972901042, 13892.444302227797, 13987.860121398655, 11414.429278536207, 11520.654380368602, 12310.153476978167, 12329.383530823243, 12376.81434778497, 12001.579944701894, 12113.939430302793, 12242.571509997108, 12322.753544928872, 12619.116661833583, 12113.515459381526, 12184.878151218374, 12506.437210325375, 12637.368131593568, 12773.808392873929, 7624.618769061635, 7794.4543881929985, 8679.349048821237, 8789.780255493664, 8957.059508751749, 9003.864942026006, 11964.880351196725, 12310.446029928495, 12345.135840491439, 12485.250884946932], "value": 9031.779201289046, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.6504039030633, 1469.61789934617, 1587.6030992251938, 1712.1268153241858, 1736.2100244388805, 7825.56959367236, 8222.671093156274, 8234.629441675124, 8886.866696999543, 8897.199252067321, 8519.74440766778, 8889.68886088987, 8896.644134234639, 8900.065493123226, 8903.688370907019, 2269.614165591845, 2281.6577513372963, 2294.0823670531754, 2301.2060839010596, 2312.8034117100065, 2222.733272007353, 2274.4200228941595, 2278.043221846828, 2300.5283916797016, 2316.7683231676783, 2206.6248737714545, 2267.4784799496124, 2268.920587779428, 2286.4398222435525, 2303.7465878753405, 2197.659362798761, 2216.3240211735497, 2221.6556433752635, 2222.977770222293, 2234.653628687556, 2197.813185879202, 2224.8331375146927, 2231.520223152014, 2232.3303009097367, 2235.6646503024513, 8965.462072275619, 8971.461712297283, 8989.865152022725, 8990.460572365613, 9045.728628141167, 5172.586193104543, 5204.68771873685, 5236.0, 5255.76349064293, 5306.814261500867, 3215.340855124694, 3249.447593909041, 3397.9490307645406, 3413.7269018478464, 3429.1941393772445, 1099.0, 1110.4669758515877, 1130.9773804523945, 1143.4511434511398, 1155.624422062833, 12266.141370104096, 12271.57049503263, 12277.263364198177, 12368.0, 12536.310502922335, 4626.930596041062, 4650.930236046462, 4752.431697539803, 4753.548412900769, 4788.928166077511, 10463.006014428769, 10514.421706806199, 10577.100946419487, 10579.523921423555, 10610.787784244272, 5140.871478213, 5143.871403214875, 5152.793888244429, 5153.665011774223, 5164.509371609691, 4248.9787551062045, 4538.1377538267625, 4679.99380133273, 4695.413073365829, 4860.246661767361, 3998.6001399859783, 4051.5340735815757, 4058.066644671742, 4064.7561146331313, 4248.936265955951, 1269.6571925580042, 1280.4366078925243, 1283.9619396996395, 1288.330068364464, 1308.8429388473444, 847.3771777743353, 879.8020445399734, 921.9627918591584, 926.7266156483853, 949.8052899155656, 5894.145348924382, 5900.822975310747, 5920.111983202554, 6020.5740109410435, 6180.381961803783, 951.5765484359393, 972.3582435592616, 973.6154219083422, 998.9712087551592, 1010.6109147977934, 3874.4188371744463, 3982.900427489336, 4000.139969906484, 4005.679545636342, 4039.2527382434346, 10154.492275386201, 10435.530401131968, 10561.10230630405, 10568.841467377995, 10571.20715946307, 10479.738006549896, 10488.737781555523, 10504.054635082879, 10509.369437833755, 10548.47257637115, 7711.845763084707, 7847.568383738949, 7882.330001949784, 7966.243206895336, 7975.202479751978, 5870.589058765845, 5982.910256346246, 6054.515638748801, 6090.604110732788, 6140.9692951536745, 9464.053594640482, 9808.558614862206, 9897.55461004271, 9929.751756206153, 9965.950170249102, 9893.455859927773, 10013.048760368045, 10071.899281007389, 10072.84890726625, 10192.541335640062, 6580.1116849224745, 6694.129763130762, 6914.585124892523, 6984.196817366068, 7063.223045464892, 8456.196661317164, 8472.915270847212, 8498.53258070812, 8548.871766923377, 8557.101504341954, 7695.730649427243, 7804.375649948104, 7826.960865195865, 7827.726029588937, 8071.434999549975, 7639.312461878458, 7683.116441609063, 7689.692412303669, 7774.805629859299, 7865.960670196612, 7092.255313192247, 7124.3944264736, 7145.4640901931525, 7156.284371562802, 7169.677364518505, 4938.0, 5038.697678139323, 5051.949480505295, 5135.127028405254, 5175.430702622633, 5096.770645321044, 5103.336566246364, 5137.974310128426, 5180.248863914787, 5206.791728330976], "value": 4590.691014814307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9333336655521, 325.0913696219067, 325.55886773422003, 332.2076846720571, 332.9417351963406, 5659.943400565993, 5704.315482142144, 5759.654420734749, 5762.2797150356255, 5782.624129431584, 5625.268715067035, 5627.7467513961865, 5636.802711905084, 5648.6893220872835, 5652.63257888237, 4162.604552567509, 4210.97894510527, 4290.270653988814, 4315.611594956454, 4316.417283666696, 4262.445882035331, 4287.957120428802, 4287.978560107211, 4305.203537345601, 4320.848770293024, 4286.314189729628, 4286.635635970931, 4294.613484786369, 4306.504751953534, 4319.568043195687, 4043.342229685815, 4240.300350442173, 4251.213525497762, 4256.34026725858, 4339.175556644227, 3665.193657395369, 3689.7417180797356, 3693.984154357573, 3727.329080765461, 3733.2720119576693, 5510.724463776795, 5526.944730552683, 5527.198556209368, 5533.0, 5571.693556854371, 4818.0, 4857.781399837016, 4894.339264199323, 4924.409070911478, 4945.357103576512, 5804.390538993429, 5839.562032847553, 5865.472107510344, 5890.1753754473975, 5925.614835035709, 4027.7986100694848, 4055.574164712692, 4076.9184616307507, 4107.8973025674295, 4123.649489793341, 5928.555358348098, 6134.355892631299, 6141.6007959482495, 6143.385661433866, 6265.968670156665, 4126.566710495415, 4134.400511925754, 4135.193637240769, 4135.276326642826, 4140.482439695038, 4162.812673429642, 4166.312558427886, 4181.226473102486, 4188.497380314321, 4189.539150693421, 4607.0, 4886.804527818847, 4896.338994235733, 4901.215805471179, 4913.140200464904, 5888.793892213752, 5909.556783241274, 5913.02435098204, 5926.644401335933, 5951.732172052268, 1413.4628841040544, 1432.1192466632945, 1445.1112565771975, 1445.2990299704634, 1448.1166488442043, 875.4834647557844, 923.298293297099, 934.845750451168, 945.9479728614992, 951.3578334624101, 5609.49514543693, 5681.318241811009, 5695.829125126253, 5740.598158128891, 5744.827655170351, 6027.758889644453, 6047.637141771508, 6052.243469566304, 6079.784043191379, 6092.623876688095, 5516.393196748354, 5669.206311116447, 5677.630953987978, 5712.742926568314, 5787.739551720183, 3210.6307774605752, 3223.5003574446, 3249.23642943908, 3260.8206548639578, 3286.5234540991423, 6105.786297479567, 6209.130721698965, 6211.09939058834, 6239.656818875005, 6265.8746825063245, 6099.542534309856, 6119.84700382494, 6135.355787642234, 6171.6297022178815, 6178.752849885954, 6076.422739839708, 6220.284667263322, 6229.595076320024, 6250.249970003629, 6252.874942501125, 5963.7912673056235, 5973.850653733692, 5984.970075149597, 6039.245094363205, 6081.665508397081, 5916.112583112567, 5931.822045338474, 6008.24896887889, 6014.9097763534455, 6027.517798576016, 5991.670458124845, 6067.908981365194, 6114.38856114385, 6188.226471691039, 6208.348123446973, 4012.632546797287, 4044.2922488564973, 4053.5946405359227, 4057.289974254553, 4072.2466343726505, 5930.495907847881, 6013.849653758516, 6019.789307374396, 6033.487153591994, 6054.636721796706, 5830.82507524775, 5830.970845145747, 5845.678487683218, 5884.264466941632, 5907.85230369227, 5836.795712150224, 5843.474087332161, 5862.413758624274, 5876.529877609695, 5905.468507834144, 5282.498162674539, 5710.942890571041, 5746.683932383759, 5769.423057694197, 5805.094694982733, 5813.56398270123, 5885.499732522783, 5940.198073260054, 5947.494462970523, 5979.4917432018765, 5541.226807421586, 5733.168690539932, 5779.797707080232, 5817.621854579439, 5856.770078283608], "value": 4426.060843770823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.5371896283783, 762.9313361797438, 769.8806684963832, 792.5522080024786, 813.304624546013, 15314.770278445832, 15547.844521554782, 16313.0, 16603.41888033919, 16629.50111496654, 14525.92737036316, 14792.40830366784, 14800.40798368064, 14804.40782368704, 14806.0, 763.4312437234269, 775.4959276470283, 777.5956502618635, 780.6135962698472, 801.9759407217792, 786.728578640371, 791.8376732769797, 792.8057625881638, 798.4251339035885, 799.0, 831.5260301628074, 832.9333653307721, 835.7283882738135, 836.1972506393869, 839.2698352433391, 820.5774026376391, 823.5100115431309, 825.1006403020737, 828.6519661742083, 833.3749687734199, 600.9399060093999, 605.1527860994598, 607.0833042106407, 607.9240094988127, 609.9756009759604, 15480.5355839325, 15529.844701552953, 15593.220338983005, 15615.609609759733, 15649.687006259812, 14258.287085645676, 14417.495387661382, 14596.400259261127, 14672.339744711513, 14675.853241467556, 11622.244554103956, 11642.18504704671, 11713.53145874164, 11724.824127638092, 11751.588694395741, 3795.7153213509096, 3856.633619806114, 3950.9012274693364, 4005.5794141615293, 4068.0, 74192.0, 75639.0, 75674.0, 76211.0, 76245.0, 10865.402402867918, 10935.945320273348, 11089.112870970303, 11160.665180044612, 11275.210735248618, 22487.66268505974, 22517.32448026562, 22560.323190304316, 22568.21011264598, 22647.0, 8280.0, 8374.995000599967, 8407.537585432738, 8543.316534677211, 8551.914480855112, 4581.217705006222, 4635.384400167874, 4657.580817726421, 4686.859394218179, 4892.779824907888, 3720.2373513429684, 3868.941965870514, 3871.825767840454, 3881.6312450317173, 3893.0267433141717, 644.887144749667, 662.6355504472617, 664.9035889795953, 668.7057694614355, 678.3928384096305, 703.7783098324012, 724.5362967700676, 724.8006798130451, 733.5484414573835, 748.1770052941721, 9007.504587247764, 9306.208972237435, 9327.860082098774, 9362.438253704799, 9533.713988580354, 659.7558903205748, 677.2414895317178, 706.9505134640526, 717.9317964793337, 726.284609659485, 4428.955710442919, 4458.331250312479, 4544.54793864808, 4651.906961860744, 4694.155052090657, 108361.6303038153, 110837.0, 111563.0, 112204.0, 116287.41856290834, 84080.0, 84503.0, 86646.56676716576, 96224.0, 97207.51396242973, 83877.0, 86323.0, 86599.5670021646, 87421.56289218513, 87788.0, 8910.376273660782, 9672.516374181121, 9694.660686875926, 9773.0, 9816.361936474392, 50974.74512627413, 51594.74202629113, 51943.2208516865, 52381.02380273868, 54140.917181656936, 50331.49668503268, 63767.68116159389, 66115.66942165258, 70679.0, 74373.0, 11651.650450486499, 11799.115066369885, 11831.76336473283, 11962.521499139937, 12024.519019239482, 14456.638584035063, 14563.199024053778, 14649.194294313915, 14749.705005899606, 14789.852101478848, 13722.0, 13919.93040034834, 14098.929505352407, 14547.709045818812, 14560.344784484936, 13947.651308717363, 14092.224927629079, 14100.435982560582, 14115.51230795293, 14304.07023543508, 13080.28058456794, 13540.119892206974, 13575.0, 13671.589852304447, 13796.310184490936, 9851.359661621971, 9908.455034973145, 10437.739056523647, 10463.633772818219, 10504.78990420172, 9889.307748457539, 10286.948565257126, 10303.227257955834, 10353.689389318333, 10376.221783366127], "value": 7477.782582940229, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 111.0, 111.0, 112.0, 113.0, 111.0, 112.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 124.0, 156.0, 183.0, 127.0, 154.0, 161.0, 128.0, 189.0, 127.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 164.0, 172.0, 163.0, 162.0, 163.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 155.0, 79.0, 77.0, 74.0, 76.0, 169.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 87.0, 86.0, 85.0, 136.0, 86.0, 85.0, 144.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 117.0, 116.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 149.0, 146.0, 148.0, 148.0, 147.0, 147.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 54.0, 53.0, 55.0, 54.0, 63.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 64.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 82.0, 80.0, 80.0, 80.0, 82.0, 80.0, 136.0, 79.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 129.0, 123.0, 120.0, 124.0, 132.0, 125.0, 135.0, 124.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 168.0, 164.0, 163.0, 161.0, 156.0, 159.0, 158.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 64.0, 62.0], "value": 63.5, "unit": "score"}]}]} 01:24:42 INFO - Return code: 0 01:24:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:24:42 ERROR - # TBPL SUCCESS # 01:24:42 INFO - Running post-action listener: _resource_record_post_action 01:24:42 INFO - ##### 01:24:42 INFO - ##### Finished run-tests step (success) 01:24:42 INFO - ##### 01:24:42 INFO - Running post-run listener: _resource_record_post_run 01:24:42 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561004544; Read time: 172; Write time: 465016 01:24:42 INFO - TinderboxPrint: CPU usage
13.4% 01:24:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 172 01:24:42 INFO - TinderboxPrint: I/O write bytes / time
561,004,544 / 465,016 01:24:42 INFO - TinderboxPrint: CPU idle
8,222.3 (86.5%) 01:24:42 INFO - TinderboxPrint: CPU user
1,223.6 (12.9%) 01:24:42 INFO - TinderboxPrint: Swap in / out
0 / 0 01:24:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 263360512; Read time: 0; Write time: 242040 01:24:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296923136; Read time: 172; Write time: 222916 01:24:43 INFO - Running post-run listener: _upload_blobber_files 01:24:43 INFO - Blob upload gear active. 01:24:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:24:43 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 01:24:43 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'] 01:24:43 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 01:24:43 INFO - (blobuploader) - INFO - Open directory for files ... 01:24:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:24:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:24:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:44 INFO - (blobuploader) - INFO - Done attempting. 01:24:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:24:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:24:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:48 INFO - (blobuploader) - INFO - Done attempting. 01:24:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:24:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:24:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:49 INFO - (blobuploader) - INFO - Done attempting. 01:24:49 INFO - (blobuploader) - INFO - Iteration through files over. 01:24:49 INFO - Return code: 0 01:24:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:24:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:24:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed6bcb4007b52c8b0d770e703288cf213fb19e5af6a6fa14bc1b592e006e1f7b2e58671edd2e589aca79388545ff4e010792746d769531ee535cdb9c8d557145", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3901e3d7bd9c13b89c2df953adfa0db5e71966f6d1978e1a9f72aefe975fe1322afb121d76729937d6e5bea3adf42cf43da8a7f547e752568f8608f9caddb581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aca24e8605bf80ed75cd01c612c58739205674a1f80df2478980c887d60d125f6347763b16ff814c185232b646dce47b5b85ea02bb6fa31d33007d231c072164"} 01:24:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:24:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:24:49 INFO - Contents: 01:24:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed6bcb4007b52c8b0d770e703288cf213fb19e5af6a6fa14bc1b592e006e1f7b2e58671edd2e589aca79388545ff4e010792746d769531ee535cdb9c8d557145", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3901e3d7bd9c13b89c2df953adfa0db5e71966f6d1978e1a9f72aefe975fe1322afb121d76729937d6e5bea3adf42cf43da8a7f547e752568f8608f9caddb581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aca24e8605bf80ed75cd01c612c58739205674a1f80df2478980c887d60d125f6347763b16ff814c185232b646dce47b5b85ea02bb6fa31d33007d231c072164"} 01:24:49 INFO - Running post-run listener: copy_logs_to_upload_dir 01:24:49 INFO - Copying logs to upload dir... 01:24:49 INFO - mkdir: /builds/slave/test/build/upload/logs 01:24:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.456898 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-24 01:24:48.179709) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 01:24:48.183595) ========= 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=923d835db2ba3686ebe126b700000192-1466755345.179609-416599024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed6bcb4007b52c8b0d770e703288cf213fb19e5af6a6fa14bc1b592e006e1f7b2e58671edd2e589aca79388545ff4e010792746d769531ee535cdb9c8d557145", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3901e3d7bd9c13b89c2df953adfa0db5e71966f6d1978e1a9f72aefe975fe1322afb121d76729937d6e5bea3adf42cf43da8a7f547e752568f8608f9caddb581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aca24e8605bf80ed75cd01c612c58739205674a1f80df2478980c887d60d125f6347763b16ff814c185232b646dce47b5b85ea02bb6fa31d33007d231c072164"} build_url:https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/L3iG28F2SCiHusE2eBolKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed6bcb4007b52c8b0d770e703288cf213fb19e5af6a6fa14bc1b592e006e1f7b2e58671edd2e589aca79388545ff4e010792746d769531ee535cdb9c8d557145", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3901e3d7bd9c13b89c2df953adfa0db5e71966f6d1978e1a9f72aefe975fe1322afb121d76729937d6e5bea3adf42cf43da8a7f547e752568f8608f9caddb581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aca24e8605bf80ed75cd01c612c58739205674a1f80df2478980c887d60d125f6347763b16ff814c185232b646dce47b5b85ea02bb6fa31d33007d231c072164"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 01:24:48.209703) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:24:48.210078) ========= 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=923d835db2ba3686ebe126b700000192-1466755345.179609-416599024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:24:48.293301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 01:24:48.293660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 01:24:48.294083) ========= ========= Total master_lag: 0.49 =========