builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1466555139.11 results: success (0) buildid: 20160621143008 builduid: 641e4944d68044a98bee1e7c5c675c5e revision: 6cb5178d51b3980a46c1719ce3ad74757307c44a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.115261) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.115731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.116074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.166766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.167136) ========= 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=fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 17:25:40-- 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% 70.4M=0s 2016-06-21 17:25:40 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167273 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.356005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.356350) ========= 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=fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018267 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.408848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:39.409226) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6cb5178d51b3980a46c1719ce3ad74757307c44a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6cb5178d51b3980a46c1719ce3ad74757307c44a --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=fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 17:25:40,486 truncating revision to first 12 chars 2016-06-21 17:25:40,487 Setting DEBUG logging. 2016-06-21 17:25:40,487 attempt 1/10 2016-06-21 17:25:40,487 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6cb5178d51b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 17:25:40,832 unpacking tar archive at: fx-team-6cb5178d51b3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661643 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:40.084613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:40.084935) ========= script_repo_revision: 6cb5178d51b3980a46c1719ce3ad74757307c44a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:40.085371) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:40.085775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 17:25:40.098724) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-21 17:25:40.099079) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:25:41 INFO - MultiFileLogger online at 20160621 17:25:41 in /builds/slave/test 17:25:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:25:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:25:41 INFO - {'append_to_log': False, 17:25:41 INFO - 'base_work_dir': '/builds/slave/test', 17:25:41 INFO - 'blob_upload_branch': 'Fx-Team', 17:25:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:25:41 INFO - 'branch': 'Fx-Team', 17:25:41 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:41 INFO - 'config_files': ('talos/linux_config.py',), 17:25:41 INFO - 'default_actions': ('clobber', 17:25:41 INFO - 'read-buildbot-config', 17:25:41 INFO - 'download-and-extract', 17:25:41 INFO - 'populate-webroot', 17:25:41 INFO - 'create-virtualenv', 17:25:41 INFO - 'install', 17:25:41 INFO - 'run-tests'), 17:25:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:41 INFO - 'download_minidump_stackwalk': True, 17:25:41 INFO - 'download_symbols': 'ondemand', 17:25:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:41 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:41 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:41 INFO - 'installer_path': 'installer.exe', 17:25:41 INFO - 'log_level': 'info', 17:25:41 INFO - 'log_name': 'talos', 17:25:41 INFO - 'log_to_console': True, 17:25:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:25:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:25:41 INFO - 'opt_config_files': (), 17:25:41 INFO - 'pip_index': False, 17:25:41 INFO - 'sps_profile': False, 17:25:41 INFO - 'sps_profile_interval': 0, 17:25:41 INFO - 'suite': 'dromaeojs', 17:25:41 INFO - 'system_bits': '32', 17:25:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:41 INFO - 'title': 'talos-linux64-ix-048', 17:25:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:41 INFO - 'use_talos_json': True, 17:25:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:25:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:41 INFO - 'work_dir': 'build'} 17:25:41 INFO - ##### 17:25:41 INFO - ##### Running clobber step. 17:25:41 INFO - ##### 17:25:41 INFO - Running pre-action listener: _resource_record_pre_action 17:25:41 INFO - Running main action method: clobber 17:25:41 INFO - rmtree: /builds/slave/test/build 17:25:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:25:41 INFO - Running post-action listener: _resource_record_post_action 17:25:41 INFO - ##### 17:25:41 INFO - ##### Finished clobber step (success) 17:25:41 INFO - ##### 17:25:41 INFO - ##### 17:25:41 INFO - ##### Running read-buildbot-config step. 17:25:41 INFO - ##### 17:25:41 INFO - Running pre-action listener: _resource_record_pre_action 17:25:41 INFO - Running main action method: read_buildbot_config 17:25:41 INFO - Using buildbot properties: 17:25:41 INFO - { 17:25:41 INFO - "project": "", 17:25:41 INFO - "product": "firefox", 17:25:41 INFO - "script_repo_revision": "production", 17:25:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:25:41 INFO - "repository": "", 17:25:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:25:41 INFO - "buildid": "20160621143008", 17:25:41 INFO - "pgo_build": "True", 17:25:41 INFO - "basedir": "/builds/slave/test", 17:25:41 INFO - "buildnumber": 1271, 17:25:41 INFO - "slavename": "talos-linux64-ix-048", 17:25:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:25:41 INFO - "platform": "ubuntu64_hw", 17:25:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:25:41 INFO - "branch": "fx-team", 17:25:41 INFO - "repo_path": "integration/fx-team", 17:25:41 INFO - "revision": "6cb5178d51b3980a46c1719ce3ad74757307c44a", 17:25:41 INFO - "stage_platform": "linux64-pgo", 17:25:41 INFO - "builduid": "641e4944d68044a98bee1e7c5c675c5e", 17:25:41 INFO - "slavebuilddir": "test" 17:25:41 INFO - } 17:25:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:25:41 INFO - Running post-action listener: _resource_record_post_action 17:25:41 INFO - ##### 17:25:41 INFO - ##### Finished read-buildbot-config step (success) 17:25:41 INFO - ##### 17:25:41 INFO - ##### 17:25:41 INFO - ##### Running download-and-extract step. 17:25:41 INFO - ##### 17:25:41 INFO - Running pre-action listener: _resource_record_pre_action 17:25:41 INFO - Running main action method: download_and_extract 17:25:41 INFO - mkdir: /builds/slave/test/build/tests 17:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:41 INFO - https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:25:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:25:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:25:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:25:48 INFO - Downloaded 1361 bytes. 17:25:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:25:48 INFO - Using the following test package requirements: 17:25:48 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:25:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:25:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:48 INFO - u'jsshell-linux-x86_64.zip'], 17:25:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:25:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:25:48 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:25:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:25:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:25:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:25: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')]} 17:25:48 INFO - https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:25:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:25:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:25:53 INFO - Downloaded 24268331 bytes. 17:25:53 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'] 17:25:53 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 17:25:54 INFO - Return code: 0 17:25:54 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 17:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:54 INFO - https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:25:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:25:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:25:57 INFO - Downloaded 24268331 bytes. 17:25:57 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'] 17:25:57 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 17:25:58 INFO - Return code: 0 17:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:58 INFO - https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:25:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:25:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:26:00 INFO - Downloaded 14405384 bytes. 17:26:00 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'] 17:26:00 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 17:26:00 INFO - Return code: 0 17:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:00 INFO - https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpvzctAwTRiXFJlzPmx3Ug/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 17:26:02 INFO - Downloaded 60122368 bytes. 17:26:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:26:02 INFO - mkdir: /builds/slave/test/properties 17:26:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:02 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:02 INFO - Contents: 17:26:02 INFO - build_url:https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:26:03 INFO - Running post-action listener: _resource_record_post_action 17:26:03 INFO - Running post-action listener: set_extra_try_arguments 17:26:03 INFO - ##### 17:26:03 INFO - ##### Finished download-and-extract step (success) 17:26:03 INFO - ##### 17:26:03 INFO - ##### 17:26:03 INFO - ##### Running populate-webroot step. 17:26:03 INFO - ##### 17:26:03 INFO - Running pre-action listener: _resource_record_pre_action 17:26:03 INFO - Running main action method: populate_webroot 17:26:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:26:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:26:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:26:03 INFO - '--tppagecycles', 17:26:03 INFO - '7'], 17:26:03 INFO - 'tests': ['tsvgm']}}, 17:26:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:26:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:26:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:26:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:26:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:03 INFO - 'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:03 INFO - 'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['damp', 'tps']}, 17:26:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:03 INFO - 'tests': ['damp', 'tps']}, 17:26:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['dromaeo_dom']}, 17:26:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['basic_compositor_video']}, 17:26:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:26:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['a11yr', 17:26:03 INFO - 'ts_paint', 17:26:03 INFO - 'tpaint', 17:26:03 INFO - 'sessionrestore', 17:26:03 INFO - 'sessionrestore_no_auto_restore', 17:26:03 INFO - 'tabpaint']}, 17:26:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:26:03 INFO - 'ts_paint', 17:26:03 INFO - 'tpaint', 17:26:03 INFO - 'sessionrestore', 17:26:03 INFO - 'sessionrestore_no_auto_restore', 17:26:03 INFO - 'tabpaint']}, 17:26:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:26:03 INFO - 'ts_paint', 17:26:03 INFO - 'tpaint', 17:26:03 INFO - 'sessionrestore', 17:26:03 INFO - 'sessionrestore_no_auto_restore', 17:26:03 INFO - 'tabpaint']}, 17:26:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:26:03 INFO - 'ts_paint', 17:26:03 INFO - 'tpaint', 17:26:03 INFO - 'sessionrestore', 17:26:03 INFO - 'sessionrestore_no_auto_restore', 17:26:03 INFO - 'tabpaint']}, 17:26:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['a11yr', 17:26:03 INFO - 'ts_paint', 17:26:03 INFO - 'tpaint', 17:26:03 INFO - 'sessionrestore', 17:26:03 INFO - 'sessionrestore_no_auto_restore', 17:26:03 INFO - 'tabpaint']}, 17:26:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['a11yr', 17:26:03 INFO - 'ts_paint', 17:26:03 INFO - 'tpaint', 17:26:03 INFO - 'sessionrestore', 17:26:03 INFO - 'sessionrestore_no_auto_restore', 17:26:03 INFO - 'tabpaint']}, 17:26:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['tsvgx', 17:26:03 INFO - 'tsvgr_opacity', 17:26:03 INFO - 'tart', 17:26:03 INFO - 'tscrollx', 17:26:03 INFO - 'cart']}, 17:26:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:26:03 INFO - 'tsvgr_opacity', 17:26:03 INFO - 'tart', 17:26:03 INFO - 'tscrollx', 17:26:03 INFO - 'cart']}, 17:26:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:03 INFO - 'talos_options': ['--disable-e10s'], 17:26:03 INFO - 'tests': ['tp5o']}, 17:26:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:03 INFO - 'tests': ['tp5o']}, 17:26:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:03 INFO - 'talos_options': ['--disable-e10s', 17:26:03 INFO - '--xperf_path', 17:26:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:03 INFO - 'tests': ['tp5n']}, 17:26:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:03 INFO - 'talos_options': ['--xperf_path', 17:26:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:03 INFO - 'tests': ['tp5n']}}, 17:26:03 INFO - 'talos.zip': {'path': '', 17:26:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:26:03 INFO - Running post-action listener: _resource_record_post_action 17:26:03 INFO - ##### 17:26:03 INFO - ##### Finished populate-webroot step (success) 17:26:03 INFO - ##### 17:26:03 INFO - ##### 17:26:03 INFO - ##### Running create-virtualenv step. 17:26:03 INFO - ##### 17:26:03 INFO - Running pre-action listener: _resource_record_pre_action 17:26:03 INFO - Running main action method: create_virtualenv 17:26:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:26:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:26:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:03 INFO - Using real prefix '/usr' 17:26:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:03 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:05 INFO - Installing pip.................done. 17:26:05 INFO - Return code: 0 17:26:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:26:05 INFO - Using env: {'DISPLAY': ':0', 17:26:05 INFO - 'HOME': '/home/cltbld', 17:26:05 INFO - 'LANG': 'en_US.UTF-8', 17:26:05 INFO - 'LANGUAGE': 'en_US:en', 17:26:05 INFO - 'LOGNAME': 'cltbld', 17:26:05 INFO - 'MAIL': '/var/mail/cltbld', 17:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:05 INFO - 'MOZ_NO_REMOTE': '1', 17:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:05 INFO - 'NO_EM_RESTART': '1', 17:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:05 INFO - 'PWD': '/builds/slave/test', 17:26:05 INFO - 'SHELL': '/bin/bash', 17:26:05 INFO - 'SHLVL': '1', 17:26:05 INFO - 'TERM': 'linux', 17:26:05 INFO - 'TMOUT': '86400', 17:26:05 INFO - 'USER': 'cltbld', 17:26:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:05 INFO - '_': '/tools/buildbot/bin/python'} 17:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:26:05 INFO - Cleaning up... 17:26:05 INFO - Return code: 0 17:26:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:26:05 INFO - Using env: {'DISPLAY': ':0', 17:26:05 INFO - 'HOME': '/home/cltbld', 17:26:05 INFO - 'LANG': 'en_US.UTF-8', 17:26:05 INFO - 'LANGUAGE': 'en_US:en', 17:26:05 INFO - 'LOGNAME': 'cltbld', 17:26:05 INFO - 'MAIL': '/var/mail/cltbld', 17:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:05 INFO - 'MOZ_NO_REMOTE': '1', 17:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:05 INFO - 'NO_EM_RESTART': '1', 17:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:05 INFO - 'PWD': '/builds/slave/test', 17:26:05 INFO - 'SHELL': '/bin/bash', 17:26:05 INFO - 'SHLVL': '1', 17:26:05 INFO - 'TERM': 'linux', 17:26:05 INFO - 'TMOUT': '86400', 17:26:05 INFO - 'USER': 'cltbld', 17:26:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:05 INFO - '_': '/tools/buildbot/bin/python'} 17:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:06 INFO - Downloading/unpacking psutil>=3.1.1 17:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:08 INFO - Installing collected packages: psutil 17:26:08 INFO - Running setup.py install for psutil 17:26:08 INFO - building 'psutil._psutil_linux' extension 17:26:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:26:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:26:08 INFO - building 'psutil._psutil_posix' extension 17:26:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:26:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:26:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:08 INFO - Successfully installed psutil 17:26:08 INFO - Cleaning up... 17:26:08 INFO - Return code: 0 17:26:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:08 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:26:08 INFO - Using env: {'DISPLAY': ':0', 17:26:08 INFO - 'HOME': '/home/cltbld', 17:26:08 INFO - 'LANG': 'en_US.UTF-8', 17:26:08 INFO - 'LANGUAGE': 'en_US:en', 17:26:08 INFO - 'LOGNAME': 'cltbld', 17:26:08 INFO - 'MAIL': '/var/mail/cltbld', 17:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:08 INFO - 'MOZ_NO_REMOTE': '1', 17:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:08 INFO - 'NO_EM_RESTART': '1', 17:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:08 INFO - 'PWD': '/builds/slave/test', 17:26:08 INFO - 'SHELL': '/bin/bash', 17:26:08 INFO - 'SHLVL': '1', 17:26:08 INFO - 'TERM': 'linux', 17:26:08 INFO - 'TMOUT': '86400', 17:26:08 INFO - 'USER': 'cltbld', 17:26:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:08 INFO - '_': '/tools/buildbot/bin/python'} 17:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:26:10 INFO - Installing collected packages: mozsystemmonitor 17:26:10 INFO - Running setup.py install for mozsystemmonitor 17:26:10 INFO - Successfully installed mozsystemmonitor 17:26:10 INFO - Cleaning up... 17:26:11 INFO - Return code: 0 17:26:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:11 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:26:11 INFO - Using env: {'DISPLAY': ':0', 17:26:11 INFO - 'HOME': '/home/cltbld', 17:26:11 INFO - 'LANG': 'en_US.UTF-8', 17:26:11 INFO - 'LANGUAGE': 'en_US:en', 17:26:11 INFO - 'LOGNAME': 'cltbld', 17:26:11 INFO - 'MAIL': '/var/mail/cltbld', 17:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:11 INFO - 'MOZ_NO_REMOTE': '1', 17:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:11 INFO - 'NO_EM_RESTART': '1', 17:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:11 INFO - 'PWD': '/builds/slave/test', 17:26:11 INFO - 'SHELL': '/bin/bash', 17:26:11 INFO - 'SHLVL': '1', 17:26:11 INFO - 'TERM': 'linux', 17:26:11 INFO - 'TMOUT': '86400', 17:26:11 INFO - 'USER': 'cltbld', 17:26:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:11 INFO - '_': '/tools/buildbot/bin/python'} 17:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:11 INFO - Downloading/unpacking jsonschema==2.5.1 17:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:13 INFO - warning: no files found matching '*.txt' 17:26:13 INFO - no previously-included directories found matching 'build' 17:26:13 INFO - no previously-included directories found matching 'dist' 17:26:13 INFO - no previously-included directories found matching '.git*' 17:26:13 INFO - Installing collected packages: jsonschema, functools32 17:26:13 INFO - Running setup.py install for functools32 17:26:13 INFO - warning: no files found matching '*.txt' 17:26:13 INFO - no previously-included directories found matching 'build' 17:26:13 INFO - no previously-included directories found matching 'dist' 17:26:13 INFO - no previously-included directories found matching '.git*' 17:26:13 INFO - Successfully installed jsonschema functools32 17:26:13 INFO - Cleaning up... 17:26:13 INFO - Return code: 0 17:26:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:13 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:26:13 INFO - Using env: {'DISPLAY': ':0', 17:26:13 INFO - 'HOME': '/home/cltbld', 17:26:13 INFO - 'LANG': 'en_US.UTF-8', 17:26:13 INFO - 'LANGUAGE': 'en_US:en', 17:26:13 INFO - 'LOGNAME': 'cltbld', 17:26:13 INFO - 'MAIL': '/var/mail/cltbld', 17:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:13 INFO - 'MOZ_NO_REMOTE': '1', 17:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:13 INFO - 'NO_EM_RESTART': '1', 17:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:13 INFO - 'PWD': '/builds/slave/test', 17:26:13 INFO - 'SHELL': '/bin/bash', 17:26:13 INFO - 'SHLVL': '1', 17:26:13 INFO - 'TERM': 'linux', 17:26:13 INFO - 'TMOUT': '86400', 17:26:13 INFO - 'USER': 'cltbld', 17:26:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:13 INFO - '_': '/tools/buildbot/bin/python'} 17:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:13 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:15 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:26:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:16 INFO - Downloading docopt-0.6.1.tar.gz 17:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:16 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:16 INFO - Running setup.py install for blobuploader 17:26:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:26:16 INFO - Running setup.py install for requests 17:26:16 INFO - Running setup.py install for docopt 17:26:16 INFO - Successfully installed blobuploader requests docopt 17:26:16 INFO - Cleaning up... 17:26:17 INFO - Return code: 0 17:26:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:17 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:17 INFO - Using env: {'DISPLAY': ':0', 17:26:17 INFO - 'HOME': '/home/cltbld', 17:26:17 INFO - 'LANG': 'en_US.UTF-8', 17:26:17 INFO - 'LANGUAGE': 'en_US:en', 17:26:17 INFO - 'LOGNAME': 'cltbld', 17:26:17 INFO - 'MAIL': '/var/mail/cltbld', 17:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:17 INFO - 'MOZ_NO_REMOTE': '1', 17:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:17 INFO - 'NO_EM_RESTART': '1', 17:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:17 INFO - 'PWD': '/builds/slave/test', 17:26:17 INFO - 'SHELL': '/bin/bash', 17:26:17 INFO - 'SHLVL': '1', 17:26:17 INFO - 'TERM': 'linux', 17:26:17 INFO - 'TMOUT': '86400', 17:26:17 INFO - 'USER': 'cltbld', 17:26:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:17 INFO - '_': '/tools/buildbot/bin/python'} 17:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:17 INFO - Running setup.py (path:/tmp/pip-FwAgFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:17 INFO - Running setup.py (path:/tmp/pip-MC1q2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:17 INFO - Running setup.py (path:/tmp/pip-kL6jcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:17 INFO - Running setup.py (path:/tmp/pip-ZQ2gNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:17 INFO - Running setup.py (path:/tmp/pip-sScN2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:17 INFO - Running setup.py (path:/tmp/pip-EmJ0EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:17 INFO - Running setup.py (path:/tmp/pip-Lhb35f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:17 INFO - Running setup.py (path:/tmp/pip-ednGXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:17 INFO - Running setup.py (path:/tmp/pip-5lZCkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:17 INFO - Running setup.py (path:/tmp/pip-XZFCty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:18 INFO - Running setup.py (path:/tmp/pip-bR63hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:18 INFO - Running setup.py (path:/tmp/pip-WX7Erz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:18 INFO - Running setup.py (path:/tmp/pip-MPv37K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:18 INFO - Running setup.py (path:/tmp/pip-qmWe2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:18 INFO - Running setup.py (path:/tmp/pip-oHwbFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:18 INFO - Running setup.py (path:/tmp/pip-DQ1EFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:18 INFO - Running setup.py (path:/tmp/pip-KhpEPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:26:18 INFO - Running setup.py install for manifestparser 17:26:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:26:18 INFO - Running setup.py install for mozcrash 17:26:18 INFO - Running setup.py install for mozdebug 17:26:18 INFO - Running setup.py install for mozdevice 17:26:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:26:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:26:18 INFO - Running setup.py install for mozfile 17:26:19 INFO - Running setup.py install for mozhttpd 17:26:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Running setup.py install for mozinfo 17:26:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Running setup.py install for mozInstall 17:26:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Running setup.py install for mozleak 17:26:19 INFO - Running setup.py install for mozlog 17:26:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Running setup.py install for moznetwork 17:26:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Running setup.py install for mozprocess 17:26:19 INFO - Running setup.py install for mozprofile 17:26:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:26:19 INFO - Running setup.py install for mozrunner 17:26:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:26:20 INFO - Running setup.py install for mozscreenshot 17:26:20 INFO - Running setup.py install for moztest 17:26:20 INFO - Running setup.py install for mozversion 17:26:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:26:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:20 INFO - Cleaning up... 17:26:20 INFO - Return code: 0 17:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:20 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:20 INFO - Using env: {'DISPLAY': ':0', 17:26:20 INFO - 'HOME': '/home/cltbld', 17:26:20 INFO - 'LANG': 'en_US.UTF-8', 17:26:20 INFO - 'LANGUAGE': 'en_US:en', 17:26:20 INFO - 'LOGNAME': 'cltbld', 17:26:20 INFO - 'MAIL': '/var/mail/cltbld', 17:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:20 INFO - 'MOZ_NO_REMOTE': '1', 17:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:20 INFO - 'NO_EM_RESTART': '1', 17:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:20 INFO - 'PWD': '/builds/slave/test', 17:26:20 INFO - 'SHELL': '/bin/bash', 17:26:20 INFO - 'SHLVL': '1', 17:26:20 INFO - 'TERM': 'linux', 17:26:20 INFO - 'TMOUT': '86400', 17:26:20 INFO - 'USER': 'cltbld', 17:26:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:20 INFO - '_': '/tools/buildbot/bin/python'} 17:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:20 INFO - Running setup.py (path:/tmp/pip-deX9AL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:20 INFO - Running setup.py (path:/tmp/pip-79I_oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:20 INFO - Running setup.py (path:/tmp/pip-xlNP1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:20 INFO - Running setup.py (path:/tmp/pip-_TwcxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:20 INFO - Running setup.py (path:/tmp/pip-NZBPyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:20 INFO - Running setup.py (path:/tmp/pip-SENunl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:21 INFO - Running setup.py (path:/tmp/pip-bMZA48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:21 INFO - Running setup.py (path:/tmp/pip-NkNS1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:21 INFO - Running setup.py (path:/tmp/pip-6YEX6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:21 INFO - Running setup.py (path:/tmp/pip-DDpprh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:21 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)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:21 INFO - Running setup.py (path:/tmp/pip-vMRfGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:21 INFO - Running setup.py (path:/tmp/pip-eUR34q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:21 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)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:21 INFO - Running setup.py (path:/tmp/pip-YJbQ55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:21 INFO - Running setup.py (path:/tmp/pip-HsqQxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:21 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)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:21 INFO - Running setup.py (path:/tmp/pip-QBw_ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:21 INFO - Running setup.py (path:/tmp/pip-hYOqRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:21 INFO - Running setup.py (path:/tmp/pip-caruKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:26:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:23 INFO - Downloading blessings-1.6.tar.gz 17:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:26:23 INFO - Installing collected packages: blessings 17:26:23 INFO - Running setup.py install for blessings 17:26:23 INFO - Successfully installed blessings 17:26:23 INFO - Cleaning up... 17:26:23 INFO - Return code: 0 17:26:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:26:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:24 INFO - Reading from file tmpfile_stdout 17:26:24 INFO - Current package versions: 17:26:24 INFO - argparse == 1.2.1 17:26:24 INFO - blessings == 1.6 17:26:24 INFO - blobuploader == 1.2.4 17:26:24 INFO - docopt == 0.6.1 17:26:24 INFO - functools32 == 3.2.3-2 17:26:24 INFO - jsonschema == 2.5.1 17:26:24 INFO - manifestparser == 1.1 17:26:24 INFO - mozInstall == 1.12 17:26:24 INFO - mozcrash == 0.17 17:26:24 INFO - mozdebug == 0.1 17:26:24 INFO - mozdevice == 0.48 17:26:24 INFO - mozfile == 1.2 17:26:24 INFO - mozhttpd == 0.7 17:26:24 INFO - mozinfo == 0.9 17:26:24 INFO - mozleak == 0.1 17:26:24 INFO - mozlog == 3.2 17:26:24 INFO - moznetwork == 0.27 17:26:24 INFO - mozprocess == 0.22 17:26:24 INFO - mozprofile == 0.28 17:26:24 INFO - mozrunner == 6.11 17:26:24 INFO - mozscreenshot == 0.1 17:26:24 INFO - mozsystemmonitor == 0.3 17:26:24 INFO - moztest == 0.7 17:26:24 INFO - mozversion == 1.4 17:26:24 INFO - psutil == 3.1.1 17:26:24 INFO - requests == 1.2.3 17:26:24 INFO - wsgiref == 0.1.2 17:26:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:24 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:24 INFO - Using env: {'DISPLAY': ':0', 17:26:24 INFO - 'HOME': '/home/cltbld', 17:26:24 INFO - 'LANG': 'en_US.UTF-8', 17:26:24 INFO - 'LANGUAGE': 'en_US:en', 17:26:24 INFO - 'LOGNAME': 'cltbld', 17:26:24 INFO - 'MAIL': '/var/mail/cltbld', 17:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:24 INFO - 'MOZ_NO_REMOTE': '1', 17:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:24 INFO - 'NO_EM_RESTART': '1', 17:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:24 INFO - 'PWD': '/builds/slave/test', 17:26:24 INFO - 'SHELL': '/bin/bash', 17:26:24 INFO - 'SHLVL': '1', 17:26:24 INFO - 'TERM': 'linux', 17:26:24 INFO - 'TMOUT': '86400', 17:26:24 INFO - 'USER': 'cltbld', 17:26:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:24 INFO - '_': '/tools/buildbot/bin/python'} 17:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:26:24 INFO - Cleaning up... 17:26:24 INFO - Return code: 0 17:26:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:24 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:26:24 INFO - Using env: {'DISPLAY': ':0', 17:26:24 INFO - 'HOME': '/home/cltbld', 17:26:24 INFO - 'LANG': 'en_US.UTF-8', 17:26:24 INFO - 'LANGUAGE': 'en_US:en', 17:26:24 INFO - 'LOGNAME': 'cltbld', 17:26:24 INFO - 'MAIL': '/var/mail/cltbld', 17:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:24 INFO - 'MOZ_NO_REMOTE': '1', 17:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:24 INFO - 'NO_EM_RESTART': '1', 17:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:24 INFO - 'PWD': '/builds/slave/test', 17:26:24 INFO - 'SHELL': '/bin/bash', 17:26:24 INFO - 'SHLVL': '1', 17:26:24 INFO - 'TERM': 'linux', 17:26:24 INFO - 'TMOUT': '86400', 17:26:24 INFO - 'USER': 'cltbld', 17:26:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:24 INFO - '_': '/tools/buildbot/bin/python'} 17:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:26:24 INFO - Cleaning up... 17:26:24 INFO - Return code: 0 17:26:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:24 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 0x7fbd4c8c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, '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': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:24 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 17:26:24 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 17:26:24 INFO - Using env: {'DISPLAY': ':0', 17:26:24 INFO - 'HOME': '/home/cltbld', 17:26:24 INFO - 'LANG': 'en_US.UTF-8', 17:26:24 INFO - 'LANGUAGE': 'en_US:en', 17:26:24 INFO - 'LOGNAME': 'cltbld', 17:26:24 INFO - 'MAIL': '/var/mail/cltbld', 17:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:24 INFO - 'MOZ_NO_REMOTE': '1', 17:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:24 INFO - 'NO_EM_RESTART': '1', 17:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:24 INFO - 'PWD': '/builds/slave/test', 17:26:24 INFO - 'SHELL': '/bin/bash', 17:26:24 INFO - 'SHLVL': '1', 17:26:24 INFO - 'TERM': 'linux', 17:26:24 INFO - 'TMOUT': '86400', 17:26:24 INFO - 'USER': 'cltbld', 17:26:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:24 INFO - '_': '/tools/buildbot/bin/python'} 17:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:24 INFO - Downloading/unpacking flake8 17:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:26:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:26:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:26:27 INFO - no previously-included directories found matching 'docs/_build' 17:26:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:26:27 INFO - Running setup.py install for pep8 17:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:26:27 INFO - no previously-included directories found matching 'docs/_build' 17:26:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:26:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:26:27 INFO - Cleaning up... 17:26:27 INFO - Return code: 0 17:26:27 INFO - Running post-action listener: _resource_record_post_action 17:26:27 INFO - Running post-action listener: _start_resource_monitoring 17:26:27 INFO - Starting resource monitoring. 17:26:27 INFO - ##### 17:26:27 INFO - ##### Finished create-virtualenv step (success) 17:26:27 INFO - ##### 17:26:27 INFO - ##### 17:26:27 INFO - ##### Running install step. 17:26:27 INFO - ##### 17:26:27 INFO - Running pre-action listener: _resource_record_pre_action 17:26:27 INFO - Running main action method: install 17:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:27 INFO - Reading from file tmpfile_stdout 17:26:27 INFO - Detecting whether we're running mozinstall >=1.0... 17:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:26:28 INFO - Reading from file tmpfile_stdout 17:26:28 INFO - Output received: 17:26:28 INFO - Usage: mozinstall [options] installer 17:26:28 INFO - Options: 17:26:28 INFO - -h, --help show this help message and exit 17:26:28 INFO - -d DEST, --destination=DEST 17:26:28 INFO - Directory to install application into. [default: 17:26:28 INFO - "/builds/slave/test"] 17:26:28 INFO - --app=APP Application being installed. [default: firefox] 17:26:28 INFO - mkdir: /builds/slave/test/build/application 17:26:28 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'] 17:26:28 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 17:26:45 INFO - Reading from file tmpfile_stdout 17:26:45 INFO - Output received: 17:26:45 INFO - /builds/slave/test/build/application/firefox/firefox 17:26:45 INFO - Running post-action listener: _resource_record_post_action 17:26:45 INFO - ##### 17:26:45 INFO - ##### Finished install step (success) 17:26:45 INFO - ##### 17:26:45 INFO - ##### 17:26:45 INFO - ##### Running run-tests step. 17:26:45 INFO - ##### 17:26:45 INFO - Running pre-action listener: _resource_record_pre_action 17:26:45 INFO - Running main action method: run_tests 17:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:26:45 INFO - Python 2.7.3 17:26:45 INFO - Return code: 0 17:26:45 INFO - grabbing minidump binary from tooltool 17:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:45 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 0x180e110>, '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 0x177a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177a6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:26:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:26:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:26:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:26:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:26:45 INFO - Return code: 0 17:26:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:26:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:26:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:26:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:26:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:26:46 INFO - Return code: 0 17:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:26:46 INFO - Using env: {'DISPLAY': ':0', 17:26:46 INFO - 'HOME': '/home/cltbld', 17:26:46 INFO - 'LANG': 'en_US.UTF-8', 17:26:46 INFO - 'LANGUAGE': 'en_US:en', 17:26:46 INFO - 'LOGNAME': 'cltbld', 17:26:46 INFO - 'MAIL': '/var/mail/cltbld', 17:26:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:26:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:46 INFO - 'MOZ_NO_REMOTE': '1', 17:26:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:46 INFO - 'NO_EM_RESTART': '1', 17:26:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:46 INFO - 'PWD': '/builds/slave/test', 17:26:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:26:46 INFO - 'SHELL': '/bin/bash', 17:26:46 INFO - 'SHLVL': '1', 17:26:46 INFO - 'TERM': 'linux', 17:26:46 INFO - 'TMOUT': '86400', 17:26:46 INFO - 'USER': 'cltbld', 17:26:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031', 17:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:46 INFO - '_': '/tools/buildbot/bin/python'} 17:26:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:26:46 INFO - mozversion application_buildid: 20160621143008 17:26:46 INFO - mozversion application_changeset: 6cb5178d51b3980a46c1719ce3ad74757307c44a 17:26:46 INFO - mozversion application_display_name: Nightly 17:26:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:26:46 INFO - mozversion application_name: Firefox 17:26:46 INFO - mozversion application_remotingname: firefox 17:26:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:26:46 INFO - mozversion application_vendor: Mozilla 17:26:46 INFO - mozversion application_version: 50.0a1 17:26:46 INFO - mozversion platform_buildid: 20160621143008 17:26:46 INFO - mozversion platform_changeset: 6cb5178d51b3980a46c1719ce3ad74757307c44a 17:26:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:26:46 INFO - mozversion platform_version: 50.0a1 17:26:46 INFO - using testdate: 1466555206 17:26:46 INFO - actual date: 1466555206 17:26:46 INFO - starting webserver on 'localhost:49390' 17:26:46 INFO - SUITE-START | Running 2 tests 17:26:46 INFO - TEST-START | dromaeo_css 17:26:46 INFO - operating with platform_type : linux_ 17:26:46 INFO - Initialising browser for dromaeo_css test... 17:26:46 INFO - TEST-INFO | started process 17916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkOpLF/profile http://localhost:49390/getInfo.html) 17:26:50 INFO - PROCESS | 17916 | __metrics Screen width/height:1600/1200 17:26:50 INFO - PROCESS | 17916 | colorDepth:24 17:26:50 INFO - PROCESS | 17916 | Browser inner width/height: 1024/697 17:26:50 INFO - PROCESS | 17916 | __metrics 17:26:52 INFO - PROCESS | 17916 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:52 INFO - PROCESS | 17916 | console.error: PushService: 17:26:52 INFO - PROCESS | 17916 | stateChangeProcessEnqueue: Error transitioning state 17:26:52 INFO - PROCESS | 17916 | UnknownError 17:26:52 INFO - TEST-INFO | 17916: exit 0 17:26:52 INFO - Browser initialized. 17:26:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:26:52 INFO - TEST-INFO | started process 18004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkOpLF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:04 INFO - PROCESS | 18004 | RSS: Main: 173899776 17:27:04 INFO - PROCESS | 18004 | 17:27:56 INFO - PROCESS | 18004 | 1466555276676 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:30:04 INFO - PROCESS | 18004 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49390/tests/dromaeo/cssquery-ext.html) 17:30:06 INFO - PROCESS | 18004 | RSS: Main: 303046656 17:30:06 INFO - PROCESS | 18004 | 17:33:08 INFO - PROCESS | 18004 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-ext.html (next: http://localhost:49390/tests/dromaeo/cssquery-jquery.html) 17:33:09 INFO - PROCESS | 18004 | RSS: Main: 258953216 17:33:09 INFO - PROCESS | 18004 | 17:36:11 INFO - PROCESS | 18004 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49390/tests/dromaeo/cssquery-mootools.html) 17:36:11 INFO - PROCESS | 18004 | RSS: Main: 258031616 17:36:11 INFO - PROCESS | 18004 | 17:39:13 INFO - PROCESS | 18004 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49390/tests/dromaeo/cssquery-prototype.html) 17:39:14 INFO - PROCESS | 18004 | RSS: Main: 247599104 17:39:14 INFO - PROCESS | 18004 | 17:42:17 INFO - PROCESS | 18004 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49390/tests/dromaeo/cssquery-yui.html) 17:42:17 INFO - PROCESS | 18004 | RSS: Main: 224952320 17:42:17 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-yui.html (next: http://localhost:49390/tests/dromaeo/cssquery-dojo.html) 17:45:20 INFO - PROCESS | 18004 | RSS: Main: 318169088 17:45:20 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | __start_tp_report 17:45:20 INFO - PROCESS | 18004 | _x_x_mozilla_page_load 17:45:20 INFO - PROCESS | 18004 | _x_x_mozilla_page_load_details 17:45:20 INFO - PROCESS | 18004 | |i|pagename|runs| 17:45:20 INFO - PROCESS | 18004 | |0;dojo.html;3086.6296044474666;3089.752819774418;3104.0687793661896;3127.781055326128;3146.354997225569;5192.273081768555;5241.737913104339;5349.893002139955;5414.3232095988005;5462.289902312698;5351.946480535194;5366.758495867685;5431.321084864392;5465.6447330923465;5548.944510554903;4851.757412129397;4928.43323017854;4930.901381972359;4937.975310123462;5069.873253168664;5001.249812528114;5044.2937988681615;5054.039732450841;5067.543921047105;5082.771275292621;4812.951870481303;4843.612510999147;4892.315075889343;4899.093667671456;4928.26076088586;4887.071456423304;4887.975560122212;4896.387951506062;4901.1177987962155;4978.278149668314;4888.340074090023;4908.337374454474;4924.089043526959;4931.5315045070665;4956.033573453178;5295.364556253236;5350.973245133789;5358.892822143535;5369.463053694639;5476.91784623231;5776.277965254343;5832.212651292106;5875.823725288248;5877.5591830612875;5881.67650779207;5843.415658434165;5855.180274761537;5901.144334071579;5909.852253693649;5910.0248459004215;5301.814436494743;5365.651232669864;5379.488948549882;5536.612437129403;5545.500904918576;5964.31410387811;5972.790952316735;5975.223220981245;5975.282966044103;5989.700514974234;5745.511631511368;5747.712614369265;5752.194692743019;5758.309002919593;5772.884542309131;5675.943240567624;5722.799702010409;5729.4843464088435;5733.827985160452;5815.244018277597;5752.539796816244;5763.077907534775;5767.452092051249;5769.624974376652;5771.6248443851855;5720.542356611461;5739.225204597409;5792.478676919098;5800;5806.535477161817;4136.9793151034055;4177.081042170717;4186.518550366747;4188;4239.894002649897;3801.486799282117;3806.5051543299196;3832.3101841668768;3840.0399900024995;3869.690424766012;5481.862953426196;5494.5054945055135;5494.670319780746;5496.6701997880255;5545.528630066409;5602.887942241132;5702.144678298206;5757.193992841006;5817.796377126865;5863.5309175265875;5445.319335083114;5450.509454149145;5458.563314934796;5460.34475862899;5512.614117011771;4834.274858771212;4846.29728689338;4849.2726091086615;4857.9028419432125;4895.828645997373;5768.105943578752;5852.590318677651;5922.230110085748;5930.55520835939;5969.313528944227;5761.395053519488;5779.595428319977;5793.073108302651;5794.594378393472;5798.10129429939;5960;6001.669908155093;6004.909926351195;6007.068904319663;6020.8795824084145;5390.245365648734;5618.381977982501;5652.971735141298;5684.545236380997;5710.057840456444;5714.171445140514;5717.285339332583;5784.42155784435;5797.159411885337;5799.246098007232;5533.972330138324;5608.803691870765;5653.462921022497;5660.29246344207;5662.518685911744;5543.556515478671;5573.860653483695;5618.747156377891;5648.519875810438;5651.943480565142;5499.065158923073;5528;5530.668159910258;5538.9169162461785;5544.1960915667805;5541.861453463534;5546.667199968015;5642.097264437671;5713.085906254979;5723.370429252862;5436.9456305438025;5459.317585301837;5505.504504594605;5523.502884740393;5554.333479982266 17:45:20 INFO - PROCESS | 18004 | |1;ext.html;576.2710171632882;602.6504627316157;614.5698011392027;630.3822254190893;633.436241744847;29708.257293567673;30521.542176867366;42661.57338426619;43452.78273608635;43578.12843743123;42678;46422.07155856881;46446.535534644725;46457.767711161396;46555.76722116393;8820;8981.461112333282;8981.640734370618;8981.775455613597;8987;8788.428752131123;8888.733337999838;8888.777780555505;8893.244074253696;8896.199342059213;8939.910600894005;8971.327150463709;8980.910190898105;8981.595828187714;8984.146506081945;8902.955485222565;8910.064443233498;8953.418027828235;8955.552222388855;8955.776105597348;8806.383553151281;8864.468131912106;8867.556622168866;8872.556372181365;8875.778105547413;42968.140637187396;43309;43339.78330108361;43381.132377352595;43388.34917476241;3570.339487194877;3654.689351405134;3735.9252814943547;3749.10021594818;3768.5477742670782;33512.329753404796;33520.83239583811;33586.6641333586;33807.492887606706;35043.123921901904;4334.956650433487;4356.215881141393;4372.475302963665;4462.553744625544;4499.0776890737325;347900;350391;351117;351283.243583783;351375;57233.56598604097;58037.4196258032;58069.41930580725;58099;58107;35666.465003024976;35717.64282357195;35732.64267357345;38339.80830095887;38392.61607383946;17560.121993900255;17657.558561036076;17758.556036098944;17766.378176763752;17768.644627107384;13470.528531501546;13617.455301788015;13620.591382258548;13625;13630.795538066937;19796.802031979783;19806.801931980783;19922.402327930184;19965.700514492295;19978.400647980292;6951.6871740771785;6970.93029069713;7022.683979220845;7134;7220.530665506831;956.4261443134064;1048.4076496779296;1052.5316234275674;1072.522727386321;1101.8457415961773;32440.188995274835;32709.345813083604;32718.34563308768;32818;33518.8324058383;1079.578964203961;1100.6202860013282;1171.5021116025655;1199.850764830245;1212.405921098673;16923.661526769396;17033.14834258307;17201.913990430217;17295;17519.29922803099;532403;532439;533526;534436;535509;55775.721121394134;56252.43747562472;56282.15576766352;56346.154807677915;56429.717851411304;1222.2116734706065;1253.3921048291572;1325.191633103806;1364.1133263378883;1364.3178410794603;29716.851415743648;32864.1783955403;33124.834375827966;33368.833155834065;33963.830180848934;49995.75002124966;60015.69992150011;60237.69881150566;60238;60387.698061509414;529490;532025;537196;537582;537757;39224.51767454323;40260;43497.88489531956;45492;46978;49284.50715492799;49515.50484495253;49704.25443618276;50500.70743986802;50737.23894141665;41658.583414166686;43792.78103609462;44114;44325.77837110794;45220.09559808851;42042.789786050875;43508.782456087516;43815.34276985784;44050.779746102344;44701.32948005848;42740.358894617224;43420.34869477023;43570.78214608907;43732.34401484044;43780.78109609432;36356.272874541835;38740.80629596834;39136.608633913296;39747.80126099351;39872.2025559493;28601.713982860736;28723.712762872103;28780.712192877803;28788.280292992844;29173.270668233465 17:45:20 INFO - PROCESS | 18004 | |2;jquery.html;389.5092183848354;394.11324519830384;394.22534719276615;404.565092525535;407.9163771426858;14505.564833055;16290.83709162911;18288;18851.43445696628;18870.716939245904;18206.453806385798;18330;18680.532986675305;18729.531761705963;19300.034998250103;5543.805966791153;5572.916406253909;5685.092612475841;5706.029974904255;5706.629069110515;4175.624193822556;5622.887542249153;5693;5722.542196624281;6081.969590152043;6296.590721603104;6389.297177310492;6389.744410223609;6394.520410969173;6400.615963042233;6141.17094192285;6328.71520781566;6356.713947872334;6359.491240700733;6394.488440924715;5620.100783874601;5621.606487545873;5625.943740562583;5628.746706398222;5646.57650676201;14024.298785060808;14936.701265974729;21840;22866.428339291484;22971.96626151827;2174.195547647365;2249.718785151856;2284.611616025263;2315.1549684365255;2609.412882101531;10104.191664666883;10184.28709990301;10187.541560629716;10589.682309530726;10718;1895.876768010075;2000.6498862699116;2012.2051789543048;2014.3281076706298;2074.315475892952;70802.64598677025;72478;74326.25673743247;74870;80688.19311806925;10523.631672891564;10692.786144277072;10886.455677216107;10969.177311701655;11106.61126860556;13364.131331463424;13727.382267797973;14502.85497145036;14913.254337283093;14950.4767333145;7875.385545963179;7931.920680793118;8028.11690714021;8029;8256.8348633027;7599.240075992357;7754.612269386508;7856.528608283521;8124.7562573122905;8179.773034044941;4401.317795741666;4473.4408198975125;4578.862634120982;4662.370579971728;4760.33355330254;1862.4878158506249;1900.4108726294892;1921.5388306806267;1935.8838469691864;1937.9321723739884;891.1712107739864;941.6610020392653;948.4783369146942;982.0964712464549;988.6984469736656;17997.550061248574;18703.812961870208;18738;18756;19424.22303107888;950.695777351241;976.2141476111656;977.2231076294363;1021.5760459409411;1041.5209003858158;9873.308868379288;9983.400995940267;10332.431716255678;10424.218183636258;10498.792638846631;348631;351846;354617;474378;481803;88599;92433;93269.5336523313;94787;95057.52471237599;977.5894124467741;999.4303247149055;1035.4770840725537;1055.6041484443333;1056.587930707025;17308.82691173072;17495.300187992845;17773.377931772327;17889.821101789337;18220.817791822443;43365.3495197566;43848;44008.559914400445;44168.779156104014;44501.33248001218;54828.45171548233;54890;56360.43639563716;63450.36549634629;63564.36435635584;7622.085349758065;7895.210478952059;7979.48133371329;8100.351971842357;8135.959320203361;12101.273923564615;13618.727625447635;13687.11033782801;13799.379027943967;13976.790348144583;11893.286402815858;11957.581484647995;11984.460699268728;12196.451159697657;12262.325572093621;11898.286102833858;11956.58151964677;11974.760504790029;12006.699832504257;12328.568500102454;11935.403229838646;12033.217840840318;12166.270023798601;12209.572664956684;12334.75330493403;7454.4781865268915;8065.717699880476;8137.511749295061;8153.388495862952;8211.21993410625;9983.301168918106;11173.888261117285;11216.66350009501;11342.97913187817;11647.534098636299 17:45:20 INFO - PROCESS | 18004 | |3;mootools.html;1120.495776900395;1470.904391214571;1511.9319630616621;1634.4851371817876;1716.7424886267058;8515;8894.377393582452;8898.866517002241;9148.954255228731;9151.222146117589;8825.691100811473;9058.230050445703;9062.320325975545;9065.682701105463;9066.274698024159;2345.659879317502;2387.1883559589737;2393.7845593896545;2393.9281821545383;2395;2255.2783109404995;2285.908563657452;2286.371247906831;2295.517941232343;2297.540491901618;2322.245270287155;2345.7302410222787;2352.6588644646517;2354.0230804216317;2354.8822558872075;2286.3369622809364;2301.1830800065904;2304.746477887431;2306.1006207579057;2315.5021670340875;2248.3929339078522;2254.211026140854;2255.796978271947;2256.5035692147703;2257.119723307911;8917.286617070684;9015.098490150998;9094.136057074567;9094.49980251086;9248.815023699488;5343.09167441532;5501.477359650867;5501.614886957915;5503.559715222773;5504.779808807642;3397.711194548466;3401.3537427888623;3482.37317282889;3482.7910325380303;3487.9651203487892;1150.9366984815915;1155.9768804623945;1160.8432861563665;1162.163242465432;1162.866270378909;12745.872541274653;12826.743465130738;12831.807522887164;12864.356782160854;12866;4563.931541026887;4653.488116307203;4733.177726575224;4755.785989630475;4760.024195040009;10049.598016079275;10057.949710251401;10062.597496100074;10064.597416103421;10066.899331006744;5282.181261904411;5361.329833770778;5393.325834270716;5393.919091213635;5408.378036525771;4314.072474417952;4786.928196077061;4959.950400495949;4985.302057711923;5002.224655178453;3801.3844116250484;3822.3119838429348;3832;3870.2066076454257;4002.939955900664;1147.8737338892715;1156.9595064172713;1161.5528021711702;1162.7325715085408;1169.9181057326075;674.7402250133733;951.7906060666643;954.5895265035962;963.3304853127149;970.277143528062;5940.257467816523;5959.672218027963;6040.093985902062;6154.261488621394;6154.3845615438095;484.91998820194976;498.1332481482267;498.4492136189531;503.6247995243567;645.1773988165127;4035.858744943913;4102.528209255974;4127.4015267786;4157.168566286755;4209.621134097946;10916.345019298868;11375.203735738585;11396.202265841477;11450.770984580262;11503.769924601462;11190.216684831983;11246.381449020218;11339.092872570174;11389.886101138882;11411.543538258376;7953.562554059582;8201.917980820235;8254.05078415978;8255.42212045163;8426.41015128935;6010.9699451502465;6035.124906888389;6070.9089363658695;6244.188255526752;6349.365063493614;10058.34620749649;10270.794584108426;10427.582896684047;10431.791364172826;10541.20940929418;10407.947960260453;10614.946925265633;10628.468576570986;10647.201459890694;10747.086497647475;7431.40548756109;7929.920700793149;7993.72021979228;8111.594420279081;8196.54918979462;8994.190522852974;8996.775080623036;9056.320775941698;9062.365634405529;9066.138716821892;7779.105402878741;7862.803429914298;8025.317847982753;8084.797880052811;8087.514749115072;7410.296021877913;7500.812479688051;7544;7566.24337566239;7616.9238307616215;6993.965030174817;7020.403265722266;7037.472189585904;7050.929490705027;7066.222715501188;4880.975595122001;4992.076465853828;5017.54842064216;5132.435432102391;5154.948450515447;5144.356955380577;5157.303763991813;5225.790968361223;5236.109861323508;5244.003639308519 17:45:20 INFO - PROCESS | 18004 | |4;prototype.html;320.8780663347927;326.6961725595197;333.17040568983236;333.3982162197236;333.81139656094314;5219.13884209106;5272.841814745564;5294.338207724035;5312.389075256347;5326.7070311132875;5212.348456442945;5216.061873285674;5250.238715386266;5277.12927366984;5286.207068939651;3913.3934240192816;3993.760374377532;4136.131412403399;4138.606832350922;4146.3780432935;4080.8369614659828;4104.610062044101;4122.958770412288;4124.855630052949;4129.896752581194;3982.9402558961638;4093.5087789465156;4114.156597897424;4118.052847844998;4120.58794120587;3810.580836108026;3975.681945444372;4030.496187976503;4128.153728485683;4146.709730318879;3664.303782281358;3665.5051568038507;3672.8347224374966;3683.7291134558536;3688.2992231475932;5090.490950904917;5102.6173037022;5167.379914410295;5178.663386879878;5202.635815492917;4573.422169351568;4707.623390128816;4717.976410117962;4732.810687572493;4743.762811859393;5442.183672449125;5457.754401051962;5469.480399362054;5478.726063696799;5488.69812160331;4014.658754005913;4014.7791871447057;4030.375291829742;4038.4749982502085;4048.898777530556;5593.552515798727;5715.799947001835;5718.34168091253;5721.256236689245;5727.513161381287;4075.3071977763852;4089.672826173899;4103.466549348625;4104.8152833122585;4113.835446582103;4203.4115223868685;4204.1801848639225;4207.684423668237;4211.894702632459;4227.725197862129;4586.3579098926175;4690.179218636725;4701.3888194535175;4706.552877476703;4768.856934291976;5472.810875649692;5487.368952570426;5502.798880447853;5505.146702261076;5511.622094476381;1437.5399872041055;1441.8558144185708;1442.1563385419647;1447.9864095133448;1457.2859298943654;919.4256082967664;920.6915683246187;945.4516380499294;945.7210123013728;949.1410273702311;5164.7934082636275;5349.127805268125;5361.303030605996;5409.864753381118;5413;5690.146478028329;5706.771729130871;5706.857328566819;5707.600467967285;5730.856728581735;5177.404598471148;5339.7063161526485;5346.465353464622;5353.9732301338245;5380.219868119101;2944.6466424029254;2954.7442337007114;2962.762978961721;2974.2267010577407;2988.387380587018;5714.685692286881;5762.9914764915975;5785.033088749761;5822.359540450547;5828.970855145697;5469.535089517356;5696.946064977909;5725.227094342294;5732.398098199712;5738.483536481654;5727.742251598688;5735.971320143372;5749.655020698771;5769.798057067983;5800.8259752207505;5386.218998245311;5575.2473416088305;5579.163125531203;5595.496405323541;5724.398938111438;5620.550355971431;5626.156076588544;5635.323761148688;5657.2928383952;5659.320881494247;5804.477597016289;5869.53043756507;5875.265591801025;5888.3228428731245;5903.557233207613;3952.505936757905;4034.5763694812795;4054.817533211072;4066.1054567994993;4072.6538244249573;5675.602707810413;5686.77252909879;5710.65736055838;5711.914321285101;5724.771009159587;5511.944880551304;5582.078956972054;5594.860128496657;5596.580256480862;5625.324961004706;5570.582206334622;5579.804706835242;5585.664860108244;5601.103823388238;5601.775928962796;5187.766550505161;5413.350397952114;5440.646357986719;5449.2371068049715;5486.6982315973;5118.71847048401;5399.515133338364;5417.8103766367985;5425.810096646598;5471.890562188813;5389.865253368697;5396.892062158813;5430.945690543044;5435.130379139318;5443.346798384061 17:45:20 INFO - PROCESS | 18004 | |5;yui.html;744.9682190166618;764.8279137194129;793.1592511937346;796.876484144957;814.0638265994108;15124.924375378121;15359.462418815343;15380.61548461289;15409.152496612696;15532.068075915453;14469.638259043502;14979.47571834986;15044.097354158757;15423.922880385582;15477.535673929771;809.9959500202491;810.5379933437943;813.6460639621783;814.3485211830541;815.0871024452591;688.1226436293715;803.052398170162;812.9430939834214;823.390690888744;825.4964471672275;840.2143995364354;843.9493630382166;846.0735494633367;848.4018766769412;848.4315508609216;710.6517806274888;843.6709683223547;845.378646694682;845.4504572028169;847.4872702015284;610.1640752169557;611.1108337369117;611.434423158581;622.8193823791095;626.3204423200832;14716.55850324492;14754.852451475455;14788.260586970717;14792;14810.407583696639;13669.453221871114;13928.955328350314;14028.512347397238;14432;14443.422263109464;12510.81233781494;12570.371481425893;12707.491700331975;13163.407646655827;13292.3353832308;4450.688451808374;4467.195904737146;4552.385427967215;4557.817687292504;4575.473820510617;72517.6374118126;72815.63592182058;72964;74130.25869741288;75312.62343688247;10828.837567436494;10935.726606834893;11025.83461248082;11031.944840275908;11055.944720276348;20421.2852550163;20587;21093.050812713464;21168.153273869182;21193;8247.752567422987;8416.074231834493;8495.02307234676;8581.528015959057;8615.870761938577;4506.414166158444;4551.704139230939;4567;4568.977155114203;4632.3977882875015;3571.2143328467696;3700.629937006278;3701.648343407372;3709.647583479565;3712.925741485155;638.2787450181359;643.2184895352169;649.5323367175625;652.2433976587137;667.2360147630935;628.6919409489317;632.3985691982347;649.2339039932924;651.2965996723527;661.9966900165468;8579.399442039123;8651.6106775194;8854.38019338653;8872.06843281459;8976.102389760972;600.3786081405724;606.2482521673094;623.305014908383;642.3238821380359;658.0852614865341;4344.891377715582;4385.583369579885;4415.933760993587;4447.132809102194;4457.153140903218;67988.3201167992;68566.31433685699;77171;104918;105513;63920.680396597716;90973.54513227391;91858.61795075351;93024.53487732518;94741;86101;88576;91404;92050;92642.53678731564;8260.83478330418;8303.875441868257;8338.291245244221;8391.16088391156;8486;35575.46636800398;38345.61654383532;49609.50390496193;51195;51453.48546514487;65090;66562;74615;75631;76724;11157.888421115686;11182.664520064085;11218.38298893536;11480.196386253216;12041.879581204426;11734.471948762155;12036.458359373673;12604.432800523815;12742.61772146837;13301.866981330062;11397.772044559228;11431.371274579978;11493.482793274155;11506.884931150582;12026.639200823989;12665.873341266837;12700.555480558136;12865.678358041125;13273;13307.866921330662;11880.405979700807;12076.75846483083;12281.815772763595;12438.937805310916;12514.43685034194;9431.764205894908;9602.375845570015;9805.362651427635;10049.849252261369;10299;8435.32517398619;9234.676786312446;9607.615695372107;9686.70939871805;9693.224542036762 17:45:20 INFO - PROCESS | 18004 | __end_tp_report 17:45:20 INFO - PROCESS | 18004 | __start_cc_report 17:45:20 INFO - PROCESS | 18004 | _x_x_mozilla_cycle_collect,1094 17:45:20 INFO - PROCESS | 18004 | __end_cc_report 17:45:20 INFO - PROCESS | 18004 | __startTimestamp1466556320496__endTimestamp 17:45:20 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | ------- Summary: start ------- 17:45:20 INFO - PROCESS | 18004 | Number of tests: 6 17:45:20 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | [#0] dojo.html Cycles:165 Average:5352.51 Median:5541.86 stddev:631.45 (11.4%) stddev-sans-first:607.86 17:45:20 INFO - PROCESS | 18004 | Values: 3086.6 3089.8 3104.1 3127.8 3146.4 5192.3 5241.7 5349.9 5414.3 5462.3 5351.9 5366.8 5431.3 5465.6 5548.9 4851.8 4928.4 4930.9 4938.0 5069.9 5001.2 5044.3 5054.0 5067.5 5082.8 4813.0 4843.6 4892.3 4899.1 4928.3 4887.1 4888.0 4896.4 4901.1 4978.3 4888.3 4908.3 4924.1 4931.5 4956.0 5295.4 5351.0 5358.9 5369.5 5476.9 5776.3 5832.2 5875.8 5877.6 5881.7 5843.4 5855.2 5901.1 5909.9 5910.0 5301.8 5365.7 5379.5 5536.6 5545.5 5964.3 5972.8 5975.2 5975.3 5989.7 5745.5 5747.7 5752.2 5758.3 5772.9 5675.9 5722.8 5729.5 5733.8 5815.2 5752.5 5763.1 5767.5 5769.6 5771.6 5720.5 5739.2 5792.5 5800.0 5806.5 4137.0 4177.1 4186.5 4188.0 4239.9 3801.5 3806.5 3832.3 3840.0 3869.7 5481.9 5494.5 5494.7 5496.7 5545.5 5602.9 5702.1 5757.2 5817.8 5863.5 5445.3 5450.5 5458.6 5460.3 5512.6 4834.3 4846.3 4849.3 4857.9 4895.8 5768.1 5852.6 5922.2 5930.6 5969.3 5761.4 5779.6 5793.1 5794.6 5798.1 5960.0 6001.7 6004.9 6007.1 6020.9 5390.2 5618.4 5653.0 5684.5 5710.1 5714.2 5717.3 5784.4 5797.2 5799.2 5534.0 5608.8 5653.5 5660.3 5662.5 5543.6 5573.9 5618.7 5648.5 5651.9 5499.1 5528.0 5530.7 5538.9 5544.2 5541.9 5546.7 5642.1 5713.1 5723.4 5436.9 5459.3 5505.5 5523.5 5554.3 17:45:20 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | [#1] ext.html Cycles:180 Average:63278.85 Median:43475.33 stddev:127674.22 (293.7%) stddev-sans-first:127945.58 17:45:20 INFO - PROCESS | 18004 | Values: 576.3 602.7 614.6 630.4 633.4 29708.3 30521.5 42661.6 43452.8 43578.1 42678.0 46422.1 46446.5 46457.8 46555.8 8820.0 8981.5 8981.6 8981.8 8987.0 8788.4 8888.7 8888.8 8893.2 8896.2 8939.9 8971.3 8980.9 8981.6 8984.1 8903.0 8910.1 8953.4 8955.6 8955.8 8806.4 8864.5 8867.6 8872.6 8875.8 42968.1 43309.0 43339.8 43381.1 43388.3 3570.3 3654.7 3735.9 3749.1 3768.5 33512.3 33520.8 33586.7 33807.5 35043.1 4335.0 4356.2 4372.5 4462.6 4499.1 347900.0 350391.0 351117.0 351283.2 351375.0 57233.6 58037.4 58069.4 58099.0 58107.0 35666.5 35717.6 35732.6 38339.8 38392.6 17560.1 17657.6 17758.6 17766.4 17768.6 13470.5 13617.5 13620.6 13625.0 13630.8 19796.8 19806.8 19922.4 19965.7 19978.4 6951.7 6970.9 7022.7 7134.0 7220.5 956.4 1048.4 1052.5 1072.5 1101.8 32440.2 32709.3 32718.3 32818.0 33518.8 1079.6 1100.6 1171.5 1199.9 1212.4 16923.7 17033.1 17201.9 17295.0 17519.3 532403.0 532439.0 533526.0 534436.0 535509.0 55775.7 56252.4 56282.2 56346.2 56429.7 1222.2 1253.4 1325.2 1364.1 1364.3 29716.9 32864.2 33124.8 33368.8 33963.8 49995.8 60015.7 60237.7 60238.0 60387.7 529490.0 532025.0 537196.0 537582.0 537757.0 39224.5 40260.0 43497.9 45492.0 46978.0 49284.5 49515.5 49704.3 50500.7 50737.2 41658.6 43792.8 44114.0 44325.8 45220.1 42042.8 43508.8 43815.3 44050.8 44701.3 42740.4 43420.3 43570.8 43732.3 43780.8 36356.3 38740.8 39136.6 39747.8 39872.2 28601.7 28723.7 28780.7 28788.3 29173.3 17:45:20 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | [#2] jquery.html Cycles:180 Average:26278.81 Median:391.81 stddev:67648.15 (17265.5%) stddev-sans-first:67809.99 17:45:20 INFO - PROCESS | 18004 | Values: 389.5 394.1 394.2 404.6 407.9 14505.6 16290.8 18288.0 18851.4 18870.7 18206.5 18330.0 18680.5 18729.5 19300.0 5543.8 5572.9 5685.1 5706.0 5706.6 4175.6 5622.9 5693.0 5722.5 6082.0 6296.6 6389.3 6389.7 6394.5 6400.6 6141.2 6328.7 6356.7 6359.5 6394.5 5620.1 5621.6 5625.9 5628.7 5646.6 14024.3 14936.7 21840.0 22866.4 22972.0 2174.2 2249.7 2284.6 2315.2 2609.4 10104.2 10184.3 10187.5 10589.7 10718.0 1895.9 2000.6 2012.2 2014.3 2074.3 70802.6 72478.0 74326.3 74870.0 80688.2 10523.6 10692.8 10886.5 10969.2 11106.6 13364.1 13727.4 14502.9 14913.3 14950.5 7875.4 7931.9 8028.1 8029.0 8256.8 7599.2 7754.6 7856.5 8124.8 8179.8 4401.3 4473.4 4578.9 4662.4 4760.3 1862.5 1900.4 1921.5 1935.9 1937.9 891.2 941.7 948.5 982.1 988.7 17997.6 18703.8 18738.0 18756.0 19424.2 950.7 976.2 977.2 1021.6 1041.5 9873.3 9983.4 10332.4 10424.2 10498.8 348631.0 351846.0 354617.0 474378.0 481803.0 88599.0 92433.0 93269.5 94787.0 95057.5 977.6 999.4 1035.5 1055.6 1056.6 17308.8 17495.3 17773.4 17889.8 18220.8 43365.3 43848.0 44008.6 44168.8 44501.3 54828.5 54890.0 56360.4 63450.4 63564.4 7622.1 7895.2 7979.5 8100.4 8136.0 12101.3 13618.7 13687.1 13799.4 13976.8 11893.3 11957.6 11984.5 12196.5 12262.3 11898.3 11956.6 11974.8 12006.7 12328.6 11935.4 12033.2 12166.3 12209.6 12334.8 7454.5 8065.7 8137.5 8153.4 8211.2 9983.3 11173.9 11216.7 11343.0 11647.5 17:45:20 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | [#3] mootools.html Cycles:180 Average:5895.42 Median:4773.48 stddev:3438.26 (72.0%) stddev-sans-first:3429.18 17:45:20 INFO - PROCESS | 18004 | Values: 1120.5 1470.9 1511.9 1634.5 1716.7 8515.0 8894.4 8898.9 9149.0 9151.2 8825.7 9058.2 9062.3 9065.7 9066.3 2345.7 2387.2 2393.8 2393.9 2395.0 2255.3 2285.9 2286.4 2295.5 2297.5 2322.2 2345.7 2352.7 2354.0 2354.9 2286.3 2301.2 2304.7 2306.1 2315.5 2248.4 2254.2 2255.8 2256.5 2257.1 8917.3 9015.1 9094.1 9094.5 9248.8 5343.1 5501.5 5501.6 5503.6 5504.8 3397.7 3401.4 3482.4 3482.8 3488.0 1150.9 1156.0 1160.8 1162.2 1162.9 12745.9 12826.7 12831.8 12864.4 12866.0 4563.9 4653.5 4733.2 4755.8 4760.0 10049.6 10057.9 10062.6 10064.6 10066.9 5282.2 5361.3 5393.3 5393.9 5408.4 4314.1 4786.9 4960.0 4985.3 5002.2 3801.4 3822.3 3832.0 3870.2 4002.9 1147.9 1157.0 1161.6 1162.7 1169.9 674.7 951.8 954.6 963.3 970.3 5940.3 5959.7 6040.1 6154.3 6154.4 484.9 498.1 498.4 503.6 645.2 4035.9 4102.5 4127.4 4157.2 4209.6 10916.3 11375.2 11396.2 11450.8 11503.8 11190.2 11246.4 11339.1 11389.9 11411.5 7953.6 8201.9 8254.1 8255.4 8426.4 6011.0 6035.1 6070.9 6244.2 6349.4 10058.3 10270.8 10427.6 10431.8 10541.2 10407.9 10614.9 10628.5 10647.2 10747.1 7431.4 7929.9 7993.7 8111.6 8196.5 8994.2 8996.8 9056.3 9062.4 9066.1 7779.1 7862.8 8025.3 8084.8 8087.5 7410.3 7500.8 7544.0 7566.2 7616.9 6994.0 7020.4 7037.5 7050.9 7066.2 4881.0 4992.1 5017.5 5132.4 5154.9 5144.4 5157.3 5225.8 5236.1 5244.0 17:45:20 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | [#4] prototype.html Cycles:180 Average:4651.30 Median:5347.80 stddev:1359.41 (25.4%) stddev-sans-first:1323.80 17:45:20 INFO - PROCESS | 18004 | Values: 320.9 326.7 333.2 333.4 333.8 5219.1 5272.8 5294.3 5312.4 5326.7 5212.3 5216.1 5250.2 5277.1 5286.2 3913.4 3993.8 4136.1 4138.6 4146.4 4080.8 4104.6 4123.0 4124.9 4129.9 3982.9 4093.5 4114.2 4118.1 4120.6 3810.6 3975.7 4030.5 4128.2 4146.7 3664.3 3665.5 3672.8 3683.7 3688.3 5090.5 5102.6 5167.4 5178.7 5202.6 4573.4 4707.6 4718.0 4732.8 4743.8 5442.2 5457.8 5469.5 5478.7 5488.7 4014.7 4014.8 4030.4 4038.5 4048.9 5593.6 5715.8 5718.3 5721.3 5727.5 4075.3 4089.7 4103.5 4104.8 4113.8 4203.4 4204.2 4207.7 4211.9 4227.7 4586.4 4690.2 4701.4 4706.6 4768.9 5472.8 5487.4 5502.8 5505.1 5511.6 1437.5 1441.9 1442.2 1448.0 1457.3 919.4 920.7 945.5 945.7 949.1 5164.8 5349.1 5361.3 5409.9 5413.0 5690.1 5706.8 5706.9 5707.6 5730.9 5177.4 5339.7 5346.5 5354.0 5380.2 2944.6 2954.7 2962.8 2974.2 2988.4 5714.7 5763.0 5785.0 5822.4 5829.0 5469.5 5696.9 5725.2 5732.4 5738.5 5727.7 5736.0 5749.7 5769.8 5800.8 5386.2 5575.2 5579.2 5595.5 5724.4 5620.6 5626.2 5635.3 5657.3 5659.3 5804.5 5869.5 5875.3 5888.3 5903.6 3952.5 4034.6 4054.8 4066.1 4072.7 5675.6 5686.8 5710.7 5711.9 5724.8 5511.9 5582.1 5594.9 5596.6 5625.3 5570.6 5579.8 5585.7 5601.1 5601.8 5187.8 5413.4 5440.6 5449.2 5486.7 5118.7 5399.5 5417.8 5425.8 5471.9 5389.9 5396.9 5430.9 5435.1 5443.3 17:45:20 INFO - PROCESS | 18004 | 17:45:20 INFO - PROCESS | 18004 | [#5] yui.html Cycles:180 Average:19045.73 Median:608.21 stddev:26814.31 (4408.8%) stddev-sans-first:26854.32 17:45:20 INFO - PROCESS | 18004 | Values: 745.0 764.8 793.2 796.9 814.1 15124.9 15359.5 15380.6 15409.2 15532.1 14469.6 14979.5 15044.1 15423.9 15477.5 810.0 810.5 813.6 814.3 815.1 688.1 803.1 812.9 823.4 825.5 840.2 843.9 846.1 848.4 848.4 710.7 843.7 845.4 845.5 847.5 610.2 611.1 611.4 622.8 626.3 14716.6 14754.9 14788.3 14792.0 14810.4 13669.5 13929.0 14028.5 14432.0 14443.4 12510.8 12570.4 12707.5 13163.4 13292.3 4450.7 4467.2 4552.4 4557.8 4575.5 72517.6 72815.6 72964.0 74130.3 75312.6 10828.8 10935.7 11025.8 11031.9 11055.9 20421.3 20587.0 21093.1 21168.2 21193.0 8247.8 8416.1 8495.0 8581.5 8615.9 4506.4 4551.7 4567.0 4569.0 4632.4 3571.2 3700.6 3701.6 3709.6 3712.9 638.3 643.2 649.5 652.2 667.2 628.7 632.4 649.2 651.3 662.0 8579.4 8651.6 8854.4 8872.1 8976.1 600.4 606.2 623.3 642.3 658.1 4344.9 4385.6 4415.9 4447.1 4457.2 67988.3 68566.3 77171.0 104918.0 105513.0 63920.7 90973.5 91858.6 93024.5 94741.0 86101.0 88576.0 91404.0 92050.0 92642.5 8260.8 8303.9 8338.3 8391.2 8486.0 35575.5 38345.6 49609.5 51195.0 51453.5 65090.0 66562.0 74615.0 75631.0 76724.0 11157.9 11182.7 11218.4 11480.2 12041.9 11734.5 12036.5 12604.4 12742.6 13301.9 11397.8 11431.4 11493.5 11506.9 12026.6 12665.9 12700.6 12865.7 13273.0 13307.9 11880.4 12076.8 12281.8 12438.9 12514.4 9431.8 9602.4 9805.4 10049.8 10299.0 8435.3 9234.7 9607.6 9686.7 9693.2 17:45:20 INFO - PROCESS | 18004 | -------- Summary: end -------- 17:45:20 INFO - PROCESS | 18004 | 17:45:21 INFO - TEST-INFO | 18004: exit 0 17:45:21 INFO - TEST-OK | dromaeo_css | took 1114981ms 17:45:21 INFO - TEST-START | kraken 17:45:21 INFO - operating with platform_type : linux_ 17:45:21 INFO - Initialising browser for kraken test... 17:45:21 INFO - TEST-INFO | started process 18184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6h387/profile http://localhost:49390/getInfo.html) 17:45:25 INFO - PROCESS | 18184 | __metrics Screen width/height:1600/1200 17:45:25 INFO - PROCESS | 18184 | colorDepth:24 17:45:25 INFO - PROCESS | 18184 | Browser inner width/height: 1024/697 17:45:25 INFO - PROCESS | 18184 | __metrics 17:45:26 INFO - PROCESS | 18184 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:45:27 INFO - TEST-INFO | 18184: exit 0 17:45:27 INFO - Browser initialized. 17:45:27 INFO - Running cycle 1/1 for kraken test... 17:45:27 INFO - TEST-INFO | started process 18264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6h387/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:39 INFO - PROCESS | 18264 | RSS: Main: 173989888 17:45:39 INFO - PROCESS | 18264 | 17:45:41 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49390/tests/kraken/driver.html?testName=audio-beat-detection) 17:45:42 INFO - PROCESS | 18264 | RSS: Main: 232816640 17:45:42 INFO - PROCESS | 18264 | 17:45:45 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49390/tests/kraken/driver.html?testName=audio-dft) 17:45:46 INFO - PROCESS | 18264 | RSS: Main: 220315648 17:45:46 INFO - PROCESS | 18264 | 17:45:49 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49390/tests/kraken/driver.html?testName=audio-fft) 17:45:49 INFO - PROCESS | 18264 | RSS: Main: 286498816 17:45:49 INFO - PROCESS | 18264 | 17:45:51 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49390/tests/kraken/driver.html?testName=audio-oscillator) 17:45:52 INFO - PROCESS | 18264 | RSS: Main: 198361088 17:45:52 INFO - PROCESS | 18264 | 17:45:54 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49390/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:45:55 INFO - PROCESS | 18264 | RSS: Main: 201965568 17:45:55 INFO - PROCESS | 18264 | 17:45:58 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49390/tests/kraken/driver.html?testName=imaging-darkroom) 17:45:58 INFO - PROCESS | 18264 | RSS: Main: 236474368 17:45:58 INFO - PROCESS | 18264 | 17:46:02 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49390/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:03 INFO - PROCESS | 18264 | RSS: Main: 234110976 17:46:03 INFO - PROCESS | 18264 | 17:46:05 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49390/tests/kraken/driver.html?testName=json-parse-financial) 17:46:06 INFO - PROCESS | 18264 | RSS: Main: 236818432 17:46:06 INFO - PROCESS | 18264 | 17:46:08 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49390/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:08 INFO - PROCESS | 18264 | RSS: Main: 225046528 17:46:08 INFO - PROCESS | 18264 | 17:46:10 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:11 INFO - PROCESS | 18264 | RSS: Main: 231231488 17:46:11 INFO - PROCESS | 18264 | 17:46:13 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:13 INFO - PROCESS | 18264 | RSS: Main: 236756992 17:46:13 INFO - PROCESS | 18264 | 17:46:16 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:16 INFO - PROCESS | 18264 | RSS: Main: 238346240 17:46:16 INFO - PROCESS | 18264 | 17:46:19 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:46:20 INFO - PROCESS | 18264 | RSS: Main: 238149632 17:46:20 INFO - PROCESS | 18264 | 17:46:21 INFO - PROCESS | 18264 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49390/tests/kraken/driver.html?testName=ai-astar) 17:46:22 INFO - PROCESS | 18264 | RSS: Main: 281464832 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | __start_tp_report 17:46:22 INFO - PROCESS | 18264 | _x_x_mozilla_page_load 17:46:22 INFO - PROCESS | 18264 | _x_x_mozilla_page_load_details 17:46:22 INFO - PROCESS | 18264 | |i|pagename|runs| 17:46:22 INFO - PROCESS | 18264 | |0;ai-astar;110;106;111;112;111;111;109;108;109;110 17:46:22 INFO - PROCESS | 18264 | |1;audio-beat-detection;164;130;133;155;125;163;154;131;180;126 17:46:22 INFO - PROCESS | 18264 | |2;audio-dft;160;161;161;162;161;160;161;160;161;161 17:46:22 INFO - PROCESS | 18264 | |3;audio-fft;75;74;74;125;75;76;75;75;97;74 17:46:22 INFO - PROCESS | 18264 | |4;audio-oscillator;84;85;115;86;85;85;117;84;84;133 17:46:22 INFO - PROCESS | 18264 | |5;imaging-gaussian-blur;118;118;118;118;117;118;117;118;117;117 17:46:22 INFO - PROCESS | 18264 | |6;imaging-darkroom;148;148;146;147;147;148;147;147;146;147 17:46:22 INFO - PROCESS | 18264 | |7;imaging-desaturate;95;95;95;94;95;95;96;96;96;96 17:46:22 INFO - PROCESS | 18264 | |8;json-parse-financial;52;54;51;53;52;54;52;53;52;53 17:46:22 INFO - PROCESS | 18264 | |9;json-stringify-tinderbox;62;63;62;63;63;63;63;63;63;64 17:46:22 INFO - PROCESS | 18264 | |10;stanford-crypto-aes;80;80;79;79;78;80;80;80;108;83 17:46:22 INFO - PROCESS | 18264 | |11;stanford-crypto-ccm;121;122;119;119;129;120;122;127;135;127 17:46:22 INFO - PROCESS | 18264 | |12;stanford-crypto-pbkdf2;159;158;168;158;162;158;159;162;158;158 17:46:22 INFO - PROCESS | 18264 | |13;stanford-crypto-sha256-iterative;64;62;63;62;62;63;62;62;62;62 17:46:22 INFO - PROCESS | 18264 | __end_tp_report 17:46:22 INFO - PROCESS | 18264 | __start_cc_report 17:46:22 INFO - PROCESS | 18264 | _x_x_mozilla_cycle_collect,1630 17:46:22 INFO - PROCESS | 18264 | __end_cc_report 17:46:22 INFO - PROCESS | 18264 | __startTimestamp1466556382066__endTimestamp 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | ------- Summary: start ------- 17:46:22 INFO - PROCESS | 18264 | Number of tests: 14 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:1.77 (1.6%) stddev-sans-first:1.87 17:46:22 INFO - PROCESS | 18264 | Values: 110.0 106.0 111.0 112.0 111.0 111.0 109.0 108.0 109.0 110.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:154.50 stddev:19.45 (12.6%) stddev-sans-first:19.52 17:46:22 INFO - PROCESS | 18264 | Values: 164.0 130.0 133.0 155.0 125.0 163.0 154.0 131.0 180.0 126.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 17:46:22 INFO - PROCESS | 18264 | Values: 160.0 161.0 161.0 162.0 161.0 160.0 161.0 160.0 161.0 161.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:16.66 (22.2%) stddev-sans-first:17.48 17:46:22 INFO - PROCESS | 18264 | Values: 75.0 74.0 74.0 125.0 75.0 76.0 75.0 75.0 97.0 74.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:84.50 stddev:18.46 (21.8%) stddev-sans-first:19.08 17:46:22 INFO - PROCESS | 18264 | Values: 84.0 85.0 115.0 86.0 85.0 85.0 117.0 84.0 84.0 133.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:46:22 INFO - PROCESS | 18264 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 17:46:22 INFO - PROCESS | 18264 | Values: 148.0 148.0 146.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:46:22 INFO - PROCESS | 18264 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 96.0 96.0 96.0 96.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 17:46:22 INFO - PROCESS | 18264 | Values: 52.0 54.0 51.0 53.0 52.0 54.0 52.0 53.0 52.0 53.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 17:46:22 INFO - PROCESS | 18264 | Values: 62.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:80.00 stddev:8.98 (11.2%) stddev-sans-first:9.47 17:46:22 INFO - PROCESS | 18264 | Values: 80.0 80.0 79.0 79.0 78.0 80.0 80.0 80.0 108.0 83.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.50 stddev:5.24 (4.2%) stddev-sans-first:5.43 17:46:22 INFO - PROCESS | 18264 | Values: 121.0 122.0 119.0 119.0 129.0 120.0 122.0 127.0 135.0 127.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:159.00 stddev:3.23 (2.0%) stddev-sans-first:3.41 17:46:22 INFO - PROCESS | 18264 | Values: 159.0 158.0 168.0 158.0 162.0 158.0 159.0 162.0 158.0 158.0 17:46:22 INFO - PROCESS | 18264 | 17:46:22 INFO - PROCESS | 18264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.44 17:46:22 INFO - PROCESS | 18264 | Values: 64.0 62.0 63.0 62.0 62.0 63.0 62.0 62.0 62.0 62.0 17:46:22 INFO - PROCESS | 18264 | -------- Summary: end -------- 17:46:22 INFO - PROCESS | 18264 | 17:46:23 INFO - TEST-INFO | 18264: exit 0 17:46:23 INFO - TEST-OK | kraken | took 61813ms 17:46:23 INFO - SUITE-END | took 1176s 17:46:23 INFO - Completed test suite (00:19:36) 17:46:23 INFO - javascript benchmark 17:46:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.6296044474666, 3089.752819774418, 3104.0687793661896, 3127.781055326128, 3146.354997225569, 5192.273081768555, 5241.737913104339, 5349.893002139955, 5414.3232095988005, 5462.289902312698, 5351.946480535194, 5366.758495867685, 5431.321084864392, 5465.6447330923465, 5548.944510554903, 4851.757412129397, 4928.43323017854, 4930.901381972359, 4937.975310123462, 5069.873253168664, 5001.249812528114, 5044.2937988681615, 5054.039732450841, 5067.543921047105, 5082.771275292621, 4812.951870481303, 4843.612510999147, 4892.315075889343, 4899.093667671456, 4928.26076088586, 4887.071456423304, 4887.975560122212, 4896.387951506062, 4901.1177987962155, 4978.278149668314, 4888.340074090023, 4908.337374454474, 4924.089043526959, 4931.5315045070665, 4956.033573453178, 5295.364556253236, 5350.973245133789, 5358.892822143535, 5369.463053694639, 5476.91784623231, 5776.277965254343, 5832.212651292106, 5875.823725288248, 5877.5591830612875, 5881.67650779207, 5843.415658434165, 5855.180274761537, 5901.144334071579, 5909.852253693649, 5910.0248459004215, 5301.814436494743, 5365.651232669864, 5379.488948549882, 5536.612437129403, 5545.500904918576, 5964.31410387811, 5972.790952316735, 5975.223220981245, 5975.282966044103, 5989.700514974234, 5745.511631511368, 5747.712614369265, 5752.194692743019, 5758.309002919593, 5772.884542309131, 5675.943240567624, 5722.799702010409, 5729.4843464088435, 5733.827985160452, 5815.244018277597, 5752.539796816244, 5763.077907534775, 5767.452092051249, 5769.624974376652, 5771.6248443851855, 5720.542356611461, 5739.225204597409, 5792.478676919098, 5800.0, 5806.535477161817, 4136.9793151034055, 4177.081042170717, 4186.518550366747, 4188.0, 4239.894002649897, 3801.486799282117, 3806.5051543299196, 3832.3101841668768, 3840.0399900024995, 3869.690424766012, 5481.862953426196, 5494.5054945055135, 5494.670319780746, 5496.6701997880255, 5545.528630066409, 5602.887942241132, 5702.144678298206, 5757.193992841006, 5817.796377126865, 5863.5309175265875, 5445.319335083114, 5450.509454149145, 5458.563314934796, 5460.34475862899, 5512.614117011771, 4834.274858771212, 4846.29728689338, 4849.2726091086615, 4857.9028419432125, 4895.828645997373, 5768.105943578752, 5852.590318677651, 5922.230110085748, 5930.55520835939, 5969.313528944227, 5761.395053519488, 5779.595428319977, 5793.073108302651, 5794.594378393472, 5798.10129429939, 5960.0, 6001.669908155093, 6004.909926351195, 6007.068904319663, 6020.8795824084145, 5390.245365648734, 5618.381977982501, 5652.971735141298, 5684.545236380997, 5710.057840456444, 5714.171445140514, 5717.285339332583, 5784.42155784435, 5797.159411885337, 5799.246098007232, 5533.972330138324, 5608.803691870765, 5653.462921022497, 5660.29246344207, 5662.518685911744, 5543.556515478671, 5573.860653483695, 5618.747156377891, 5648.519875810438, 5651.943480565142, 5499.065158923073, 5528.0, 5530.668159910258, 5538.9169162461785, 5544.1960915667805, 5541.861453463534, 5546.667199968015, 5642.097264437671, 5713.085906254979, 5723.370429252862, 5436.9456305438025, 5459.317585301837, 5505.504504594605, 5523.502884740393, 5554.333479982266], "value": 5308.117926435557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2710171632882, 602.6504627316157, 614.5698011392027, 630.3822254190893, 633.436241744847, 29708.257293567673, 30521.542176867366, 42661.57338426619, 43452.78273608635, 43578.12843743123, 42678.0, 46422.07155856881, 46446.535534644725, 46457.767711161396, 46555.76722116393, 8820.0, 8981.461112333282, 8981.640734370618, 8981.775455613597, 8987.0, 8788.428752131123, 8888.733337999838, 8888.777780555505, 8893.244074253696, 8896.199342059213, 8939.910600894005, 8971.327150463709, 8980.910190898105, 8981.595828187714, 8984.146506081945, 8902.955485222565, 8910.064443233498, 8953.418027828235, 8955.552222388855, 8955.776105597348, 8806.383553151281, 8864.468131912106, 8867.556622168866, 8872.556372181365, 8875.778105547413, 42968.140637187396, 43309.0, 43339.78330108361, 43381.132377352595, 43388.34917476241, 3570.339487194877, 3654.689351405134, 3735.9252814943547, 3749.10021594818, 3768.5477742670782, 33512.329753404796, 33520.83239583811, 33586.6641333586, 33807.492887606706, 35043.123921901904, 4334.956650433487, 4356.215881141393, 4372.475302963665, 4462.553744625544, 4499.0776890737325, 347900.0, 350391.0, 351117.0, 351283.243583783, 351375.0, 57233.56598604097, 58037.4196258032, 58069.41930580725, 58099.0, 58107.0, 35666.465003024976, 35717.64282357195, 35732.64267357345, 38339.80830095887, 38392.61607383946, 17560.121993900255, 17657.558561036076, 17758.556036098944, 17766.378176763752, 17768.644627107384, 13470.528531501546, 13617.455301788015, 13620.591382258548, 13625.0, 13630.795538066937, 19796.802031979783, 19806.801931980783, 19922.402327930184, 19965.700514492295, 19978.400647980292, 6951.6871740771785, 6970.93029069713, 7022.683979220845, 7134.0, 7220.530665506831, 956.4261443134064, 1048.4076496779296, 1052.5316234275674, 1072.522727386321, 1101.8457415961773, 32440.188995274835, 32709.345813083604, 32718.34563308768, 32818.0, 33518.8324058383, 1079.578964203961, 1100.6202860013282, 1171.5021116025655, 1199.850764830245, 1212.405921098673, 16923.661526769396, 17033.14834258307, 17201.913990430217, 17295.0, 17519.29922803099, 532403.0, 532439.0, 533526.0, 534436.0, 535509.0, 55775.721121394134, 56252.43747562472, 56282.15576766352, 56346.154807677915, 56429.717851411304, 1222.2116734706065, 1253.3921048291572, 1325.191633103806, 1364.1133263378883, 1364.3178410794603, 29716.851415743648, 32864.1783955403, 33124.834375827966, 33368.833155834065, 33963.830180848934, 49995.75002124966, 60015.69992150011, 60237.69881150566, 60238.0, 60387.698061509414, 529490.0, 532025.0, 537196.0, 537582.0, 537757.0, 39224.51767454323, 40260.0, 43497.88489531956, 45492.0, 46978.0, 49284.50715492799, 49515.50484495253, 49704.25443618276, 50500.70743986802, 50737.23894141665, 41658.583414166686, 43792.78103609462, 44114.0, 44325.77837110794, 45220.09559808851, 42042.789786050875, 43508.782456087516, 43815.34276985784, 44050.779746102344, 44701.32948005848, 42740.358894617224, 43420.34869477023, 43570.78214608907, 43732.34401484044, 43780.78109609432, 36356.272874541835, 38740.80629596834, 39136.608633913296, 39747.80126099351, 39872.2025559493, 28601.713982860736, 28723.712762872103, 28780.712192877803, 28788.280292992844, 29173.270668233465], "value": 20590.012749421086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.5092183848354, 394.11324519830384, 394.22534719276615, 404.565092525535, 407.9163771426858, 14505.564833055, 16290.83709162911, 18288.0, 18851.43445696628, 18870.716939245904, 18206.453806385798, 18330.0, 18680.532986675305, 18729.531761705963, 19300.034998250103, 5543.805966791153, 5572.916406253909, 5685.092612475841, 5706.029974904255, 5706.629069110515, 4175.624193822556, 5622.887542249153, 5693.0, 5722.542196624281, 6081.969590152043, 6296.590721603104, 6389.297177310492, 6389.744410223609, 6394.520410969173, 6400.615963042233, 6141.17094192285, 6328.71520781566, 6356.713947872334, 6359.491240700733, 6394.488440924715, 5620.100783874601, 5621.606487545873, 5625.943740562583, 5628.746706398222, 5646.57650676201, 14024.298785060808, 14936.701265974729, 21840.0, 22866.428339291484, 22971.96626151827, 2174.195547647365, 2249.718785151856, 2284.611616025263, 2315.1549684365255, 2609.412882101531, 10104.191664666883, 10184.28709990301, 10187.541560629716, 10589.682309530726, 10718.0, 1895.876768010075, 2000.6498862699116, 2012.2051789543048, 2014.3281076706298, 2074.315475892952, 70802.64598677025, 72478.0, 74326.25673743247, 74870.0, 80688.19311806925, 10523.631672891564, 10692.786144277072, 10886.455677216107, 10969.177311701655, 11106.61126860556, 13364.131331463424, 13727.382267797973, 14502.85497145036, 14913.254337283093, 14950.4767333145, 7875.385545963179, 7931.920680793118, 8028.11690714021, 8029.0, 8256.8348633027, 7599.240075992357, 7754.612269386508, 7856.528608283521, 8124.7562573122905, 8179.773034044941, 4401.317795741666, 4473.4408198975125, 4578.862634120982, 4662.370579971728, 4760.33355330254, 1862.4878158506249, 1900.4108726294892, 1921.5388306806267, 1935.8838469691864, 1937.9321723739884, 891.1712107739864, 941.6610020392653, 948.4783369146942, 982.0964712464549, 988.6984469736656, 17997.550061248574, 18703.812961870208, 18738.0, 18756.0, 19424.22303107888, 950.695777351241, 976.2141476111656, 977.2231076294363, 1021.5760459409411, 1041.5209003858158, 9873.308868379288, 9983.400995940267, 10332.431716255678, 10424.218183636258, 10498.792638846631, 348631.0, 351846.0, 354617.0, 474378.0, 481803.0, 88599.0, 92433.0, 93269.5336523313, 94787.0, 95057.52471237599, 977.5894124467741, 999.4303247149055, 1035.4770840725537, 1055.6041484443333, 1056.587930707025, 17308.82691173072, 17495.300187992845, 17773.377931772327, 17889.821101789337, 18220.817791822443, 43365.3495197566, 43848.0, 44008.559914400445, 44168.779156104014, 44501.33248001218, 54828.45171548233, 54890.0, 56360.43639563716, 63450.36549634629, 63564.36435635584, 7622.085349758065, 7895.210478952059, 7979.48133371329, 8100.351971842357, 8135.959320203361, 12101.273923564615, 13618.727625447635, 13687.11033782801, 13799.379027943967, 13976.790348144583, 11893.286402815858, 11957.581484647995, 11984.460699268728, 12196.451159697657, 12262.325572093621, 11898.286102833858, 11956.58151964677, 11974.760504790029, 12006.699832504257, 12328.568500102454, 11935.403229838646, 12033.217840840318, 12166.270023798601, 12209.572664956684, 12334.75330493403, 7454.4781865268915, 8065.717699880476, 8137.511749295061, 8153.388495862952, 8211.21993410625, 9983.301168918106, 11173.888261117285, 11216.66350009501, 11342.97913187817, 11647.534098636299], "value": 9058.71701451463, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1120.495776900395, 1470.904391214571, 1511.9319630616621, 1634.4851371817876, 1716.7424886267058, 8515.0, 8894.377393582452, 8898.866517002241, 9148.954255228731, 9151.222146117589, 8825.691100811473, 9058.230050445703, 9062.320325975545, 9065.682701105463, 9066.274698024159, 2345.659879317502, 2387.1883559589737, 2393.7845593896545, 2393.9281821545383, 2395.0, 2255.2783109404995, 2285.908563657452, 2286.371247906831, 2295.517941232343, 2297.540491901618, 2322.245270287155, 2345.7302410222787, 2352.6588644646517, 2354.0230804216317, 2354.8822558872075, 2286.3369622809364, 2301.1830800065904, 2304.746477887431, 2306.1006207579057, 2315.5021670340875, 2248.3929339078522, 2254.211026140854, 2255.796978271947, 2256.5035692147703, 2257.119723307911, 8917.286617070684, 9015.098490150998, 9094.136057074567, 9094.49980251086, 9248.815023699488, 5343.09167441532, 5501.477359650867, 5501.614886957915, 5503.559715222773, 5504.779808807642, 3397.711194548466, 3401.3537427888623, 3482.37317282889, 3482.7910325380303, 3487.9651203487892, 1150.9366984815915, 1155.9768804623945, 1160.8432861563665, 1162.163242465432, 1162.866270378909, 12745.872541274653, 12826.743465130738, 12831.807522887164, 12864.356782160854, 12866.0, 4563.931541026887, 4653.488116307203, 4733.177726575224, 4755.785989630475, 4760.024195040009, 10049.598016079275, 10057.949710251401, 10062.597496100074, 10064.597416103421, 10066.899331006744, 5282.181261904411, 5361.329833770778, 5393.325834270716, 5393.919091213635, 5408.378036525771, 4314.072474417952, 4786.928196077061, 4959.950400495949, 4985.302057711923, 5002.224655178453, 3801.3844116250484, 3822.3119838429348, 3832.0, 3870.2066076454257, 4002.939955900664, 1147.8737338892715, 1156.9595064172713, 1161.5528021711702, 1162.7325715085408, 1169.9181057326075, 674.7402250133733, 951.7906060666643, 954.5895265035962, 963.3304853127149, 970.277143528062, 5940.257467816523, 5959.672218027963, 6040.093985902062, 6154.261488621394, 6154.3845615438095, 484.91998820194976, 498.1332481482267, 498.4492136189531, 503.6247995243567, 645.1773988165127, 4035.858744943913, 4102.528209255974, 4127.4015267786, 4157.168566286755, 4209.621134097946, 10916.345019298868, 11375.203735738585, 11396.202265841477, 11450.770984580262, 11503.769924601462, 11190.216684831983, 11246.381449020218, 11339.092872570174, 11389.886101138882, 11411.543538258376, 7953.562554059582, 8201.917980820235, 8254.05078415978, 8255.42212045163, 8426.41015128935, 6010.9699451502465, 6035.124906888389, 6070.9089363658695, 6244.188255526752, 6349.365063493614, 10058.34620749649, 10270.794584108426, 10427.582896684047, 10431.791364172826, 10541.20940929418, 10407.947960260453, 10614.946925265633, 10628.468576570986, 10647.201459890694, 10747.086497647475, 7431.40548756109, 7929.920700793149, 7993.72021979228, 8111.594420279081, 8196.54918979462, 8994.190522852974, 8996.775080623036, 9056.320775941698, 9062.365634405529, 9066.138716821892, 7779.105402878741, 7862.803429914298, 8025.317847982753, 8084.797880052811, 8087.514749115072, 7410.296021877913, 7500.812479688051, 7544.0, 7566.24337566239, 7616.9238307616215, 6993.965030174817, 7020.403265722266, 7037.472189585904, 7050.929490705027, 7066.222715501188, 4880.975595122001, 4992.076465853828, 5017.54842064216, 5132.435432102391, 5154.948450515447, 5144.356955380577, 5157.303763991813, 5225.790968361223, 5236.109861323508, 5244.003639308519], "value": 4603.002848229488, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.8780663347927, 326.6961725595197, 333.17040568983236, 333.3982162197236, 333.81139656094314, 5219.13884209106, 5272.841814745564, 5294.338207724035, 5312.389075256347, 5326.7070311132875, 5212.348456442945, 5216.061873285674, 5250.238715386266, 5277.12927366984, 5286.207068939651, 3913.3934240192816, 3993.760374377532, 4136.131412403399, 4138.606832350922, 4146.3780432935, 4080.8369614659828, 4104.610062044101, 4122.958770412288, 4124.855630052949, 4129.896752581194, 3982.9402558961638, 4093.5087789465156, 4114.156597897424, 4118.052847844998, 4120.58794120587, 3810.580836108026, 3975.681945444372, 4030.496187976503, 4128.153728485683, 4146.709730318879, 3664.303782281358, 3665.5051568038507, 3672.8347224374966, 3683.7291134558536, 3688.2992231475932, 5090.490950904917, 5102.6173037022, 5167.379914410295, 5178.663386879878, 5202.635815492917, 4573.422169351568, 4707.623390128816, 4717.976410117962, 4732.810687572493, 4743.762811859393, 5442.183672449125, 5457.754401051962, 5469.480399362054, 5478.726063696799, 5488.69812160331, 4014.658754005913, 4014.7791871447057, 4030.375291829742, 4038.4749982502085, 4048.898777530556, 5593.552515798727, 5715.799947001835, 5718.34168091253, 5721.256236689245, 5727.513161381287, 4075.3071977763852, 4089.672826173899, 4103.466549348625, 4104.8152833122585, 4113.835446582103, 4203.4115223868685, 4204.1801848639225, 4207.684423668237, 4211.894702632459, 4227.725197862129, 4586.3579098926175, 4690.179218636725, 4701.3888194535175, 4706.552877476703, 4768.856934291976, 5472.810875649692, 5487.368952570426, 5502.798880447853, 5505.146702261076, 5511.622094476381, 1437.5399872041055, 1441.8558144185708, 1442.1563385419647, 1447.9864095133448, 1457.2859298943654, 919.4256082967664, 920.6915683246187, 945.4516380499294, 945.7210123013728, 949.1410273702311, 5164.7934082636275, 5349.127805268125, 5361.303030605996, 5409.864753381118, 5413.0, 5690.146478028329, 5706.771729130871, 5706.857328566819, 5707.600467967285, 5730.856728581735, 5177.404598471148, 5339.7063161526485, 5346.465353464622, 5353.9732301338245, 5380.219868119101, 2944.6466424029254, 2954.7442337007114, 2962.762978961721, 2974.2267010577407, 2988.387380587018, 5714.685692286881, 5762.9914764915975, 5785.033088749761, 5822.359540450547, 5828.970855145697, 5469.535089517356, 5696.946064977909, 5725.227094342294, 5732.398098199712, 5738.483536481654, 5727.742251598688, 5735.971320143372, 5749.655020698771, 5769.798057067983, 5800.8259752207505, 5386.218998245311, 5575.2473416088305, 5579.163125531203, 5595.496405323541, 5724.398938111438, 5620.550355971431, 5626.156076588544, 5635.323761148688, 5657.2928383952, 5659.320881494247, 5804.477597016289, 5869.53043756507, 5875.265591801025, 5888.3228428731245, 5903.557233207613, 3952.505936757905, 4034.5763694812795, 4054.817533211072, 4066.1054567994993, 4072.6538244249573, 5675.602707810413, 5686.77252909879, 5710.65736055838, 5711.914321285101, 5724.771009159587, 5511.944880551304, 5582.078956972054, 5594.860128496657, 5596.580256480862, 5625.324961004706, 5570.582206334622, 5579.804706835242, 5585.664860108244, 5601.103823388238, 5601.775928962796, 5187.766550505161, 5413.350397952114, 5440.646357986719, 5449.2371068049715, 5486.6982315973, 5118.71847048401, 5399.515133338364, 5417.8103766367985, 5425.810096646598, 5471.890562188813, 5389.865253368697, 5396.892062158813, 5430.945690543044, 5435.130379139318, 5443.346798384061], "value": 4217.7854869685725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9682190166618, 764.8279137194129, 793.1592511937346, 796.876484144957, 814.0638265994108, 15124.924375378121, 15359.462418815343, 15380.61548461289, 15409.152496612696, 15532.068075915453, 14469.638259043502, 14979.47571834986, 15044.097354158757, 15423.922880385582, 15477.535673929771, 809.9959500202491, 810.5379933437943, 813.6460639621783, 814.3485211830541, 815.0871024452591, 688.1226436293715, 803.052398170162, 812.9430939834214, 823.390690888744, 825.4964471672275, 840.2143995364354, 843.9493630382166, 846.0735494633367, 848.4018766769412, 848.4315508609216, 710.6517806274888, 843.6709683223547, 845.378646694682, 845.4504572028169, 847.4872702015284, 610.1640752169557, 611.1108337369117, 611.434423158581, 622.8193823791095, 626.3204423200832, 14716.55850324492, 14754.852451475455, 14788.260586970717, 14792.0, 14810.407583696639, 13669.453221871114, 13928.955328350314, 14028.512347397238, 14432.0, 14443.422263109464, 12510.81233781494, 12570.371481425893, 12707.491700331975, 13163.407646655827, 13292.3353832308, 4450.688451808374, 4467.195904737146, 4552.385427967215, 4557.817687292504, 4575.473820510617, 72517.6374118126, 72815.63592182058, 72964.0, 74130.25869741288, 75312.62343688247, 10828.837567436494, 10935.726606834893, 11025.83461248082, 11031.944840275908, 11055.944720276348, 20421.2852550163, 20587.0, 21093.050812713464, 21168.153273869182, 21193.0, 8247.752567422987, 8416.074231834493, 8495.02307234676, 8581.528015959057, 8615.870761938577, 4506.414166158444, 4551.704139230939, 4567.0, 4568.977155114203, 4632.3977882875015, 3571.2143328467696, 3700.629937006278, 3701.648343407372, 3709.647583479565, 3712.925741485155, 638.2787450181359, 643.2184895352169, 649.5323367175625, 652.2433976587137, 667.2360147630935, 628.6919409489317, 632.3985691982347, 649.2339039932924, 651.2965996723527, 661.9966900165468, 8579.399442039123, 8651.6106775194, 8854.38019338653, 8872.06843281459, 8976.102389760972, 600.3786081405724, 606.2482521673094, 623.305014908383, 642.3238821380359, 658.0852614865341, 4344.891377715582, 4385.583369579885, 4415.933760993587, 4447.132809102194, 4457.153140903218, 67988.3201167992, 68566.31433685699, 77171.0, 104918.0, 105513.0, 63920.680396597716, 90973.54513227391, 91858.61795075351, 93024.53487732518, 94741.0, 86101.0, 88576.0, 91404.0, 92050.0, 92642.53678731564, 8260.83478330418, 8303.875441868257, 8338.291245244221, 8391.16088391156, 8486.0, 35575.46636800398, 38345.61654383532, 49609.50390496193, 51195.0, 51453.48546514487, 65090.0, 66562.0, 74615.0, 75631.0, 76724.0, 11157.888421115686, 11182.664520064085, 11218.38298893536, 11480.196386253216, 12041.879581204426, 11734.471948762155, 12036.458359373673, 12604.432800523815, 12742.61772146837, 13301.866981330062, 11397.772044559228, 11431.371274579978, 11493.482793274155, 11506.884931150582, 12026.639200823989, 12665.873341266837, 12700.555480558136, 12865.678358041125, 13273.0, 13307.866921330662, 11880.405979700807, 12076.75846483083, 12281.815772763595, 12438.937805310916, 12514.43685034194, 9431.764205894908, 9602.375845570015, 9805.362651427635, 10049.849252261369, 10299.0, 8435.32517398619, 9234.676786312446, 9607.615695372107, 9686.70939871805, 9693.224542036762], "value": 7173.823242289894, "unit": "score"}], "name": "dromaeo_css", "value": 7187.829071712594, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 112.0, 111.0, 111.0, 109.0, 108.0, 109.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 133.0, 155.0, 125.0, 163.0, 154.0, 131.0, 180.0, 126.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 125.0, 75.0, 76.0, 75.0, 75.0, 97.0, 74.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 115.0, 86.0, 85.0, 85.0, 117.0, 84.0, 84.0, 133.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 51.0, 53.0, 52.0, 54.0, 52.0, 53.0, 52.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 78.0, 80.0, 80.0, 80.0, 108.0, 83.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 119.0, 119.0, 129.0, 120.0, 122.0, 127.0, 135.0, 127.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 168.0, 158.0, 162.0, 158.0, 159.0, 162.0, 158.0, 158.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1499.1000000000001, "alertThreshold": 2.0}]} 17:46:23 INFO - Return code: 0 17:46:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:46:23 INFO - # TBPL SUCCESS # 17:46:23 INFO - Running post-action listener: _resource_record_post_action 17:46:23 INFO - ##### 17:46:23 INFO - ##### Finished run-tests step (success) 17:46:23 INFO - ##### 17:46:23 INFO - Running post-run listener: _resource_record_post_run 17:46:23 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551219200; Read time: 12; Write time: 615192 17:46:23 INFO - TinderboxPrint: CPU usage
13.2% 17:46:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:46:23 INFO - TinderboxPrint: I/O write bytes / time
551,219,200 / 615,192 17:46:23 INFO - TinderboxPrint: CPU idle
8,277.9 (86.8%) 17:46:23 INFO - TinderboxPrint: CPU user
1,208.1 (12.7%) 17:46:23 INFO - TinderboxPrint: Swap in / out
0 / 0 17:46:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256462848; Read time: 0; Write time: 274596 17:46:23 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294756352; Read time: 12; Write time: 340596 17:46:24 INFO - Running post-run listener: _upload_blobber_files 17:46:24 INFO - Blob upload gear active. 17:46:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:46:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:46:24 INFO - (blobuploader) - INFO - Open directory for files ... 17:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:46:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:28 INFO - (blobuploader) - INFO - Done attempting. 17:46:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:46:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:29 INFO - (blobuploader) - INFO - Done attempting. 17:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:46:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:30 INFO - (blobuploader) - INFO - Done attempting. 17:46:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:46:30 INFO - Return code: 0 17:46:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:46:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:46:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12acba9c5077c541bf8570a2408b793578ad6ceb17d9d1c432f969ad17070994dad90e1cfc30ea5411ac8b81a1890157ec97fcd4470de13ad29479fbb5dfa84c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e9cb532f415ae97ed5500733f07f61d3825a7ab7fc31e8cd3223245524c72c46a4cc12446dcc72f3df5e0f625ac2988fdcf755a19697fba8fda71c042bfa35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86079c71662395daf87c9238109e9cda81ec7850e5624f85b7763439fba06c29c07698873ea2e6bd3515a8270eea3889859377d0d40618579773acb42056fb47"} 17:46:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:46:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:46:30 INFO - Contents: 17:46:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12acba9c5077c541bf8570a2408b793578ad6ceb17d9d1c432f969ad17070994dad90e1cfc30ea5411ac8b81a1890157ec97fcd4470de13ad29479fbb5dfa84c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e9cb532f415ae97ed5500733f07f61d3825a7ab7fc31e8cd3223245524c72c46a4cc12446dcc72f3df5e0f625ac2988fdcf755a19697fba8fda71c042bfa35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86079c71662395daf87c9238109e9cda81ec7850e5624f85b7763439fba06c29c07698873ea2e6bd3515a8270eea3889859377d0d40618579773acb42056fb47"} 17:46:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:46:30 INFO - Copying logs to upload dir... 17:46:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:46:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.036192 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-21 17:46:29.144300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 17:46:29.147587) ========= 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=fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12acba9c5077c541bf8570a2408b793578ad6ceb17d9d1c432f969ad17070994dad90e1cfc30ea5411ac8b81a1890157ec97fcd4470de13ad29479fbb5dfa84c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e9cb532f415ae97ed5500733f07f61d3825a7ab7fc31e8cd3223245524c72c46a4cc12446dcc72f3df5e0f625ac2988fdcf755a19697fba8fda71c042bfa35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86079c71662395daf87c9238109e9cda81ec7850e5624f85b7763439fba06c29c07698873ea2e6bd3515a8270eea3889859377d0d40618579773acb42056fb47"} build_url:https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/FpvzctAwTRiXFJlzPmx3Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12acba9c5077c541bf8570a2408b793578ad6ceb17d9d1c432f969ad17070994dad90e1cfc30ea5411ac8b81a1890157ec97fcd4470de13ad29479fbb5dfa84c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e9cb532f415ae97ed5500733f07f61d3825a7ab7fc31e8cd3223245524c72c46a4cc12446dcc72f3df5e0f625ac2988fdcf755a19697fba8fda71c042bfa35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86079c71662395daf87c9238109e9cda81ec7850e5624f85b7763439fba06c29c07698873ea2e6bd3515a8270eea3889859377d0d40618579773acb42056fb47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 17:46:29.173560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 17:46:29.173943) ========= 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=fa44defc139c4ba8574fe040000001db-1466552129.516883-1300269031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 17:46:29.257549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 17:46:29.257912) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 17:46:29.258259) ========= ========= Total master_lag: 0.17 =========