builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1465286747.23 results: success (0) buildid: 20160606223051 builduid: 7c072ad2ce0743cd9e16bad9a6b5a684 revision: d8c954e520e4f30cc5e4d1b9c574f777edba24c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.227592) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.228099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.228379) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.243700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.244134) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 01:05:47-- 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% 43.1M=0s 2016-06-07 01:05:47 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.372340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.372735) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015744 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.422943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:47.423337) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d8c954e520e4f30cc5e4d1b9c574f777edba24c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d8c954e520e4f30cc5e4d1b9c574f777edba24c4 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 01:05:48,106 truncating revision to first 12 chars 2016-06-07 01:05:48,106 Setting DEBUG logging. 2016-06-07 01:05:48,106 attempt 1/10 2016-06-07 01:05:48,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d8c954e520e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 01:05:48,728 unpacking tar archive at: mozilla-inbound-d8c954e520e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979133 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:48.416408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:48.416818) ========= script_repo_revision: d8c954e520e4f30cc5e4d1b9c574f777edba24c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:48.417293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:48.417679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:05:48.428776) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-07 01:05:48.429060) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:05:49 INFO - MultiFileLogger online at 20160607 01:05:49 in /builds/slave/test 01:05:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:05:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:05:49 INFO - {'append_to_log': False, 01:05:49 INFO - 'base_work_dir': '/builds/slave/test', 01:05:49 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:05:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:05:49 INFO - 'branch': 'Mozilla-Inbound', 01:05:49 INFO - 'buildbot_json_path': 'buildprops.json', 01:05:49 INFO - 'config_files': ('talos/linux_config.py',), 01:05:49 INFO - 'default_actions': ('clobber', 01:05:49 INFO - 'read-buildbot-config', 01:05:49 INFO - 'download-and-extract', 01:05:49 INFO - 'populate-webroot', 01:05:49 INFO - 'create-virtualenv', 01:05:49 INFO - 'install', 01:05:49 INFO - 'run-tests'), 01:05:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:05:49 INFO - 'download_minidump_stackwalk': True, 01:05:49 INFO - 'download_symbols': 'ondemand', 01:05:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:05:49 INFO - 'tooltool.py': '/tools/tooltool.py', 01:05:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:05:49 INFO - '/tools/misc-python/virtualenv.py')}, 01:05:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:05:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:05:49 INFO - 'installer_path': 'installer.exe', 01:05:49 INFO - 'log_level': 'info', 01:05:49 INFO - 'log_name': 'talos', 01:05:49 INFO - 'log_to_console': True, 01:05:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:05:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:05:49 INFO - 'opt_config_files': (), 01:05:49 INFO - 'pip_index': False, 01:05:49 INFO - 'sps_profile': False, 01:05:49 INFO - 'sps_profile_interval': 0, 01:05:49 INFO - 'suite': 'dromaeojs', 01:05:49 INFO - 'system_bits': '32', 01:05:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:05:49 INFO - 'title': 'talos-linux64-ix-041', 01:05:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:05:49 INFO - 'use_talos_json': True, 01:05:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:05:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:05:49 INFO - 'work_dir': 'build'} 01:05:49 INFO - ##### 01:05:49 INFO - ##### Running clobber step. 01:05:49 INFO - ##### 01:05:49 INFO - Running pre-action listener: _resource_record_pre_action 01:05:49 INFO - Running main action method: clobber 01:05:49 INFO - rmtree: /builds/slave/test/build 01:05:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:05:49 INFO - Running post-action listener: _resource_record_post_action 01:05:49 INFO - ##### 01:05:49 INFO - ##### Finished clobber step (success) 01:05:49 INFO - ##### 01:05:49 INFO - ##### 01:05:49 INFO - ##### Running read-buildbot-config step. 01:05:49 INFO - ##### 01:05:49 INFO - Running pre-action listener: _resource_record_pre_action 01:05:49 INFO - Running main action method: read_buildbot_config 01:05:49 INFO - Using buildbot properties: 01:05:49 INFO - { 01:05:49 INFO - "project": "", 01:05:49 INFO - "product": "firefox", 01:05:49 INFO - "script_repo_revision": "production", 01:05:49 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:05:49 INFO - "repository": "", 01:05:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:05:49 INFO - "buildid": "20160606223051", 01:05:49 INFO - "pgo_build": "True", 01:05:49 INFO - "basedir": "/builds/slave/test", 01:05:49 INFO - "buildnumber": 1137, 01:05:49 INFO - "slavename": "talos-linux64-ix-041", 01:05:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:05:49 INFO - "platform": "ubuntu64_hw", 01:05:49 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:05:49 INFO - "branch": "mozilla-inbound", 01:05:49 INFO - "repo_path": "integration/mozilla-inbound", 01:05:49 INFO - "revision": "d8c954e520e4f30cc5e4d1b9c574f777edba24c4", 01:05:49 INFO - "stage_platform": "linux64-pgo", 01:05:49 INFO - "builduid": "7c072ad2ce0743cd9e16bad9a6b5a684", 01:05:49 INFO - "slavebuilddir": "test" 01:05:49 INFO - } 01:05:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:05:49 INFO - Running post-action listener: _resource_record_post_action 01:05:49 INFO - ##### 01:05:49 INFO - ##### Finished read-buildbot-config step (success) 01:05:49 INFO - ##### 01:05:49 INFO - ##### 01:05:49 INFO - ##### Running download-and-extract step. 01:05:49 INFO - ##### 01:05:49 INFO - Running pre-action listener: _resource_record_pre_action 01:05:49 INFO - Running main action method: download_and_extract 01:05:49 INFO - mkdir: /builds/slave/test/build/tests 01:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:49 INFO - https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:05:50 INFO - Downloaded 1361 bytes. 01:05:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:05:50 INFO - Using the following test package requirements: 01:05:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:05:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:05:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:05:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:50 INFO - u'jsshell-linux-x86_64.zip'], 01:05:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:05:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:05:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:05:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:05:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:05:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:05:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:05:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:50 INFO - https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:05:52 INFO - Downloaded 24444951 bytes. 01:05:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:05:53 INFO - Return code: 0 01:05:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:53 INFO - https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:05:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:05:54 INFO - Downloaded 24444951 bytes. 01:05:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:05:56 INFO - Return code: 0 01:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:56 INFO - https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:05:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:05:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:05:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:05:58 INFO - Downloaded 10833369 bytes. 01:05:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:05:59 INFO - Return code: 0 01:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:59 INFO - https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:06:00 INFO - Downloaded 59161346 bytes. 01:06:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:00 INFO - mkdir: /builds/slave/test/properties 01:06:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:06:00 INFO - Writing to file /builds/slave/test/properties/build_url 01:06:00 INFO - Contents: 01:06:00 INFO - build_url:https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:06:01 INFO - Running post-action listener: _resource_record_post_action 01:06:01 INFO - Running post-action listener: set_extra_try_arguments 01:06:01 INFO - ##### 01:06:01 INFO - ##### Finished download-and-extract step (success) 01:06:01 INFO - ##### 01:06:01 INFO - ##### 01:06:01 INFO - ##### Running populate-webroot step. 01:06:01 INFO - ##### 01:06:01 INFO - Running pre-action listener: _resource_record_pre_action 01:06:01 INFO - Running main action method: populate_webroot 01:06:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:06:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:06:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:06:01 INFO - '--tppagecycles', 01:06:01 INFO - '7'], 01:06:01 INFO - 'tests': ['tsvgm']}}, 01:06:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:06:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:06:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:06:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:06:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:01 INFO - 'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:01 INFO - 'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['damp', 'tps']}, 01:06:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:01 INFO - 'tests': ['damp', 'tps']}, 01:06:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['dromaeo_dom']}, 01:06:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:06:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['a11yr', 01:06:01 INFO - 'ts_paint', 01:06:01 INFO - 'tpaint', 01:06:01 INFO - 'sessionrestore', 01:06:01 INFO - 'sessionrestore_no_auto_restore', 01:06:01 INFO - 'tabpaint']}, 01:06:01 INFO - 'other-e10s': {'tests': ['a11yr', 01:06:01 INFO - 'ts_paint', 01:06:01 INFO - 'tpaint', 01:06:01 INFO - 'sessionrestore', 01:06:01 INFO - 'sessionrestore_no_auto_restore', 01:06:01 INFO - 'tabpaint']}, 01:06:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:06:01 INFO - 'ts_paint', 01:06:01 INFO - 'tpaint', 01:06:01 INFO - 'sessionrestore', 01:06:01 INFO - 'sessionrestore_no_auto_restore', 01:06:01 INFO - 'tabpaint']}, 01:06:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:06:01 INFO - 'ts_paint', 01:06:01 INFO - 'tpaint', 01:06:01 INFO - 'sessionrestore', 01:06:01 INFO - 'sessionrestore_no_auto_restore', 01:06:01 INFO - 'tabpaint']}, 01:06:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['a11yr', 01:06:01 INFO - 'ts_paint', 01:06:01 INFO - 'tpaint', 01:06:01 INFO - 'sessionrestore', 01:06:01 INFO - 'sessionrestore_no_auto_restore', 01:06:01 INFO - 'tabpaint']}, 01:06:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['a11yr', 01:06:01 INFO - 'ts_paint', 01:06:01 INFO - 'tpaint', 01:06:01 INFO - 'sessionrestore', 01:06:01 INFO - 'sessionrestore_no_auto_restore', 01:06:01 INFO - 'tabpaint']}, 01:06:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['tsvgx', 01:06:01 INFO - 'tsvgr_opacity', 01:06:01 INFO - 'tart', 01:06:01 INFO - 'tscrollx', 01:06:01 INFO - 'cart']}, 01:06:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:06:01 INFO - 'tsvgr_opacity', 01:06:01 INFO - 'tart', 01:06:01 INFO - 'tscrollx', 01:06:01 INFO - 'cart']}, 01:06:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:01 INFO - 'talos_options': ['--disable-e10s'], 01:06:01 INFO - 'tests': ['tp5o']}, 01:06:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:01 INFO - 'tests': ['tp5o']}, 01:06:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:01 INFO - 'talos_options': ['--disable-e10s', 01:06:01 INFO - '--xperf_path', 01:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:01 INFO - 'tests': ['tp5n']}, 01:06:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:01 INFO - 'talos_options': ['--xperf_path', 01:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:01 INFO - 'tests': ['tp5n']}}, 01:06:01 INFO - 'talos.zip': {'path': '', 01:06:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:06:01 INFO - Running post-action listener: _resource_record_post_action 01:06:01 INFO - ##### 01:06:01 INFO - ##### Finished populate-webroot step (success) 01:06:01 INFO - ##### 01:06:01 INFO - ##### 01:06:01 INFO - ##### Running create-virtualenv step. 01:06:01 INFO - ##### 01:06:01 INFO - Running pre-action listener: _resource_record_pre_action 01:06:01 INFO - Running main action method: create_virtualenv 01:06:01 INFO - Creating virtualenv /builds/slave/test/build/venv 01:06:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:06:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:06:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:06:01 INFO - Using real prefix '/usr' 01:06:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:06:02 INFO - Installing distribute.............................................................................................................................................................................................done. 01:06:03 INFO - Installing pip.................done. 01:06:03 INFO - Return code: 0 01:06:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:03 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 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:06:03 INFO - Using env: {'DISPLAY': ':0', 01:06:03 INFO - 'HOME': '/home/cltbld', 01:06:03 INFO - 'LANG': 'en_US.UTF-8', 01:06:03 INFO - 'LANGUAGE': 'en_US:en', 01:06:03 INFO - 'LOGNAME': 'cltbld', 01:06:03 INFO - 'MAIL': '/var/mail/cltbld', 01:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:03 INFO - 'MOZ_NO_REMOTE': '1', 01:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:03 INFO - 'NO_EM_RESTART': '1', 01:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:03 INFO - 'PWD': '/builds/slave/test', 01:06:03 INFO - 'SHELL': '/bin/bash', 01:06:03 INFO - 'SHLVL': '1', 01:06:03 INFO - 'TERM': 'linux', 01:06:03 INFO - 'TMOUT': '86400', 01:06:03 INFO - 'USER': 'cltbld', 01:06:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:03 INFO - '_': '/tools/buildbot/bin/python'} 01:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:06:04 INFO - Cleaning up... 01:06:04 INFO - Return code: 0 01:06:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:04 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 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:06:04 INFO - Using env: {'DISPLAY': ':0', 01:06:04 INFO - 'HOME': '/home/cltbld', 01:06:04 INFO - 'LANG': 'en_US.UTF-8', 01:06:04 INFO - 'LANGUAGE': 'en_US:en', 01:06:04 INFO - 'LOGNAME': 'cltbld', 01:06:04 INFO - 'MAIL': '/var/mail/cltbld', 01:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:04 INFO - 'MOZ_NO_REMOTE': '1', 01:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:04 INFO - 'NO_EM_RESTART': '1', 01:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:04 INFO - 'PWD': '/builds/slave/test', 01:06:04 INFO - 'SHELL': '/bin/bash', 01:06:04 INFO - 'SHLVL': '1', 01:06:04 INFO - 'TERM': 'linux', 01:06:04 INFO - 'TMOUT': '86400', 01:06:04 INFO - 'USER': 'cltbld', 01:06:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:04 INFO - '_': '/tools/buildbot/bin/python'} 01:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:04 INFO - Downloading/unpacking psutil>=3.1.1 01:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:06:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:06:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:06:06 INFO - Installing collected packages: psutil 01:06:06 INFO - Running setup.py install for psutil 01:06:06 INFO - building 'psutil._psutil_linux' extension 01:06:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:06:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:06:06 INFO - building 'psutil._psutil_posix' extension 01:06:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:06:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:06:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:06:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:06:06 INFO - Successfully installed psutil 01:06:06 INFO - Cleaning up... 01:06:06 INFO - Return code: 0 01:06:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:06 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 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:06:06 INFO - Using env: {'DISPLAY': ':0', 01:06:06 INFO - 'HOME': '/home/cltbld', 01:06:06 INFO - 'LANG': 'en_US.UTF-8', 01:06:06 INFO - 'LANGUAGE': 'en_US:en', 01:06:06 INFO - 'LOGNAME': 'cltbld', 01:06:06 INFO - 'MAIL': '/var/mail/cltbld', 01:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:06 INFO - 'MOZ_NO_REMOTE': '1', 01:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:06 INFO - 'NO_EM_RESTART': '1', 01:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:06 INFO - 'PWD': '/builds/slave/test', 01:06:06 INFO - 'SHELL': '/bin/bash', 01:06:06 INFO - 'SHLVL': '1', 01:06:06 INFO - 'TERM': 'linux', 01:06:06 INFO - 'TMOUT': '86400', 01:06:06 INFO - 'USER': 'cltbld', 01:06:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:06 INFO - '_': '/tools/buildbot/bin/python'} 01:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:06:09 INFO - Installing collected packages: mozsystemmonitor 01:06:09 INFO - Running setup.py install for mozsystemmonitor 01:06:09 INFO - Successfully installed mozsystemmonitor 01:06:09 INFO - Cleaning up... 01:06:09 INFO - Return code: 0 01:06:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:09 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 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:06:09 INFO - Using env: {'DISPLAY': ':0', 01:06:09 INFO - 'HOME': '/home/cltbld', 01:06:09 INFO - 'LANG': 'en_US.UTF-8', 01:06:09 INFO - 'LANGUAGE': 'en_US:en', 01:06:09 INFO - 'LOGNAME': 'cltbld', 01:06:09 INFO - 'MAIL': '/var/mail/cltbld', 01:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:09 INFO - 'MOZ_NO_REMOTE': '1', 01:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:09 INFO - 'NO_EM_RESTART': '1', 01:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:09 INFO - 'PWD': '/builds/slave/test', 01:06:09 INFO - 'SHELL': '/bin/bash', 01:06:09 INFO - 'SHLVL': '1', 01:06:09 INFO - 'TERM': 'linux', 01:06:09 INFO - 'TMOUT': '86400', 01:06:09 INFO - 'USER': 'cltbld', 01:06:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:09 INFO - '_': '/tools/buildbot/bin/python'} 01:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:09 INFO - Downloading/unpacking jsonschema==2.5.1 01:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:06:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:12 INFO - Downloading functools32-3.2.3-2.tar.gz 01:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:06:12 INFO - warning: no files found matching '*.txt' 01:06:12 INFO - no previously-included directories found matching 'build' 01:06:12 INFO - no previously-included directories found matching 'dist' 01:06:12 INFO - no previously-included directories found matching '.git*' 01:06:12 INFO - Installing collected packages: jsonschema, functools32 01:06:12 INFO - Running setup.py install for functools32 01:06:12 INFO - warning: no files found matching '*.txt' 01:06:12 INFO - no previously-included directories found matching 'build' 01:06:12 INFO - no previously-included directories found matching 'dist' 01:06:12 INFO - no previously-included directories found matching '.git*' 01:06:12 INFO - Successfully installed jsonschema functools32 01:06:12 INFO - Cleaning up... 01:06:12 INFO - Return code: 0 01:06:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:12 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 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:06:12 INFO - Using env: {'DISPLAY': ':0', 01:06:12 INFO - 'HOME': '/home/cltbld', 01:06:12 INFO - 'LANG': 'en_US.UTF-8', 01:06:12 INFO - 'LANGUAGE': 'en_US:en', 01:06:12 INFO - 'LOGNAME': 'cltbld', 01:06:12 INFO - 'MAIL': '/var/mail/cltbld', 01:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:12 INFO - 'MOZ_NO_REMOTE': '1', 01:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:12 INFO - 'NO_EM_RESTART': '1', 01:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:12 INFO - 'PWD': '/builds/slave/test', 01:06:12 INFO - 'SHELL': '/bin/bash', 01:06:12 INFO - 'SHLVL': '1', 01:06:12 INFO - 'TERM': 'linux', 01:06:12 INFO - 'TMOUT': '86400', 01:06:12 INFO - 'USER': 'cltbld', 01:06:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:12 INFO - '_': '/tools/buildbot/bin/python'} 01:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:12 INFO - Downloading/unpacking blobuploader==1.2.4 01:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:14 INFO - Downloading blobuploader-1.2.4.tar.gz 01:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:06:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:06:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06:15 INFO - Downloading docopt-0.6.1.tar.gz 01:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:06:15 INFO - Installing collected packages: blobuploader, requests, docopt 01:06:15 INFO - Running setup.py install for blobuploader 01:06:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:06:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:06:15 INFO - Running setup.py install for requests 01:06:16 INFO - Running setup.py install for docopt 01:06:16 INFO - Successfully installed blobuploader requests docopt 01:06:16 INFO - Cleaning up... 01:06:16 INFO - Return code: 0 01:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:16 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 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:06:16 INFO - Using env: {'DISPLAY': ':0', 01:06:16 INFO - 'HOME': '/home/cltbld', 01:06:16 INFO - 'LANG': 'en_US.UTF-8', 01:06:16 INFO - 'LANGUAGE': 'en_US:en', 01:06:16 INFO - 'LOGNAME': 'cltbld', 01:06:16 INFO - 'MAIL': '/var/mail/cltbld', 01:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:16 INFO - 'MOZ_NO_REMOTE': '1', 01:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:16 INFO - 'NO_EM_RESTART': '1', 01:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:16 INFO - 'PWD': '/builds/slave/test', 01:06:16 INFO - 'SHELL': '/bin/bash', 01:06:16 INFO - 'SHLVL': '1', 01:06:16 INFO - 'TERM': 'linux', 01:06:16 INFO - 'TMOUT': '86400', 01:06:16 INFO - 'USER': 'cltbld', 01:06:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:16 INFO - '_': '/tools/buildbot/bin/python'} 01:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:16 INFO - Running setup.py (path:/tmp/pip-T8flIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:16 INFO - Running setup.py (path:/tmp/pip-Mf9hwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:16 INFO - Running setup.py (path:/tmp/pip-yju8da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:16 INFO - Running setup.py (path:/tmp/pip-7Qe78E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:16 INFO - Running setup.py (path:/tmp/pip-rqRMUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:16 INFO - Running setup.py (path:/tmp/pip-GjGXSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:16 INFO - Running setup.py (path:/tmp/pip-BzexX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:16 INFO - Running setup.py (path:/tmp/pip-N1WQEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:17 INFO - Running setup.py (path:/tmp/pip-p90msb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:17 INFO - Running setup.py (path:/tmp/pip-cZqF82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:17 INFO - Running setup.py (path:/tmp/pip-WueHw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:17 INFO - Running setup.py (path:/tmp/pip-PmGaHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:17 INFO - Running setup.py (path:/tmp/pip-eFwmAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:17 INFO - Running setup.py (path:/tmp/pip-X0y69g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:17 INFO - Running setup.py (path:/tmp/pip-YlNa0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:17 INFO - Running setup.py (path:/tmp/pip-kQZ69g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:17 INFO - Running setup.py (path:/tmp/pip-hiWX18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:06:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:06:17 INFO - Running setup.py install for manifestparser 01:06:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:06:17 INFO - Running setup.py install for mozcrash 01:06:17 INFO - Running setup.py install for mozdebug 01:06:17 INFO - Running setup.py install for mozdevice 01:06:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Running setup.py install for mozfile 01:06:18 INFO - Running setup.py install for mozhttpd 01:06:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Running setup.py install for mozinfo 01:06:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Running setup.py install for mozInstall 01:06:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Running setup.py install for mozleak 01:06:18 INFO - Running setup.py install for mozlog 01:06:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Running setup.py install for moznetwork 01:06:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:06:18 INFO - Running setup.py install for mozprocess 01:06:18 INFO - Running setup.py install for mozprofile 01:06:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:06:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:06:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:06:19 INFO - Running setup.py install for mozrunner 01:06:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:06:19 INFO - Running setup.py install for mozscreenshot 01:06:19 INFO - Running setup.py install for moztest 01:06:19 INFO - Running setup.py install for mozversion 01:06:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:06:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:06:19 INFO - Cleaning up... 01:06:19 INFO - Return code: 0 01:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:19 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 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:06:19 INFO - Using env: {'DISPLAY': ':0', 01:06:19 INFO - 'HOME': '/home/cltbld', 01:06:19 INFO - 'LANG': 'en_US.UTF-8', 01:06:19 INFO - 'LANGUAGE': 'en_US:en', 01:06:19 INFO - 'LOGNAME': 'cltbld', 01:06:19 INFO - 'MAIL': '/var/mail/cltbld', 01:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:19 INFO - 'MOZ_NO_REMOTE': '1', 01:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:19 INFO - 'NO_EM_RESTART': '1', 01:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:19 INFO - 'PWD': '/builds/slave/test', 01:06:19 INFO - 'SHELL': '/bin/bash', 01:06:19 INFO - 'SHLVL': '1', 01:06:19 INFO - 'TERM': 'linux', 01:06:19 INFO - 'TMOUT': '86400', 01:06:19 INFO - 'USER': 'cltbld', 01:06:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:19 INFO - '_': '/tools/buildbot/bin/python'} 01:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:19 INFO - Running setup.py (path:/tmp/pip-O0eVdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:19 INFO - Running setup.py (path:/tmp/pip-RX10mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:19 INFO - Running setup.py (path:/tmp/pip-c5Ymof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:19 INFO - Running setup.py (path:/tmp/pip-khXBbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:19 INFO - Running setup.py (path:/tmp/pip-mdjRtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06: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)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:20 INFO - Running setup.py (path:/tmp/pip-xgOrVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:20 INFO - Running setup.py (path:/tmp/pip-PcNRfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:20 INFO - Running setup.py (path:/tmp/pip-qRtDT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:20 INFO - Running setup.py (path:/tmp/pip-eLnmQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:20 INFO - Running setup.py (path:/tmp/pip-s9JYvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:20 INFO - Running setup.py (path:/tmp/pip-BOftXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:20 INFO - Running setup.py (path:/tmp/pip-6atKlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:20 INFO - Running setup.py (path:/tmp/pip-0Kn9qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:20 INFO - Running setup.py (path:/tmp/pip-K3VGkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:20 INFO - Running setup.py (path:/tmp/pip-6QXi9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:20 INFO - Running setup.py (path:/tmp/pip-kBpyRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:20 INFO - Running setup.py (path:/tmp/pip-_lrJRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:06:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:22 INFO - Downloading blessings-1.6.tar.gz 01:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:06:22 INFO - Installing collected packages: blessings 01:06:22 INFO - Running setup.py install for blessings 01:06:22 INFO - Successfully installed blessings 01:06:22 INFO - Cleaning up... 01:06:23 INFO - Return code: 0 01:06:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:06:23 INFO - Reading from file tmpfile_stdout 01:06:23 INFO - Current package versions: 01:06:23 INFO - argparse == 1.2.1 01:06:23 INFO - blessings == 1.6 01:06:23 INFO - blobuploader == 1.2.4 01:06:23 INFO - docopt == 0.6.1 01:06:23 INFO - functools32 == 3.2.3-2 01:06:23 INFO - jsonschema == 2.5.1 01:06:23 INFO - manifestparser == 1.1 01:06:23 INFO - mozInstall == 1.12 01:06:23 INFO - mozcrash == 0.17 01:06:23 INFO - mozdebug == 0.1 01:06:23 INFO - mozdevice == 0.48 01:06:23 INFO - mozfile == 1.2 01:06:23 INFO - mozhttpd == 0.7 01:06:23 INFO - mozinfo == 0.9 01:06:23 INFO - mozleak == 0.1 01:06:23 INFO - mozlog == 3.2 01:06:23 INFO - moznetwork == 0.27 01:06:23 INFO - mozprocess == 0.22 01:06:23 INFO - mozprofile == 0.28 01:06:23 INFO - mozrunner == 6.11 01:06:23 INFO - mozscreenshot == 0.1 01:06:23 INFO - mozsystemmonitor == 0.3 01:06:23 INFO - moztest == 0.7 01:06:23 INFO - mozversion == 1.4 01:06:23 INFO - psutil == 3.1.1 01:06:23 INFO - requests == 1.2.3 01:06:23 INFO - wsgiref == 0.1.2 01:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:23 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 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:06:23 INFO - Using env: {'DISPLAY': ':0', 01:06:23 INFO - 'HOME': '/home/cltbld', 01:06:23 INFO - 'LANG': 'en_US.UTF-8', 01:06:23 INFO - 'LANGUAGE': 'en_US:en', 01:06:23 INFO - 'LOGNAME': 'cltbld', 01:06:23 INFO - 'MAIL': '/var/mail/cltbld', 01:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:23 INFO - 'MOZ_NO_REMOTE': '1', 01:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:23 INFO - 'NO_EM_RESTART': '1', 01:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:23 INFO - 'PWD': '/builds/slave/test', 01:06:23 INFO - 'SHELL': '/bin/bash', 01:06:23 INFO - 'SHLVL': '1', 01:06:23 INFO - 'TERM': 'linux', 01:06:23 INFO - 'TMOUT': '86400', 01:06:23 INFO - 'USER': 'cltbld', 01:06:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:23 INFO - '_': '/tools/buildbot/bin/python'} 01:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:06:23 INFO - Cleaning up... 01:06:23 INFO - Return code: 0 01:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:06:23 INFO - Using env: {'DISPLAY': ':0', 01:06:23 INFO - 'HOME': '/home/cltbld', 01:06:23 INFO - 'LANG': 'en_US.UTF-8', 01:06:23 INFO - 'LANGUAGE': 'en_US:en', 01:06:23 INFO - 'LOGNAME': 'cltbld', 01:06:23 INFO - 'MAIL': '/var/mail/cltbld', 01:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:23 INFO - 'MOZ_NO_REMOTE': '1', 01:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:23 INFO - 'NO_EM_RESTART': '1', 01:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:23 INFO - 'PWD': '/builds/slave/test', 01:06:23 INFO - 'SHELL': '/bin/bash', 01:06:23 INFO - 'SHLVL': '1', 01:06:23 INFO - 'TERM': 'linux', 01:06:23 INFO - 'TMOUT': '86400', 01:06:23 INFO - 'USER': 'cltbld', 01:06:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:23 INFO - '_': '/tools/buildbot/bin/python'} 01:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:06:23 INFO - Cleaning up... 01:06:23 INFO - Return code: 0 01:06:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe32cbabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b55350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:06:23 INFO - Using env: {'DISPLAY': ':0', 01:06:23 INFO - 'HOME': '/home/cltbld', 01:06:23 INFO - 'LANG': 'en_US.UTF-8', 01:06:23 INFO - 'LANGUAGE': 'en_US:en', 01:06:23 INFO - 'LOGNAME': 'cltbld', 01:06:23 INFO - 'MAIL': '/var/mail/cltbld', 01:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:23 INFO - 'MOZ_NO_REMOTE': '1', 01:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:23 INFO - 'NO_EM_RESTART': '1', 01:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:23 INFO - 'PWD': '/builds/slave/test', 01:06:23 INFO - 'SHELL': '/bin/bash', 01:06:23 INFO - 'SHLVL': '1', 01:06:23 INFO - 'TERM': 'linux', 01:06:23 INFO - 'TMOUT': '86400', 01:06:23 INFO - 'USER': 'cltbld', 01:06:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:23 INFO - '_': '/tools/buildbot/bin/python'} 01:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:23 INFO - Downloading/unpacking flake8 01:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:06:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:06:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:06:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:06:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:06:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:06:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:06:26 INFO - no previously-included directories found matching 'docs/_build' 01:06:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:06:26 INFO - Running setup.py install for pep8 01:06:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:06:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:06:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:06:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:06:26 INFO - no previously-included directories found matching 'docs/_build' 01:06:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:06:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:06:26 INFO - Cleaning up... 01:06:26 INFO - Return code: 0 01:06:26 INFO - Running post-action listener: _resource_record_post_action 01:06:26 INFO - Running post-action listener: _start_resource_monitoring 01:06:26 INFO - Starting resource monitoring. 01:06:26 INFO - ##### 01:06:26 INFO - ##### Finished create-virtualenv step (success) 01:06:26 INFO - ##### 01:06:26 INFO - ##### 01:06:26 INFO - ##### Running install step. 01:06:26 INFO - ##### 01:06:26 INFO - Running pre-action listener: _resource_record_pre_action 01:06:26 INFO - Running main action method: install 01:06:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:06:27 INFO - Reading from file tmpfile_stdout 01:06:27 INFO - Detecting whether we're running mozinstall >=1.0... 01:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:06:27 INFO - Reading from file tmpfile_stdout 01:06:27 INFO - Output received: 01:06:27 INFO - Usage: mozinstall [options] installer 01:06:27 INFO - Options: 01:06:27 INFO - -h, --help show this help message and exit 01:06:27 INFO - -d DEST, --destination=DEST 01:06:27 INFO - Directory to install application into. [default: 01:06:27 INFO - "/builds/slave/test"] 01:06:27 INFO - --app=APP Application being installed. [default: firefox] 01:06:27 INFO - mkdir: /builds/slave/test/build/application 01:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:06:43 INFO - Reading from file tmpfile_stdout 01:06:43 INFO - Output received: 01:06:43 INFO - /builds/slave/test/build/application/firefox/firefox 01:06:43 INFO - Running post-action listener: _resource_record_post_action 01:06:43 INFO - ##### 01:06:43 INFO - ##### Finished install step (success) 01:06:43 INFO - ##### 01:06:43 INFO - ##### 01:06:43 INFO - ##### Running run-tests step. 01:06:43 INFO - ##### 01:06:43 INFO - Running pre-action listener: _resource_record_pre_action 01:06:43 INFO - Running main action method: run_tests 01:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:06:43 INFO - Python 2.7.3 01:06:43 INFO - Return code: 0 01:06:43 INFO - grabbing minidump binary from tooltool 01:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:43 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 0x1be41c0>, '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 0x1be50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be5550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:06:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:06:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:06:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:06:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:06:44 INFO - Return code: 0 01:06:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:06:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:06:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:06:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:06:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:06:44 INFO - Return code: 0 01:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 01:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 01:06:44 INFO - Using env: {'DISPLAY': ':0', 01:06:44 INFO - 'HOME': '/home/cltbld', 01:06:44 INFO - 'LANG': 'en_US.UTF-8', 01:06:44 INFO - 'LANGUAGE': 'en_US:en', 01:06:44 INFO - 'LOGNAME': 'cltbld', 01:06:44 INFO - 'MAIL': '/var/mail/cltbld', 01:06:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:06:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:44 INFO - 'MOZ_NO_REMOTE': '1', 01:06:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:44 INFO - 'NO_EM_RESTART': '1', 01:06:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:44 INFO - 'PWD': '/builds/slave/test', 01:06:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:06:44 INFO - 'SHELL': '/bin/bash', 01:06:44 INFO - 'SHLVL': '1', 01:06:44 INFO - 'TERM': 'linux', 01:06:44 INFO - 'TMOUT': '86400', 01:06:44 INFO - 'USER': 'cltbld', 01:06:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422', 01:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:44 INFO - '_': '/tools/buildbot/bin/python'} 01:06:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 01:06:45 INFO - mozversion application_buildid: 20160606223051 01:06:45 INFO - mozversion application_changeset: d8c954e520e4f30cc5e4d1b9c574f777edba24c4 01:06:45 INFO - mozversion application_display_name: Nightly 01:06:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:06:45 INFO - mozversion application_name: Firefox 01:06:45 INFO - mozversion application_remotingname: firefox 01:06:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:06:45 INFO - mozversion application_vendor: Mozilla 01:06:45 INFO - mozversion application_version: 50.0a1 01:06:45 INFO - mozversion platform_buildid: 20160606223051 01:06:45 INFO - mozversion platform_changeset: d8c954e520e4f30cc5e4d1b9c574f777edba24c4 01:06:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:06:45 INFO - mozversion platform_version: 50.0a1 01:06:45 INFO - using testdate: 1465286805 01:06:45 INFO - actual date: 1465286805 01:06:45 INFO - starting webserver on 'localhost:47939' 01:06:45 INFO - SUITE-START | Running 2 tests 01:06:45 INFO - TEST-START | dromaeo_css 01:06:45 INFO - operating with platform_type : linux_ 01:06:45 INFO - Initialising browser for dromaeo_css test... 01:06:45 INFO - TEST-INFO | started process 4761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4hZY2i/profile http://localhost:47939/getInfo.html) 01:06:49 INFO - PROCESS | 4761 | __metrics Screen width/height:1600/1200 01:06:49 INFO - PROCESS | 4761 | colorDepth:24 01:06:49 INFO - PROCESS | 4761 | Browser inner width/height: 1024/697 01:06:49 INFO - PROCESS | 4761 | __metrics 01:06:50 ERROR - PROCESS | 4761 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:06:50 INFO - PROCESS | 4761 | console.error: PushService: 01:06:50 INFO - PROCESS | 4761 | stateChangeProcessEnqueue: Error transitioning state 01:06:50 INFO - PROCESS | 4761 | UnknownError 01:06:51 INFO - TEST-INFO | 4761: exit 0 01:06:51 INFO - Browser initialized. 01:06:51 INFO - Running cycle 1/1 for dromaeo_css test... 01:06:51 INFO - TEST-INFO | started process 4846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4hZY2i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:07:03 INFO - PROCESS | 4846 | RSS: Main: 155713536 01:07:03 INFO - PROCESS | 4846 | 01:07:54 INFO - PROCESS | 4846 | 1465286874552 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:10:02 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47939/tests/dromaeo/cssquery-ext.html) 01:10:03 INFO - PROCESS | 4846 | RSS: Main: 244879360 01:10:03 INFO - PROCESS | 4846 | 01:13:05 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-ext.html (next: http://localhost:47939/tests/dromaeo/cssquery-jquery.html) 01:13:06 INFO - PROCESS | 4846 | RSS: Main: 237592576 01:13:06 INFO - PROCESS | 4846 | 01:16:08 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47939/tests/dromaeo/cssquery-mootools.html) 01:16:09 INFO - PROCESS | 4846 | RSS: Main: 238936064 01:16:09 INFO - PROCESS | 4846 | 01:19:11 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47939/tests/dromaeo/cssquery-prototype.html) 01:19:11 INFO - PROCESS | 4846 | RSS: Main: 233885696 01:19:11 INFO - PROCESS | 4846 | 01:22:14 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47939/tests/dromaeo/cssquery-yui.html) 01:22:15 INFO - PROCESS | 4846 | RSS: Main: 219262976 01:22:15 INFO - PROCESS | 4846 | 01:25:17 INFO - PROCESS | 4846 | Cycle 1(1): loaded http://localhost:47939/tests/dromaeo/cssquery-yui.html (next: http://localhost:47939/tests/dromaeo/cssquery-dojo.html) 01:25:18 INFO - PROCESS | 4846 | RSS: Main: 274550784 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - PROCESS | 4846 | __start_tp_report 01:25:18 INFO - PROCESS | 4846 | _x_x_mozilla_page_load 01:25:18 INFO - PROCESS | 4846 | _x_x_mozilla_page_load_details 01:25:18 INFO - PROCESS | 4846 | |i|pagename|runs| 01:25:18 INFO - PROCESS | 4846 | |0;dojo.html;3110.1447102046936;3117.8441077946113;3128.0772172209195;3158.9210269743267;3173.984130079349;5020.899582008357;5089.236614507826;5197.350331208599;5285.18079697647;5292.867678308045;5157.7163256020995;5160.664556803805;5194.428612852583;5237.685738855671;5260.868478288045;4641.767911604423;4674.813007479696;4800.951990480103;4857.951420485803;4892.510748925115;4820.566149046585;4843.418789745236;4855.927161092586;4872.65891387603;4931.80272789088;4587.105514424688;4637.0725854829;4721.433427988629;4765.999140180566;4785.306130611042;4767.809287628491;4786.329913812069;4794.808207671689;4833.613310935152;4859.708417494926;4744.7627618618935;4746.4541577718655;4747.359106520645;4789.616830653539;4842.225243960985;4974.577160941324;5037.5718063964605;5081;5102.770375333119;5212.947870521322;5501.449855014506;5553.583481238883;5582.162675598693;5585.972070139624;5645.689487078209;5619.185218143387;5671.347795003545;5672.347680016768;5687.630304030225;5691.373948865621;5068.214426763858;5153.2270159476;5207.713575753332;5209.270702101709;5240.318758561439;5691.772329106872;5746.511546518509;5753.252077229933;5753.827385178368;5766.596338256366;5370;5552.7223638817895;5553.722313884289;5554.389017208104;5554.833354999357;5481.917771233435;5551.611387202938;5558.138488534284;5572.972135139298;5586;5548.140038294071;5548.9722551386985;5551.250581171571;5553.444655534414;5555.611107222537;5373.543248823894;5454.427285135003;5571.637843540238;5572.749226284745;5621.662700237999;4242.490901091889;4253.3194688849635;4260.211860805761;4299.957000429956;4300.4194433751045;3778.0932576181517;3784;3799.5630502492013;3830.616938306203;3848.5574158971517;5079.949200508022;5132.409772876093;5200.479952004769;5229.372475302912;5254.13306804373;5539.778408863681;5555.583331250173;5561.720804215053;5595.048841696921;5609.382967873531;5259.868503287372;5269.077911365495;5272.472752724697;5273.077211488051;5310.92033619496;4540.273556230987;4694.155052090657;4808.639352048541;4810.39870016248;4816.253480710496;5837.9124313135335;5839.357670656224;5841.386654401226;5841.7371218295275;5886.175935369051;5646.463585959327;5656.264685590847;5657.858553536194;5660.066089095418;5662.8301150965535;5597.27235459404;5662.150677398423;5701.971490142523;5709.9714501427225;5828.6502809831545;5481.616286859881;5483.369412517612;5485.177223416519;5488.56091512686;5489.64317319373;5512.2558454608115;5546.473085056913;5557.360903495988;5558.749856256397;5612.663240205601;5201.115810312332;5313.787448502017;5350.678959262456;5405.837824865261;5446.537044351275;5428.647137936022;5436.537894278872;5439.700816455133;5446.291982042309;5452.59105567092;5213.113770658922;5321.918319603824;5345.893082138413;5360;5422.5119739223655;5447;5449.482299181572;5469.781208751605;5560.221568980427;5593.4126916674795;5413.431589683027;5415.48552887475;5422.972885135549;5447.455254474521;5470.945290547043 01:25:18 INFO - PROCESS | 4846 | |1;ext.html;596.5972968246435;611.7858749437695;627.1690010735775;628.3339659960442;634.5399585300657;31033.379332413366;41547.16905661885;42147;42189.367159492635;42195.36706949391;44895.55104448955;45507;45526.089478210415;45554.0889182217;45620.771896140555;7843;8603.010653774818;8796.560171991407;8796.736097917073;10103.191744660446;9996.300258981873;10160.085592296691;10164.847527287096;10165.898341016606;10171.6948491545;10319.793604127914;10377.533011014484;10381.896181038168;10383.896161038407;10389;7896.170902055288;8105.594720263964;8108.594570271522;10137.341072830242;10225.079742823144;9918.256130790147;10366.222533310032;10382.428966406844;10386.428746418944;10396.688099357032;41906.79046604778;42476.36285455721;42548.57451425477;42558;42579;3475.4960530722906;3527.8588856445713;3543.9114022149392;3662.34077865984;3761.22894806564;31347;31688;32049.83975080133;32150;32176.678233217837;4221.303484924983;4367.694261401703;4415.337699345092;4477.686561940665;4478.955210447919;242088;243299;244803;245147;245298;55210.447895521334;55281.44718552763;55526.16710749342;55926.440735592936;55948.16077758837;59415.40584594185;59419.702901485216;59562.702186488794;59671;59806.40193598095;16902.74645880313;17108.401205957733;17145.48563543071;17151.485455436356;17153.656926861393;13597.932010340082;13655.863441365658;13657.863421365857;13669.179849209078;13674.521391751241;14886.776698349533;15854.762178567331;15854.9207253963;15916.522504324888;15931.681366372608;5262.421133675292;6163.445289923929;6347.39699728525;6433.163688720437;6503.154589903377;1013.9847902281472;1017.2014968250036;1069.652362982034;1094.1793654758771;1143.331151276496;31555.21111972219;31888.521672174935;31997.680023199937;32465.188370290933;32579.51130733041;1077.6120596585224;1086.190787863047;1097.8353247013013;1126.4649291586431;1149.36210403227;16106.919465402832;16376;16519.00885946847;16683.83316166847;16844.74732879008;532446;539838;541659;543626;544077;55853.44146558564;56951.715241423524;56978.43021569814;56985.14522282169;57064.71467642718;1343.187371640163;1365.8292713410824;1383.2115694054291;1384.0588399888172;1385.1481338976457;29271.85364073166;30548.694513054586;30727.385452290382;31078.68921310758;31441.371172575964;48906.266406003226;49291.01417971692;49307;49336.75331623319;49354.75322623364;426119;435022;435613;435999;436689;32747.672523275414;33390;33986.32027359489;39188.216235675696;39732.2053558933;40383.3942490857;46594.76702616465;46936.53063469322;47676.284855726495;48173.75913120412;37799.24401512009;38725.419118713806;39132.80433597814;39276;39894.40158397685;37295;37568.51763584336;37960.24079518339;38118;38394.42408363821;39424.40863387109;39957.40063898986;40263.79868100641;40621.593784061784;40799.1840163201;35143.297134057684;35257.29485410226;35534.64465355417;35767;35932.820335898155;27158.864205678845;27225.956476393945;27405.889116632665;27597.172084836682;27655.861720691268 01:25:18 INFO - PROCESS | 4846 | |2;jquery.html;375.87408218246884;380.53384603860275;391.31324525457825;399.77612536979274;408.1734487662483;16860.494185174433;18825.62348753024;19032.61934761304;19044.428667140008;19074.904625476887;17468.21393037313;18335.358262460817;18434.539136521595;18893;18913.338033168842;4950.6782059166035;5040.722760248185;5106.872328191806;5125.948740512585;5128.769205385766;5610.13042978339;5623.26897503324;5648.802291919784;5655.802046928358;5658.321001479828;5117.820876269331;5606.018946684334;5610.074337734269;5615.326160860703;5617.691026993513;5357.598180136505;5429;5434.7826086956675;5443.455654434564;5460.372057213432;5079.339685840854;5470.2888624478965;5473.397926228112;5475.589330800166;5484.177373393983;12551.874481255161;12827.973762099009;12837.486500539968;19803.801961980338;21146.471338216514;2066.545360020793;2099.4121645939163;2165.8159056480217;2210.767869373725;2379.250536081146;9133.954330228373;9137.680181193693;9337.159655630958;9461.574229159703;9656.37233579815;1815.9273629054821;1866.346778627483;1871.6243560982666;1907.637548865711;1921.7213504041974;43970.560294396964;56609.43390566083;76199;80899.19100808975;80921.59539202326;10236;10515.211359148094;10624.256302058937;10786.191035672357;11086.445677716081;12821.551245706356;13946.58160255194;14793.852061479247;14990.47533336328;15010.924945375204;8126.390520710852;8199.877001844978;8349.415540912078;8403.411761176782;8543.743687689379;8190.303824175012;8236.341092712568;8298.792530186794;8388.622511986854;8426.452280601741;4652.209124448852;4668.5798278155125;4669.906601868011;4796.37647105874;4822.180229361017;1794.4078454110113;1840.981590184081;1893.337331933812;1910.8471322294183;1948.4641723526145;950.619752099152;954.6038394066524;994.7413672445216;1016.6797458800454;1066.802641511323;17466.476005719847;17953.102344882966;18448.35430759917;18841.717374239397;18926.526836828914;969.1810420194925;971.4317124482116;986.413084214891;1042.457921880633;1049.8530205771199;9876.506174691236;10550;10564.260501764802;10608.075915190955;10673.35959842412;529988;530411;535546;550636;551970;58518.4148158513;68633;91371;91558;92291;988.9554970026367;1002.809466201434;1017.1760873692333;1033.4574348467115;1039.3555995282973;16410.17949102564;16422.917885410498;16530.504084877473;16584.336626534805;16595.83404165943;28239;36398.8180059098;36436.27127457489;39425.80287098546;41710.791446042575;51570;53392;53941.460585395216;53942.46057539374;54890.17664734952;7309.195988441374;7685.577293248925;8348.373871959506;8451.492910425393;8600.78498037554;13155.60533184006;13457.663558410726;13460.326983650582;13603.455861765815;13608.455661773418;10904.50929708181;11754.882451175721;11800.468978895799;11820.40897955116;12011.159218854596;11224.775504490028;11485.770284594095;11734.882651173379;11932.1050921183;11974.760504789681;10043.443266293736;10667.786644266916;12005.939970300093;12249;12285.93857030745;7293.708251669874;7548.773536793905;7857.410694197843;8428.157184281768;8758.080401557745;9858.748345096044;11446.084313255085;11870.881291187323;11919;11924.403779811148 01:25:18 INFO - PROCESS | 4846 | |3;mootools.html;1332.267253010845;1482.8591283828032;1513.5156749840048;1664.850163485286;1798.694221982263;8118.391120665951;8536.274416674582;8542.402031857764;8752.212300892917;8779.2098711116;8522.275606573448;8710.738677839676;8716.520591367473;8726.432781869175;8731.86902196466;1934.2746470073723;2106.6839974003947;2169.273293446697;2276.146445083094;2300.3788976976207;2320.512692334612;2325.139698311627;2328.767123287666;2329.301209637111;2330.0330362899376;2155.5365596396773;2201.0535469748;2204.7464541577765;2205.2943058221376;2206.1837120265523;1937.3122541497776;2213.944651383712;2265.2184996176456;2270.818334533233;2287.3709729824263;2220.822334213275;2232.118313266251;2238.809701175402;2239.1715065425733;2256.4133325335365;8538.146185381474;8587.570621468902;8607.741767746978;8608.655653773842;8631.6978905738;5179.14544100223;5269.1832765921345;5304.840854774363;5314.176302673091;5321.2284218788445;3261.8858339958224;3358.882439114619;3447.5345828313357;3454.65453454655;3462.8961131166106;1056.4295280548495;1072.0726571515584;1088.7278180454887;1116.3636727065575;1135.9261647992937;12080;12133.757324853454;12154.939225303906;12226.572069977597;12285.877141228562;4500.617447516997;4594.494605593382;4656.278276867091;4678.134545109166;4727.456342520585;10152.187824973984;10156.898431015743;10180.083792458714;10270.691879243635;10278.640247591447;4470.552944705569;5294.7617357219015;5295.841124766263;5300.257963885059;5301.734913254322;4726.905461890743;4843.346148269939;4846.127697014571;4851.684640498356;4881.243407271879;3808.847646094125;3904.39481880309;3967.920641587152;3985.960140398617;3995.06116062725;1233.802591585342;1241.3048692731918;1254.4480428611382;1255.8995280377549;1258.5783762439503;798.9840203195904;911.4030310146865;912.7581190984395;915.6200176926501;936.0545848692733;5596.384397716248;5632.408597097327;5685.090385538294;5712.6001179917;5733;890.6214858685033;906.3881879731155;916.4959272400154;967.3277072434731;1000.4297550396204;3920.725549211528;4049.655779258796;4054.2702313583836;4060.817263223162;4113.300738874398;10277.794444111225;10791.56833726642;10861.402622855661;10862.61980830683;10877.891221087688;10526.31578947366;10726.463676816284;10793.460326983619;10807.83788243177;10885.129189664807;8010;8046.155153708776;8095.3523718102415;8149.633266502903;8169.387295952827;5560.555155587463;5587.161925711176;5655.095184770417;5676.9432305678065;5723.570732195185;9787.559559819683;9829.950850245703;9920.206383489447;9928.751781205528;9948.154406875206;9808.9019109808;9905.851412228678;10130.94934525352;10214.387136771817;10215.336003160068;6270.561060725706;6992.510524263253;7197.71209151628;7224.74713385029;7356.705731770883;8422.705205317785;8429.4942303462;8461.153884611489;8514.148585141436;8515.8722619162;7479.70081196746;7674.079110506552;7686.3082322591235;7773.844523109619;7820.452568320163;7416.110066792019;7591.696332146652;7634;7770.339521140766;7774.30031297186;7013.754518591825;7047.330503602149;7053.894191587027;7079.752208672672;7091.397231235196;4784.784684689128;4989.600831933364;5087.262346959744;5092.439831618445;5116.74416279192;5086.61850361217;5109.770060347368;5189.532942035235;5228;5291.656042357235 01:25:18 INFO - PROCESS | 4846 | |4;prototype.html;315.21983091847665;324.5650827890626;326.77942388887493;328.84708610496114;333.60134639106263;5284.31303930489;5314;5354.2771725817;5373.596980226479;5376.8118115865955;5255.527002569768;5270.604704647158;5271.367435907687;5280.947190528093;5353.812616558412;3987.5813039630857;4019.216252830699;4152.691902050859;4194.496660400756;4221.134667393177;4169.124483858393;4172;4191.727537710054;4202.201581699467;4212.347086201644;3924.82338294776;4140.689448291375;4143.730657507267;4150.294449943517;4153.356229784388;4027.5972402759635;4039.5354534228645;4050.2709512287774;4143.798298493433;4163.604457576525;3640.5449318835144;3667.963320366789;3676.981615091934;3680.1167719747336;3681.7238707097076;5113.360829896263;5119.206522988906;5126.871828204287;5128.153854613985;5142.897142057175;4536.319552067183;4713.222318317507;4721;4763.214069678499;4765.737884416356;5467.617266791326;5514.172874068921;5523;5529.22590837279;5555.194496797942;4022.9684009574976;4030.2141082488924;4032.2741906456827;4039.838406463738;4041.2523683118716;5559.777608895639;5669.489745922887;5755.712214389264;5765.971170144165;5773;4081.6326530611796;4083.8979025524004;4085.4688890444645;4100.302948498763;4123.752574845519;4133.958660413417;4143.875683729493;4150.8547200847825;4151.584841515884;4166.937495937564;4515.680974483752;4728.40894888139;4728.59806916416;4742.146413645577;4747.430308363018;5527.623122057554;5530.6128571000445;5560.165975103686;5575.8884822304135;5592.468715472024;1430.9713805724036;1442.149132012118;1443.7545617245094;1445.1762495377743;1449.7680371140777;889.6485888074175;895.5343221524771;933.85992101184;937.7468083617385;957.8658987741721;5298.735063246822;5360.16917377807;5364.758585863646;5385.569154467633;5398.811041613603;5727.713614319267;5739.737257803276;5739.741711622987;5743.282089738783;5752.194692743019;5268.841934741964;5306.946930530722;5385.057614917374;5417.241586177938;5425.945740542623;3047.756179505634;3048.3598444326494;3055.724984751383;3062.8774849006236;3065.2183693158104;5887.61730487517;5905.202797622352;5912.881742365129;5945.702714864239;5957.4042595740075;5571.66570005801;5842.4653084883885;5854.560907931922;5857.619254748428;5865;5873.647581145145;5894.852628684232;5908.793192238251;5915.456353767835;5929.436703513332;5560.332760068818;5577.903725082609;5731.254936858182;5766.538676905921;5779.219805326227;5666.943330566806;5672.461116193955;5721.427857214246;5727.914081288701;5734.483896449339;5895.20414744004;5915.497182739516;5939.4357536034;5943.632964418121;5964.343922168645;3885.9222815542967;3986.342253528135;4019.336809426412;4021.3163762159916;4023.9396409054475;5709.429057094258;5740.942590574041;5748.885022299447;5787.710614469344;5815.854603634943;5398.811041613525;5665.858353541194;5666.46168613981;5672.376038635664;5678.432156784289;5564;5588.636738611977;5662.85842853932;5664.235328230636;5665.376808550974;5276.973615131899;5434.1795498508445;5465.781368745205;5499.340079190362;5506.393312380397;5401.729913504388;5580.525655319343;5638.85902852432;5682.545396368363;5685.715714214355;5485.588580856372;5500.22996780459;5539.418361072029;5547.805826796042;5556.333240011225 01:25:18 INFO - PROCESS | 4846 | |5;yui.html;718.4611541343993;765.8353454007387;786.4023342259884;800.7317548621212;810.5217921426357;15440;15648.139352335631;15869.444569440058;16391.34434622614;16830.24263908124;15133.924330378333;15251.237438128104;15261.923690381533;15310.46413375532;15316.23418829057;674.5042393840523;796.0964305513255;796.5419883566958;814.8777683347515;815.0463957170095;810.0603300171801;819.8442295963778;820.2207902492626;821.2485575698229;822.979425514361;847.6439895243982;853.0701535326493;854.1714536899198;854.2824027816632;854.3250831842837;710.9360157585817;831.2767891933995;849.354490587152;850.459957926718;850.4939560961218;619.1734035063196;619.4796371048341;620.1225266248254;620.8944479438507;620.9037599172091;13878.791818122736;13901.165930044128;13905.4437822488;13906.652333691738;13908.235047072407;13793.172409655454;14060.578182654537;14174.07868488545;14202.360893759806;14313;12517.499300027988;12660.620181394574;12676.80984785229;12782.936085319607;12822.230666159967;4433.578810013076;4455.844045458393;4547.15877562652;4559.498455169929;4699.389079419688;70031.64984175097;70630.29369706288;71152.644236779;75076.62461687712;75370.99999999945;10581.788364232672;10623.36259824413;10642.467876606139;10691.518881650345;10777.89222107769;21340.146394144373;21423.57152856934;21445.249416270355;21516.354509364744;21871;7999;8050.396220283502;8148.307393871469;8532.658693652309;8789.296856251485;4473.923657897502;4729.077829823152;4790.257510085942;4861.440934292531;4988.326575912205;3442.8794992175153;3564.7148228141687;3564.8395822188063;3574.696150827209;3577.2308953575107;559.7565059199261;577.1861675038176;592.623683960688;595.9642421454727;618.9102580125857;585.4847733994058;702.9156501219886;705.0728292295615;705.6295444891473;720.050640924191;9748.31761776683;9807;9945;9968.700938971842;9977.950110249401;667.8797816392998;671.3085521912438;684.226823689228;713.5896859305919;728.9562626242337;4761.642876784185;4929.7781599828095;4973.47778483254;5004.84985450437;5069.340985671913;76520.23479765131;93506.06493934973;116322.41838790922;118905;122109.38945305394;65889.67055164694;89791.55104224567;94931.52534237284;105196.47401762943;105480.47259763652;90363.54818225867;93065;93248.53375733213;94717.0528294722;97580;9430.113024356864;9636.75908102275;9650.806983860424;9677.467739274407;9807.509624518603;52651.47348526466;53387;54148.45851541434;54430;54831.725841370535;68445;77602.61198693971;77934;78127.21872781427;78701;12634.178778379375;12958.935205323913;12972.156809807333;13214.471421143431;13712.588622341345;14902.552923412315;14961.925190373979;14971.625709357353;15135.394584216509;15328.310226039632;13393.531226407029;13844.446222151404;13920.443182273;13987.650308742363;14598.70802583921;13880.861191388361;13907.675233239706;14151;14248.928755356157;14292.571222863331;13785.51750688721;13819.79270310926;14101.717965640835;14115.788263176266;14192.219427931563;11663.358515281741;11667.533298667959;11812.990898890414;11866.914602203316;12019.278843269432;11561.768764624829;11598.18812683104;11793.587224447103;11836.349000805038;11991 01:25:18 INFO - PROCESS | 4846 | __end_tp_report 01:25:18 INFO - PROCESS | 4846 | __start_cc_report 01:25:18 INFO - PROCESS | 4846 | _x_x_mozilla_cycle_collect,854 01:25:18 INFO - PROCESS | 4846 | __end_cc_report 01:25:18 INFO - PROCESS | 4846 | __startTimestamp1465287918224__endTimestamp 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - PROCESS | 4846 | ------- Summary: start ------- 01:25:18 INFO - PROCESS | 4846 | Number of tests: 6 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - PROCESS | 4846 | [#0] dojo.html Cycles:165 Average:5180.71 Median:5370.00 stddev:574.73 (10.7%) stddev-sans-first:553.07 01:25:18 INFO - PROCESS | 4846 | Values: 3110.1 3117.8 3128.1 3158.9 3174.0 5020.9 5089.2 5197.4 5285.2 5292.9 5157.7 5160.7 5194.4 5237.7 5260.9 4641.8 4674.8 4801.0 4858.0 4892.5 4820.6 4843.4 4855.9 4872.7 4931.8 4587.1 4637.1 4721.4 4766.0 4785.3 4767.8 4786.3 4794.8 4833.6 4859.7 4744.8 4746.5 4747.4 4789.6 4842.2 4974.6 5037.6 5081.0 5102.8 5212.9 5501.4 5553.6 5582.2 5586.0 5645.7 5619.2 5671.3 5672.3 5687.6 5691.4 5068.2 5153.2 5207.7 5209.3 5240.3 5691.8 5746.5 5753.3 5753.8 5766.6 5370.0 5552.7 5553.7 5554.4 5554.8 5481.9 5551.6 5558.1 5573.0 5586.0 5548.1 5549.0 5551.3 5553.4 5555.6 5373.5 5454.4 5571.6 5572.7 5621.7 4242.5 4253.3 4260.2 4300.0 4300.4 3778.1 3784.0 3799.6 3830.6 3848.6 5079.9 5132.4 5200.5 5229.4 5254.1 5539.8 5555.6 5561.7 5595.0 5609.4 5259.9 5269.1 5272.5 5273.1 5310.9 4540.3 4694.2 4808.6 4810.4 4816.3 5837.9 5839.4 5841.4 5841.7 5886.2 5646.5 5656.3 5657.9 5660.1 5662.8 5597.3 5662.2 5702.0 5710.0 5828.7 5481.6 5483.4 5485.2 5488.6 5489.6 5512.3 5546.5 5557.4 5558.7 5612.7 5201.1 5313.8 5350.7 5405.8 5446.5 5428.6 5436.5 5439.7 5446.3 5452.6 5213.1 5321.9 5345.9 5360.0 5422.5 5447.0 5449.5 5469.8 5560.2 5593.4 5413.4 5415.5 5423.0 5447.5 5470.9 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - PROCESS | 4846 | [#1] ext.html Cycles:180 Average:57034.63 Median:20664.87 stddev:112738.96 (545.6%) stddev-sans-first:112975.58 01:25:18 INFO - PROCESS | 4846 | Values: 596.6 611.8 627.2 628.3 634.5 31033.4 41547.2 42147.0 42189.4 42195.4 44895.6 45507.0 45526.1 45554.1 45620.8 7843.0 8603.0 8796.6 8796.7 10103.2 9996.3 10160.1 10164.8 10165.9 10171.7 10319.8 10377.5 10381.9 10383.9 10389.0 7896.2 8105.6 8108.6 10137.3 10225.1 9918.3 10366.2 10382.4 10386.4 10396.7 41906.8 42476.4 42548.6 42558.0 42579.0 3475.5 3527.9 3543.9 3662.3 3761.2 31347.0 31688.0 32049.8 32150.0 32176.7 4221.3 4367.7 4415.3 4477.7 4479.0 242088.0 243299.0 244803.0 245147.0 245298.0 55210.4 55281.4 55526.2 55926.4 55948.2 59415.4 59419.7 59562.7 59671.0 59806.4 16902.7 17108.4 17145.5 17151.5 17153.7 13597.9 13655.9 13657.9 13669.2 13674.5 14886.8 15854.8 15854.9 15916.5 15931.7 5262.4 6163.4 6347.4 6433.2 6503.2 1014.0 1017.2 1069.7 1094.2 1143.3 31555.2 31888.5 31997.7 32465.2 32579.5 1077.6 1086.2 1097.8 1126.5 1149.4 16106.9 16376.0 16519.0 16683.8 16844.7 532446.0 539838.0 541659.0 543626.0 544077.0 55853.4 56951.7 56978.4 56985.1 57064.7 1343.2 1365.8 1383.2 1384.1 1385.1 29271.9 30548.7 30727.4 31078.7 31441.4 48906.3 49291.0 49307.0 49336.8 49354.8 426119.0 435022.0 435613.0 435999.0 436689.0 32747.7 33390.0 33986.3 39188.2 39732.2 40383.4 46594.8 46936.5 47676.3 48173.8 37799.2 38725.4 39132.8 39276.0 39894.4 37295.0 37568.5 37960.2 38118.0 38394.4 39424.4 39957.4 40263.8 40621.6 40799.2 35143.3 35257.3 35534.6 35767.0 35932.8 27158.9 27226.0 27405.9 27597.2 27655.9 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - PROCESS | 4846 | [#2] jquery.html Cycles:180 Average:28992.90 Median:385.92 stddev:88447.72 (22918.5%) stddev-sans-first:88669.73 01:25:18 INFO - PROCESS | 4846 | Values: 375.9 380.5 391.3 399.8 408.2 16860.5 18825.6 19032.6 19044.4 19074.9 17468.2 18335.4 18434.5 18893.0 18913.3 4950.7 5040.7 5106.9 5125.9 5128.8 5610.1 5623.3 5648.8 5655.8 5658.3 5117.8 5606.0 5610.1 5615.3 5617.7 5357.6 5429.0 5434.8 5443.5 5460.4 5079.3 5470.3 5473.4 5475.6 5484.2 12551.9 12828.0 12837.5 19803.8 21146.5 2066.5 2099.4 2165.8 2210.8 2379.3 9134.0 9137.7 9337.2 9461.6 9656.4 1815.9 1866.3 1871.6 1907.6 1921.7 43970.6 56609.4 76199.0 80899.2 80921.6 10236.0 10515.2 10624.3 10786.2 11086.4 12821.6 13946.6 14793.9 14990.5 15010.9 8126.4 8199.9 8349.4 8403.4 8543.7 8190.3 8236.3 8298.8 8388.6 8426.5 4652.2 4668.6 4669.9 4796.4 4822.2 1794.4 1841.0 1893.3 1910.8 1948.5 950.6 954.6 994.7 1016.7 1066.8 17466.5 17953.1 18448.4 18841.7 18926.5 969.2 971.4 986.4 1042.5 1049.9 9876.5 10550.0 10564.3 10608.1 10673.4 529988.0 530411.0 535546.0 550636.0 551970.0 58518.4 68633.0 91371.0 91558.0 92291.0 989.0 1002.8 1017.2 1033.5 1039.4 16410.2 16422.9 16530.5 16584.3 16595.8 28239.0 36398.8 36436.3 39425.8 41710.8 51570.0 53392.0 53941.5 53942.5 54890.2 7309.2 7685.6 8348.4 8451.5 8600.8 13155.6 13457.7 13460.3 13603.5 13608.5 10904.5 11754.9 11800.5 11820.4 12011.2 11224.8 11485.8 11734.9 11932.1 11974.8 10043.4 10667.8 12005.9 12249.0 12285.9 7293.7 7548.8 7857.4 8428.2 8758.1 9858.7 11446.1 11870.9 11919.0 11924.4 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - PROCESS | 4846 | [#3] mootools.html Cycles:180 Average:5699.19 Median:4935.42 stddev:3253.44 (65.9%) stddev-sans-first:3246.01 01:25:18 INFO - PROCESS | 4846 | Values: 1332.3 1482.9 1513.5 1664.9 1798.7 8118.4 8536.3 8542.4 8752.2 8779.2 8522.3 8710.7 8716.5 8726.4 8731.9 1934.3 2106.7 2169.3 2276.1 2300.4 2320.5 2325.1 2328.8 2329.3 2330.0 2155.5 2201.1 2204.7 2205.3 2206.2 1937.3 2213.9 2265.2 2270.8 2287.4 2220.8 2232.1 2238.8 2239.2 2256.4 8538.1 8587.6 8607.7 8608.7 8631.7 5179.1 5269.2 5304.8 5314.2 5321.2 3261.9 3358.9 3447.5 3454.7 3462.9 1056.4 1072.1 1088.7 1116.4 1135.9 12080.0 12133.8 12154.9 12226.6 12285.9 4500.6 4594.5 4656.3 4678.1 4727.5 10152.2 10156.9 10180.1 10270.7 10278.6 4470.6 5294.8 5295.8 5300.3 5301.7 4726.9 4843.3 4846.1 4851.7 4881.2 3808.8 3904.4 3967.9 3986.0 3995.1 1233.8 1241.3 1254.4 1255.9 1258.6 799.0 911.4 912.8 915.6 936.1 5596.4 5632.4 5685.1 5712.6 5733.0 890.6 906.4 916.5 967.3 1000.4 3920.7 4049.7 4054.3 4060.8 4113.3 10277.8 10791.6 10861.4 10862.6 10877.9 10526.3 10726.5 10793.5 10807.8 10885.1 8010.0 8046.2 8095.4 8149.6 8169.4 5560.6 5587.2 5655.1 5676.9 5723.6 9787.6 9830.0 9920.2 9928.8 9948.2 9808.9 9905.9 10130.9 10214.4 10215.3 6270.6 6992.5 7197.7 7224.7 7356.7 8422.7 8429.5 8461.2 8514.1 8515.9 7479.7 7674.1 7686.3 7773.8 7820.5 7416.1 7591.7 7634.0 7770.3 7774.3 7013.8 7047.3 7053.9 7079.8 7091.4 4784.8 4989.6 5087.3 5092.4 5116.7 5086.6 5109.8 5189.5 5228.0 5291.7 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - PROCESS | 4846 | [#4] prototype.html Cycles:180 Average:4696.45 Median:5380.93 stddev:1384.84 (25.7%) stddev-sans-first:1349.12 01:25:18 INFO - PROCESS | 4846 | Values: 315.2 324.6 326.8 328.8 333.6 5284.3 5314.0 5354.3 5373.6 5376.8 5255.5 5270.6 5271.4 5280.9 5353.8 3987.6 4019.2 4152.7 4194.5 4221.1 4169.1 4172.0 4191.7 4202.2 4212.3 3924.8 4140.7 4143.7 4150.3 4153.4 4027.6 4039.5 4050.3 4143.8 4163.6 3640.5 3668.0 3677.0 3680.1 3681.7 5113.4 5119.2 5126.9 5128.2 5142.9 4536.3 4713.2 4721.0 4763.2 4765.7 5467.6 5514.2 5523.0 5529.2 5555.2 4023.0 4030.2 4032.3 4039.8 4041.3 5559.8 5669.5 5755.7 5766.0 5773.0 4081.6 4083.9 4085.5 4100.3 4123.8 4134.0 4143.9 4150.9 4151.6 4166.9 4515.7 4728.4 4728.6 4742.1 4747.4 5527.6 5530.6 5560.2 5575.9 5592.5 1431.0 1442.1 1443.8 1445.2 1449.8 889.6 895.5 933.9 937.7 957.9 5298.7 5360.2 5364.8 5385.6 5398.8 5727.7 5739.7 5739.7 5743.3 5752.2 5268.8 5306.9 5385.1 5417.2 5425.9 3047.8 3048.4 3055.7 3062.9 3065.2 5887.6 5905.2 5912.9 5945.7 5957.4 5571.7 5842.5 5854.6 5857.6 5865.0 5873.6 5894.9 5908.8 5915.5 5929.4 5560.3 5577.9 5731.3 5766.5 5779.2 5666.9 5672.5 5721.4 5727.9 5734.5 5895.2 5915.5 5939.4 5943.6 5964.3 3885.9 3986.3 4019.3 4021.3 4023.9 5709.4 5740.9 5748.9 5787.7 5815.9 5398.8 5665.9 5666.5 5672.4 5678.4 5564.0 5588.6 5662.9 5664.2 5665.4 5277.0 5434.2 5465.8 5499.3 5506.4 5401.7 5580.5 5638.9 5682.5 5685.7 5485.6 5500.2 5539.4 5547.8 5556.3 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - PROCESS | 4846 | [#5] yui.html Cycles:180 Average:20673.29 Median:4951.63 stddev:29322.36 (592.2%) stddev-sans-first:29366.33 01:25:18 INFO - PROCESS | 4846 | Values: 718.5 765.8 786.4 800.7 810.5 15440.0 15648.1 15869.4 16391.3 16830.2 15133.9 15251.2 15261.9 15310.5 15316.2 674.5 796.1 796.5 814.9 815.0 810.1 819.8 820.2 821.2 823.0 847.6 853.1 854.2 854.3 854.3 710.9 831.3 849.4 850.5 850.5 619.2 619.5 620.1 620.9 620.9 13878.8 13901.2 13905.4 13906.7 13908.2 13793.2 14060.6 14174.1 14202.4 14313.0 12517.5 12660.6 12676.8 12782.9 12822.2 4433.6 4455.8 4547.2 4559.5 4699.4 70031.6 70630.3 71152.6 75076.6 75371.0 10581.8 10623.4 10642.5 10691.5 10777.9 21340.1 21423.6 21445.2 21516.4 21871.0 7999.0 8050.4 8148.3 8532.7 8789.3 4473.9 4729.1 4790.3 4861.4 4988.3 3442.9 3564.7 3564.8 3574.7 3577.2 559.8 577.2 592.6 596.0 618.9 585.5 702.9 705.1 705.6 720.1 9748.3 9807.0 9945.0 9968.7 9978.0 667.9 671.3 684.2 713.6 729.0 4761.6 4929.8 4973.5 5004.8 5069.3 76520.2 93506.1 116322.4 118905.0 122109.4 65889.7 89791.6 94931.5 105196.5 105480.5 90363.5 93065.0 93248.5 94717.1 97580.0 9430.1 9636.8 9650.8 9677.5 9807.5 52651.5 53387.0 54148.5 54430.0 54831.7 68445.0 77602.6 77934.0 78127.2 78701.0 12634.2 12958.9 12972.2 13214.5 13712.6 14902.6 14961.9 14971.6 15135.4 15328.3 13393.5 13844.4 13920.4 13987.7 14598.7 13880.9 13907.7 14151.0 14248.9 14292.6 13785.5 13819.8 14101.7 14115.8 14192.2 11663.4 11667.5 11813.0 11866.9 12019.3 11561.8 11598.2 11793.6 11836.3 11991.0 01:25:18 INFO - PROCESS | 4846 | -------- Summary: end -------- 01:25:18 INFO - PROCESS | 4846 | 01:25:18 INFO - TEST-INFO | 4846: exit 0 01:25:18 INFO - TEST-OK | dromaeo_css | took 1113828ms 01:25:18 INFO - TEST-START | kraken 01:25:18 INFO - operating with platform_type : linux_ 01:25:18 INFO - Initialising browser for kraken test... 01:25:19 INFO - TEST-INFO | started process 5029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8XjlqG/profile http://localhost:47939/getInfo.html) 01:25:23 INFO - PROCESS | 5029 | __metrics Screen width/height:1600/1200 01:25:23 INFO - PROCESS | 5029 | colorDepth:24 01:25:23 INFO - PROCESS | 5029 | Browser inner width/height: 1024/697 01:25:23 INFO - PROCESS | 5029 | __metrics 01:25:24 ERROR - PROCESS | 5029 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:25:24 INFO - PROCESS | 5029 | console.error: PushService: 01:25:24 INFO - PROCESS | 5029 | stateChangeProcessEnqueue: Error transitioning state 01:25:24 INFO - PROCESS | 5029 | UnknownError 01:25:25 INFO - TEST-INFO | 5029: exit 0 01:25:25 INFO - Browser initialized. 01:25:25 INFO - Running cycle 1/1 for kraken test... 01:25:25 INFO - TEST-INFO | started process 5110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8XjlqG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:36 INFO - PROCESS | 5110 | RSS: Main: 159928320 01:25:36 INFO - PROCESS | 5110 | 01:25:39 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47939/tests/kraken/driver.html?testName=audio-beat-detection) 01:25:40 INFO - PROCESS | 5110 | RSS: Main: 217882624 01:25:40 INFO - PROCESS | 5110 | 01:25:43 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47939/tests/kraken/driver.html?testName=audio-dft) 01:25:43 INFO - PROCESS | 5110 | RSS: Main: 204460032 01:25:43 INFO - PROCESS | 5110 | 01:25:46 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47939/tests/kraken/driver.html?testName=audio-fft) 01:25:47 INFO - PROCESS | 5110 | RSS: Main: 271028224 01:25:47 INFO - PROCESS | 5110 | 01:25:49 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47939/tests/kraken/driver.html?testName=audio-oscillator) 01:25:49 INFO - PROCESS | 5110 | RSS: Main: 182964224 01:25:49 INFO - PROCESS | 5110 | 01:25:52 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:25:52 INFO - PROCESS | 5110 | RSS: Main: 186884096 01:25:52 INFO - PROCESS | 5110 | 01:25:55 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47939/tests/kraken/driver.html?testName=imaging-darkroom) 01:25:56 INFO - PROCESS | 5110 | RSS: Main: 222330880 01:25:56 INFO - PROCESS | 5110 | 01:25:59 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47939/tests/kraken/driver.html?testName=imaging-desaturate) 01:26:00 INFO - PROCESS | 5110 | RSS: Main: 223490048 01:26:00 INFO - PROCESS | 5110 | 01:26:03 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47939/tests/kraken/driver.html?testName=json-parse-financial) 01:26:03 INFO - PROCESS | 5110 | RSS: Main: 223485952 01:26:03 INFO - PROCESS | 5110 | 01:26:05 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:26:05 INFO - PROCESS | 5110 | RSS: Main: 209903616 01:26:05 INFO - PROCESS | 5110 | 01:26:07 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:26:08 INFO - PROCESS | 5110 | RSS: Main: 215109632 01:26:08 INFO - PROCESS | 5110 | 01:26:10 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:26:11 INFO - PROCESS | 5110 | RSS: Main: 218271744 01:26:11 INFO - PROCESS | 5110 | 01:26:13 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:26:14 INFO - PROCESS | 5110 | RSS: Main: 222674944 01:26:14 INFO - PROCESS | 5110 | 01:26:16 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:26:17 INFO - PROCESS | 5110 | RSS: Main: 223035392 01:26:17 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:47939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47939/tests/kraken/driver.html?testName=ai-astar) 01:26:19 INFO - PROCESS | 5110 | RSS: Main: 265568256 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | __start_tp_report 01:26:19 INFO - PROCESS | 5110 | _x_x_mozilla_page_load 01:26:19 INFO - PROCESS | 5110 | _x_x_mozilla_page_load_details 01:26:19 INFO - PROCESS | 5110 | |i|pagename|runs| 01:26:19 INFO - PROCESS | 5110 | |0;ai-astar;113;106;111;111;112;110;111;111;110;111 01:26:19 INFO - PROCESS | 5110 | |1;audio-beat-detection;151;135;137;181;128;152;153;129;187;127 01:26:19 INFO - PROCESS | 5110 | |2;audio-dft;162;162;163;168;161;161;163;161;161;161 01:26:19 INFO - PROCESS | 5110 | |3;audio-fft;74;75;76;119;75;77;74;75;98;73 01:26:19 INFO - PROCESS | 5110 | |4;audio-oscillator;85;86;118;86;86;87;118;87;86;127 01:26:19 INFO - PROCESS | 5110 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;117;117;119 01:26:19 INFO - PROCESS | 5110 | |6;imaging-darkroom;147;147;147;146;146;146;147;147;146;146 01:26:19 INFO - PROCESS | 5110 | |7;imaging-desaturate;95;95;95;96;96;95;96;96;96;95 01:26:19 INFO - PROCESS | 5110 | |8;json-parse-financial;56;56;55;57;56;57;58;56;57;57 01:26:19 INFO - PROCESS | 5110 | |9;json-stringify-tinderbox;60;62;61;61;62;61;61;61;62;61 01:26:19 INFO - PROCESS | 5110 | |10;stanford-crypto-aes;79;80;86;86;83;80;85;79;114;80 01:26:19 INFO - PROCESS | 5110 | |11;stanford-crypto-ccm;127;123;121;122;121;128;127;132;156;122 01:26:19 INFO - PROCESS | 5110 | |12;stanford-crypto-pbkdf2;166;165;160;172;168;163;161;166;163;161 01:26:19 INFO - PROCESS | 5110 | |13;stanford-crypto-sha256-iterative;65;64;64;66;65;65;63;67;62;66 01:26:19 INFO - PROCESS | 5110 | __end_tp_report 01:26:19 INFO - PROCESS | 5110 | __start_cc_report 01:26:19 INFO - PROCESS | 5110 | _x_x_mozilla_cycle_collect,1582 01:26:19 INFO - PROCESS | 5110 | __end_cc_report 01:26:19 INFO - PROCESS | 5110 | __startTimestamp1465287979463__endTimestamp 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | ------- Summary: start ------- 01:26:19 INFO - PROCESS | 5110 | Number of tests: 14 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.84 (1.7%) stddev-sans-first:1.73 01:26:19 INFO - PROCESS | 5110 | Values: 113.0 106.0 111.0 111.0 112.0 110.0 111.0 111.0 110.0 111.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:151.50 stddev:21.48 (14.2%) stddev-sans-first:22.75 01:26:19 INFO - PROCESS | 5110 | Values: 151.0 135.0 137.0 181.0 128.0 152.0 153.0 129.0 187.0 127.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.16 (1.3%) stddev-sans-first:2.29 01:26:19 INFO - PROCESS | 5110 | Values: 162.0 162.0 163.0 168.0 161.0 161.0 163.0 161.0 161.0 161.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:15.06 (20.1%) stddev-sans-first:15.72 01:26:19 INFO - PROCESS | 5110 | Values: 74.0 75.0 76.0 119.0 75.0 77.0 74.0 75.0 98.0 73.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:86.00 stddev:17.02 (19.8%) stddev-sans-first:17.53 01:26:19 INFO - PROCESS | 5110 | Values: 85.0 86.0 118.0 86.0 86.0 87.0 118.0 87.0 86.0 127.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 01:26:19 INFO - PROCESS | 5110 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 119.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:26:19 INFO - PROCESS | 5110 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:26:19 INFO - PROCESS | 5110 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 01:26:19 INFO - PROCESS | 5110 | Values: 56.0 56.0 55.0 57.0 56.0 57.0 58.0 56.0 57.0 57.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 01:26:19 INFO - PROCESS | 5110 | Values: 60.0 62.0 61.0 61.0 62.0 61.0 61.0 61.0 62.0 61.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:81.50 stddev:10.51 (12.9%) stddev-sans-first:10.90 01:26:19 INFO - PROCESS | 5110 | Values: 79.0 80.0 86.0 86.0 83.0 80.0 85.0 79.0 114.0 80.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:127.00 stddev:10.52 (8.3%) stddev-sans-first:11.16 01:26:19 INFO - PROCESS | 5110 | Values: 127.0 123.0 121.0 122.0 121.0 128.0 127.0 132.0 156.0 122.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.50 stddev:3.69 (2.2%) stddev-sans-first:3.87 01:26:19 INFO - PROCESS | 5110 | Values: 166.0 165.0 160.0 172.0 168.0 163.0 161.0 166.0 163.0 161.0 01:26:19 INFO - PROCESS | 5110 | 01:26:19 INFO - PROCESS | 5110 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.58 01:26:19 INFO - PROCESS | 5110 | Values: 65.0 64.0 64.0 66.0 65.0 65.0 63.0 67.0 62.0 66.0 01:26:19 INFO - PROCESS | 5110 | -------- Summary: end -------- 01:26:19 INFO - PROCESS | 5110 | 01:26:20 INFO - TEST-INFO | 5110: exit 0 01:26:20 INFO - TEST-OK | kraken | took 61451ms 01:26:20 INFO - SUITE-END | took 1175s 01:26:20 INFO - Completed test suite (00:19:35) 01:26:20 INFO - javascript benchmark 01:26:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.1447102046936, 3117.8441077946113, 3128.0772172209195, 3158.9210269743267, 3173.984130079349, 5020.899582008357, 5089.236614507826, 5197.350331208599, 5285.18079697647, 5292.867678308045, 5157.7163256020995, 5160.664556803805, 5194.428612852583, 5237.685738855671, 5260.868478288045, 4641.767911604423, 4674.813007479696, 4800.951990480103, 4857.951420485803, 4892.510748925115, 4820.566149046585, 4843.418789745236, 4855.927161092586, 4872.65891387603, 4931.80272789088, 4587.105514424688, 4637.0725854829, 4721.433427988629, 4765.999140180566, 4785.306130611042, 4767.809287628491, 4786.329913812069, 4794.808207671689, 4833.613310935152, 4859.708417494926, 4744.7627618618935, 4746.4541577718655, 4747.359106520645, 4789.616830653539, 4842.225243960985, 4974.577160941324, 5037.5718063964605, 5081.0, 5102.770375333119, 5212.947870521322, 5501.449855014506, 5553.583481238883, 5582.162675598693, 5585.972070139624, 5645.689487078209, 5619.185218143387, 5671.347795003545, 5672.347680016768, 5687.630304030225, 5691.373948865621, 5068.214426763858, 5153.2270159476, 5207.713575753332, 5209.270702101709, 5240.318758561439, 5691.772329106872, 5746.511546518509, 5753.252077229933, 5753.827385178368, 5766.596338256366, 5370.0, 5552.7223638817895, 5553.722313884289, 5554.389017208104, 5554.833354999357, 5481.917771233435, 5551.611387202938, 5558.138488534284, 5572.972135139298, 5586.0, 5548.140038294071, 5548.9722551386985, 5551.250581171571, 5553.444655534414, 5555.611107222537, 5373.543248823894, 5454.427285135003, 5571.637843540238, 5572.749226284745, 5621.662700237999, 4242.490901091889, 4253.3194688849635, 4260.211860805761, 4299.957000429956, 4300.4194433751045, 3778.0932576181517, 3784.0, 3799.5630502492013, 3830.616938306203, 3848.5574158971517, 5079.949200508022, 5132.409772876093, 5200.479952004769, 5229.372475302912, 5254.13306804373, 5539.778408863681, 5555.583331250173, 5561.720804215053, 5595.048841696921, 5609.382967873531, 5259.868503287372, 5269.077911365495, 5272.472752724697, 5273.077211488051, 5310.92033619496, 4540.273556230987, 4694.155052090657, 4808.639352048541, 4810.39870016248, 4816.253480710496, 5837.9124313135335, 5839.357670656224, 5841.386654401226, 5841.7371218295275, 5886.175935369051, 5646.463585959327, 5656.264685590847, 5657.858553536194, 5660.066089095418, 5662.8301150965535, 5597.27235459404, 5662.150677398423, 5701.971490142523, 5709.9714501427225, 5828.6502809831545, 5481.616286859881, 5483.369412517612, 5485.177223416519, 5488.56091512686, 5489.64317319373, 5512.2558454608115, 5546.473085056913, 5557.360903495988, 5558.749856256397, 5612.663240205601, 5201.115810312332, 5313.787448502017, 5350.678959262456, 5405.837824865261, 5446.537044351275, 5428.647137936022, 5436.537894278872, 5439.700816455133, 5446.291982042309, 5452.59105567092, 5213.113770658922, 5321.918319603824, 5345.893082138413, 5360.0, 5422.5119739223655, 5447.0, 5449.482299181572, 5469.781208751605, 5560.221568980427, 5593.4126916674795, 5413.431589683027, 5415.48552887475, 5422.972885135549, 5447.455254474521, 5470.945290547043], "value": 5143.604146453161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.5972968246435, 611.7858749437695, 627.1690010735775, 628.3339659960442, 634.5399585300657, 31033.379332413366, 41547.16905661885, 42147.0, 42189.367159492635, 42195.36706949391, 44895.55104448955, 45507.0, 45526.089478210415, 45554.0889182217, 45620.771896140555, 7843.0, 8603.010653774818, 8796.560171991407, 8796.736097917073, 10103.191744660446, 9996.300258981873, 10160.085592296691, 10164.847527287096, 10165.898341016606, 10171.6948491545, 10319.793604127914, 10377.533011014484, 10381.896181038168, 10383.896161038407, 10389.0, 7896.170902055288, 8105.594720263964, 8108.594570271522, 10137.341072830242, 10225.079742823144, 9918.256130790147, 10366.222533310032, 10382.428966406844, 10386.428746418944, 10396.688099357032, 41906.79046604778, 42476.36285455721, 42548.57451425477, 42558.0, 42579.0, 3475.4960530722906, 3527.8588856445713, 3543.9114022149392, 3662.34077865984, 3761.22894806564, 31347.0, 31688.0, 32049.83975080133, 32150.0, 32176.678233217837, 4221.303484924983, 4367.694261401703, 4415.337699345092, 4477.686561940665, 4478.955210447919, 242088.0, 243299.0, 244803.0, 245147.0, 245298.0, 55210.447895521334, 55281.44718552763, 55526.16710749342, 55926.440735592936, 55948.16077758837, 59415.40584594185, 59419.702901485216, 59562.702186488794, 59671.0, 59806.40193598095, 16902.74645880313, 17108.401205957733, 17145.48563543071, 17151.485455436356, 17153.656926861393, 13597.932010340082, 13655.863441365658, 13657.863421365857, 13669.179849209078, 13674.521391751241, 14886.776698349533, 15854.762178567331, 15854.9207253963, 15916.522504324888, 15931.681366372608, 5262.421133675292, 6163.445289923929, 6347.39699728525, 6433.163688720437, 6503.154589903377, 1013.9847902281472, 1017.2014968250036, 1069.652362982034, 1094.1793654758771, 1143.331151276496, 31555.21111972219, 31888.521672174935, 31997.680023199937, 32465.188370290933, 32579.51130733041, 1077.6120596585224, 1086.190787863047, 1097.8353247013013, 1126.4649291586431, 1149.36210403227, 16106.919465402832, 16376.0, 16519.00885946847, 16683.83316166847, 16844.74732879008, 532446.0, 539838.0, 541659.0, 543626.0, 544077.0, 55853.44146558564, 56951.715241423524, 56978.43021569814, 56985.14522282169, 57064.71467642718, 1343.187371640163, 1365.8292713410824, 1383.2115694054291, 1384.0588399888172, 1385.1481338976457, 29271.85364073166, 30548.694513054586, 30727.385452290382, 31078.68921310758, 31441.371172575964, 48906.266406003226, 49291.01417971692, 49307.0, 49336.75331623319, 49354.75322623364, 426119.0, 435022.0, 435613.0, 435999.0, 436689.0, 32747.672523275414, 33390.0, 33986.32027359489, 39188.216235675696, 39732.2053558933, 40383.3942490857, 46594.76702616465, 46936.53063469322, 47676.284855726495, 48173.75913120412, 37799.24401512009, 38725.419118713806, 39132.80433597814, 39276.0, 39894.40158397685, 37295.0, 37568.51763584336, 37960.24079518339, 38118.0, 38394.42408363821, 39424.40863387109, 39957.40063898986, 40263.79868100641, 40621.593784061784, 40799.1840163201, 35143.297134057684, 35257.29485410226, 35534.64465355417, 35767.0, 35932.820335898155, 27158.864205678845, 27225.956476393945, 27405.889116632665, 27597.172084836682, 27655.861720691268], "value": 19932.029323794206, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.87408218246884, 380.53384603860275, 391.31324525457825, 399.77612536979274, 408.1734487662483, 16860.494185174433, 18825.62348753024, 19032.61934761304, 19044.428667140008, 19074.904625476887, 17468.21393037313, 18335.358262460817, 18434.539136521595, 18893.0, 18913.338033168842, 4950.6782059166035, 5040.722760248185, 5106.872328191806, 5125.948740512585, 5128.769205385766, 5610.13042978339, 5623.26897503324, 5648.802291919784, 5655.802046928358, 5658.321001479828, 5117.820876269331, 5606.018946684334, 5610.074337734269, 5615.326160860703, 5617.691026993513, 5357.598180136505, 5429.0, 5434.7826086956675, 5443.455654434564, 5460.372057213432, 5079.339685840854, 5470.2888624478965, 5473.397926228112, 5475.589330800166, 5484.177373393983, 12551.874481255161, 12827.973762099009, 12837.486500539968, 19803.801961980338, 21146.471338216514, 2066.545360020793, 2099.4121645939163, 2165.8159056480217, 2210.767869373725, 2379.250536081146, 9133.954330228373, 9137.680181193693, 9337.159655630958, 9461.574229159703, 9656.37233579815, 1815.9273629054821, 1866.346778627483, 1871.6243560982666, 1907.637548865711, 1921.7213504041974, 43970.560294396964, 56609.43390566083, 76199.0, 80899.19100808975, 80921.59539202326, 10236.0, 10515.211359148094, 10624.256302058937, 10786.191035672357, 11086.445677716081, 12821.551245706356, 13946.58160255194, 14793.852061479247, 14990.47533336328, 15010.924945375204, 8126.390520710852, 8199.877001844978, 8349.415540912078, 8403.411761176782, 8543.743687689379, 8190.303824175012, 8236.341092712568, 8298.792530186794, 8388.622511986854, 8426.452280601741, 4652.209124448852, 4668.5798278155125, 4669.906601868011, 4796.37647105874, 4822.180229361017, 1794.4078454110113, 1840.981590184081, 1893.337331933812, 1910.8471322294183, 1948.4641723526145, 950.619752099152, 954.6038394066524, 994.7413672445216, 1016.6797458800454, 1066.802641511323, 17466.476005719847, 17953.102344882966, 18448.35430759917, 18841.717374239397, 18926.526836828914, 969.1810420194925, 971.4317124482116, 986.413084214891, 1042.457921880633, 1049.8530205771199, 9876.506174691236, 10550.0, 10564.260501764802, 10608.075915190955, 10673.35959842412, 529988.0, 530411.0, 535546.0, 550636.0, 551970.0, 58518.4148158513, 68633.0, 91371.0, 91558.0, 92291.0, 988.9554970026367, 1002.809466201434, 1017.1760873692333, 1033.4574348467115, 1039.3555995282973, 16410.17949102564, 16422.917885410498, 16530.504084877473, 16584.336626534805, 16595.83404165943, 28239.0, 36398.8180059098, 36436.27127457489, 39425.80287098546, 41710.791446042575, 51570.0, 53392.0, 53941.460585395216, 53942.46057539374, 54890.17664734952, 7309.195988441374, 7685.577293248925, 8348.373871959506, 8451.492910425393, 8600.78498037554, 13155.60533184006, 13457.663558410726, 13460.326983650582, 13603.455861765815, 13608.455661773418, 10904.50929708181, 11754.882451175721, 11800.468978895799, 11820.40897955116, 12011.159218854596, 11224.775504490028, 11485.770284594095, 11734.882651173379, 11932.1050921183, 11974.760504789681, 10043.443266293736, 10667.786644266916, 12005.939970300093, 12249.0, 12285.93857030745, 7293.708251669874, 7548.773536793905, 7857.410694197843, 8428.157184281768, 8758.080401557745, 9858.748345096044, 11446.084313255085, 11870.881291187323, 11919.0, 11924.403779811148], "value": 8799.432008611191, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.267253010845, 1482.8591283828032, 1513.5156749840048, 1664.850163485286, 1798.694221982263, 8118.391120665951, 8536.274416674582, 8542.402031857764, 8752.212300892917, 8779.2098711116, 8522.275606573448, 8710.738677839676, 8716.520591367473, 8726.432781869175, 8731.86902196466, 1934.2746470073723, 2106.6839974003947, 2169.273293446697, 2276.146445083094, 2300.3788976976207, 2320.512692334612, 2325.139698311627, 2328.767123287666, 2329.301209637111, 2330.0330362899376, 2155.5365596396773, 2201.0535469748, 2204.7464541577765, 2205.2943058221376, 2206.1837120265523, 1937.3122541497776, 2213.944651383712, 2265.2184996176456, 2270.818334533233, 2287.3709729824263, 2220.822334213275, 2232.118313266251, 2238.809701175402, 2239.1715065425733, 2256.4133325335365, 8538.146185381474, 8587.570621468902, 8607.741767746978, 8608.655653773842, 8631.6978905738, 5179.14544100223, 5269.1832765921345, 5304.840854774363, 5314.176302673091, 5321.2284218788445, 3261.8858339958224, 3358.882439114619, 3447.5345828313357, 3454.65453454655, 3462.8961131166106, 1056.4295280548495, 1072.0726571515584, 1088.7278180454887, 1116.3636727065575, 1135.9261647992937, 12080.0, 12133.757324853454, 12154.939225303906, 12226.572069977597, 12285.877141228562, 4500.617447516997, 4594.494605593382, 4656.278276867091, 4678.134545109166, 4727.456342520585, 10152.187824973984, 10156.898431015743, 10180.083792458714, 10270.691879243635, 10278.640247591447, 4470.552944705569, 5294.7617357219015, 5295.841124766263, 5300.257963885059, 5301.734913254322, 4726.905461890743, 4843.346148269939, 4846.127697014571, 4851.684640498356, 4881.243407271879, 3808.847646094125, 3904.39481880309, 3967.920641587152, 3985.960140398617, 3995.06116062725, 1233.802591585342, 1241.3048692731918, 1254.4480428611382, 1255.8995280377549, 1258.5783762439503, 798.9840203195904, 911.4030310146865, 912.7581190984395, 915.6200176926501, 936.0545848692733, 5596.384397716248, 5632.408597097327, 5685.090385538294, 5712.6001179917, 5733.0, 890.6214858685033, 906.3881879731155, 916.4959272400154, 967.3277072434731, 1000.4297550396204, 3920.725549211528, 4049.655779258796, 4054.2702313583836, 4060.817263223162, 4113.300738874398, 10277.794444111225, 10791.56833726642, 10861.402622855661, 10862.61980830683, 10877.891221087688, 10526.31578947366, 10726.463676816284, 10793.460326983619, 10807.83788243177, 10885.129189664807, 8010.0, 8046.155153708776, 8095.3523718102415, 8149.633266502903, 8169.387295952827, 5560.555155587463, 5587.161925711176, 5655.095184770417, 5676.9432305678065, 5723.570732195185, 9787.559559819683, 9829.950850245703, 9920.206383489447, 9928.751781205528, 9948.154406875206, 9808.9019109808, 9905.851412228678, 10130.94934525352, 10214.387136771817, 10215.336003160068, 6270.561060725706, 6992.510524263253, 7197.71209151628, 7224.74713385029, 7356.705731770883, 8422.705205317785, 8429.4942303462, 8461.153884611489, 8514.148585141436, 8515.8722619162, 7479.70081196746, 7674.079110506552, 7686.3082322591235, 7773.844523109619, 7820.452568320163, 7416.110066792019, 7591.696332146652, 7634.0, 7770.339521140766, 7774.30031297186, 7013.754518591825, 7047.330503602149, 7053.894191587027, 7079.752208672672, 7091.397231235196, 4784.784684689128, 4989.600831933364, 5087.262346959744, 5092.439831618445, 5116.74416279192, 5086.61850361217, 5109.770060347368, 5189.532942035235, 5228.0, 5291.656042357235], "value": 4546.7942450345445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.21983091847665, 324.5650827890626, 326.77942388887493, 328.84708610496114, 333.60134639106263, 5284.31303930489, 5314.0, 5354.2771725817, 5373.596980226479, 5376.8118115865955, 5255.527002569768, 5270.604704647158, 5271.367435907687, 5280.947190528093, 5353.812616558412, 3987.5813039630857, 4019.216252830699, 4152.691902050859, 4194.496660400756, 4221.134667393177, 4169.124483858393, 4172.0, 4191.727537710054, 4202.201581699467, 4212.347086201644, 3924.82338294776, 4140.689448291375, 4143.730657507267, 4150.294449943517, 4153.356229784388, 4027.5972402759635, 4039.5354534228645, 4050.2709512287774, 4143.798298493433, 4163.604457576525, 3640.5449318835144, 3667.963320366789, 3676.981615091934, 3680.1167719747336, 3681.7238707097076, 5113.360829896263, 5119.206522988906, 5126.871828204287, 5128.153854613985, 5142.897142057175, 4536.319552067183, 4713.222318317507, 4721.0, 4763.214069678499, 4765.737884416356, 5467.617266791326, 5514.172874068921, 5523.0, 5529.22590837279, 5555.194496797942, 4022.9684009574976, 4030.2141082488924, 4032.2741906456827, 4039.838406463738, 4041.2523683118716, 5559.777608895639, 5669.489745922887, 5755.712214389264, 5765.971170144165, 5773.0, 4081.6326530611796, 4083.8979025524004, 4085.4688890444645, 4100.302948498763, 4123.752574845519, 4133.958660413417, 4143.875683729493, 4150.8547200847825, 4151.584841515884, 4166.937495937564, 4515.680974483752, 4728.40894888139, 4728.59806916416, 4742.146413645577, 4747.430308363018, 5527.623122057554, 5530.6128571000445, 5560.165975103686, 5575.8884822304135, 5592.468715472024, 1430.9713805724036, 1442.149132012118, 1443.7545617245094, 1445.1762495377743, 1449.7680371140777, 889.6485888074175, 895.5343221524771, 933.85992101184, 937.7468083617385, 957.8658987741721, 5298.735063246822, 5360.16917377807, 5364.758585863646, 5385.569154467633, 5398.811041613603, 5727.713614319267, 5739.737257803276, 5739.741711622987, 5743.282089738783, 5752.194692743019, 5268.841934741964, 5306.946930530722, 5385.057614917374, 5417.241586177938, 5425.945740542623, 3047.756179505634, 3048.3598444326494, 3055.724984751383, 3062.8774849006236, 3065.2183693158104, 5887.61730487517, 5905.202797622352, 5912.881742365129, 5945.702714864239, 5957.4042595740075, 5571.66570005801, 5842.4653084883885, 5854.560907931922, 5857.619254748428, 5865.0, 5873.647581145145, 5894.852628684232, 5908.793192238251, 5915.456353767835, 5929.436703513332, 5560.332760068818, 5577.903725082609, 5731.254936858182, 5766.538676905921, 5779.219805326227, 5666.943330566806, 5672.461116193955, 5721.427857214246, 5727.914081288701, 5734.483896449339, 5895.20414744004, 5915.497182739516, 5939.4357536034, 5943.632964418121, 5964.343922168645, 3885.9222815542967, 3986.342253528135, 4019.336809426412, 4021.3163762159916, 4023.9396409054475, 5709.429057094258, 5740.942590574041, 5748.885022299447, 5787.710614469344, 5815.854603634943, 5398.811041613525, 5665.858353541194, 5666.46168613981, 5672.376038635664, 5678.432156784289, 5564.0, 5588.636738611977, 5662.85842853932, 5664.235328230636, 5665.376808550974, 5276.973615131899, 5434.1795498508445, 5465.781368745205, 5499.340079190362, 5506.393312380397, 5401.729913504388, 5580.525655319343, 5638.85902852432, 5682.545396368363, 5685.715714214355, 5485.588580856372, 5500.22996780459, 5539.418361072029, 5547.805826796042, 5556.333240011225], "value": 4251.378338884754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4611541343993, 765.8353454007387, 786.4023342259884, 800.7317548621212, 810.5217921426357, 15440.0, 15648.139352335631, 15869.444569440058, 16391.34434622614, 16830.24263908124, 15133.924330378333, 15251.237438128104, 15261.923690381533, 15310.46413375532, 15316.23418829057, 674.5042393840523, 796.0964305513255, 796.5419883566958, 814.8777683347515, 815.0463957170095, 810.0603300171801, 819.8442295963778, 820.2207902492626, 821.2485575698229, 822.979425514361, 847.6439895243982, 853.0701535326493, 854.1714536899198, 854.2824027816632, 854.3250831842837, 710.9360157585817, 831.2767891933995, 849.354490587152, 850.459957926718, 850.4939560961218, 619.1734035063196, 619.4796371048341, 620.1225266248254, 620.8944479438507, 620.9037599172091, 13878.791818122736, 13901.165930044128, 13905.4437822488, 13906.652333691738, 13908.235047072407, 13793.172409655454, 14060.578182654537, 14174.07868488545, 14202.360893759806, 14313.0, 12517.499300027988, 12660.620181394574, 12676.80984785229, 12782.936085319607, 12822.230666159967, 4433.578810013076, 4455.844045458393, 4547.15877562652, 4559.498455169929, 4699.389079419688, 70031.64984175097, 70630.29369706288, 71152.644236779, 75076.62461687712, 75370.99999999945, 10581.788364232672, 10623.36259824413, 10642.467876606139, 10691.518881650345, 10777.89222107769, 21340.146394144373, 21423.57152856934, 21445.249416270355, 21516.354509364744, 21871.0, 7999.0, 8050.396220283502, 8148.307393871469, 8532.658693652309, 8789.296856251485, 4473.923657897502, 4729.077829823152, 4790.257510085942, 4861.440934292531, 4988.326575912205, 3442.8794992175153, 3564.7148228141687, 3564.8395822188063, 3574.696150827209, 3577.2308953575107, 559.7565059199261, 577.1861675038176, 592.623683960688, 595.9642421454727, 618.9102580125857, 585.4847733994058, 702.9156501219886, 705.0728292295615, 705.6295444891473, 720.050640924191, 9748.31761776683, 9807.0, 9945.0, 9968.700938971842, 9977.950110249401, 667.8797816392998, 671.3085521912438, 684.226823689228, 713.5896859305919, 728.9562626242337, 4761.642876784185, 4929.7781599828095, 4973.47778483254, 5004.84985450437, 5069.340985671913, 76520.23479765131, 93506.06493934973, 116322.41838790922, 118905.0, 122109.38945305394, 65889.67055164694, 89791.55104224567, 94931.52534237284, 105196.47401762943, 105480.47259763652, 90363.54818225867, 93065.0, 93248.53375733213, 94717.0528294722, 97580.0, 9430.113024356864, 9636.75908102275, 9650.806983860424, 9677.467739274407, 9807.509624518603, 52651.47348526466, 53387.0, 54148.45851541434, 54430.0, 54831.725841370535, 68445.0, 77602.61198693971, 77934.0, 78127.21872781427, 78701.0, 12634.178778379375, 12958.935205323913, 12972.156809807333, 13214.471421143431, 13712.588622341345, 14902.552923412315, 14961.925190373979, 14971.625709357353, 15135.394584216509, 15328.310226039632, 13393.531226407029, 13844.446222151404, 13920.443182273, 13987.650308742363, 14598.70802583921, 13880.861191388361, 13907.675233239706, 14151.0, 14248.928755356157, 14292.571222863331, 13785.51750688721, 13819.79270310926, 14101.717965640835, 14115.788263176266, 14192.219427931563, 11663.358515281741, 11667.533298667959, 11812.990898890414, 11866.914602203316, 12019.278843269432, 11561.768764624829, 11598.18812683104, 11793.587224447103, 11836.349000805038, 11991.0], "value": 7603.071506800113, "unit": "score"}], "name": "dromaeo_css", "value": 7140.970078587242, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 111.0, 111.0, 112.0, 110.0, 111.0, 111.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 135.0, 137.0, 181.0, 128.0, 152.0, 153.0, 129.0, 187.0, 127.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 168.0, 161.0, 161.0, 163.0, 161.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 119.0, 75.0, 77.0, 74.0, 75.0, 98.0, 73.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 118.0, 86.0, 86.0, 87.0, 118.0, 87.0, 86.0, 127.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 119.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 57.0, 56.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 86.0, 86.0, 83.0, 80.0, 85.0, 79.0, 114.0, 80.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 121.0, 122.0, 121.0, 128.0, 127.0, 132.0, 156.0, 122.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 160.0, 172.0, 168.0, 163.0, 161.0, 166.0, 163.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 63.0, 67.0, 62.0, 66.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1518.0000000000002, "alertThreshold": 2.0}]} 01:26:20 INFO - Return code: 0 01:26:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:26:20 ERROR - # TBPL SUCCESS # 01:26:20 INFO - Running post-action listener: _resource_record_post_action 01:26:20 INFO - ##### 01:26:20 INFO - ##### Finished run-tests step (success) 01:26:20 INFO - ##### 01:26:20 INFO - Running post-run listener: _resource_record_post_run 01:26:20 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 549842944; Read time: 424; Write time: 768352 01:26:20 INFO - TinderboxPrint: CPU usage
13.2% 01:26:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 424 01:26:20 INFO - TinderboxPrint: I/O write bytes / time
549,842,944 / 768,352 01:26:20 INFO - TinderboxPrint: CPU idle
8,264.1 (86.8%) 01:26:20 INFO - TinderboxPrint: CPU user
1,206.7 (12.7%) 01:26:20 INFO - TinderboxPrint: Swap in / out
0 / 0 01:26:20 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 257380352; Read time: 0; Write time: 396832 01:26:20 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292462592; Read time: 424; Write time: 371520 01:26:21 INFO - Running post-run listener: _upload_blobber_files 01:26:21 INFO - Blob upload gear active. 01:26:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:26:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:26:21 INFO - (blobuploader) - INFO - Open directory for files ... 01:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:26:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:25 INFO - (blobuploader) - INFO - Done attempting. 01:26:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:26:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:26:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:26 INFO - (blobuploader) - INFO - Done attempting. 01:26:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:26:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:26:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:27 INFO - (blobuploader) - INFO - Done attempting. 01:26:27 INFO - (blobuploader) - INFO - Iteration through files over. 01:26:27 INFO - Return code: 0 01:26:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:26:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:26:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/246e2607a6e0e86ec66085dc9d88e60e43b67a475f31bb0f9aee8cb69344da08d179884548f99552ffae62cbbc11c3566351e3e620704b4f18d38258ba5f74d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a4cc845775b2ad6ed35dc01c6a1945749ce3a96e6f1f21dcc642c68e4de44aacc79c4e24c31754dbc0995f1f04560b2c58f64b888fde2638f3578475a6bdd92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fe1364b92dd4caa990866521d7047f0096c2b8e9168fcba5403fd466be180c24abf95a1820025a6c16099d0fd31854604ddc1cdf330cbff84bae9e9842cfdb2"} 01:26:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:26:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:26:27 INFO - Contents: 01:26:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/246e2607a6e0e86ec66085dc9d88e60e43b67a475f31bb0f9aee8cb69344da08d179884548f99552ffae62cbbc11c3566351e3e620704b4f18d38258ba5f74d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a4cc845775b2ad6ed35dc01c6a1945749ce3a96e6f1f21dcc642c68e4de44aacc79c4e24c31754dbc0995f1f04560b2c58f64b888fde2638f3578475a6bdd92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fe1364b92dd4caa990866521d7047f0096c2b8e9168fcba5403fd466be180c24abf95a1820025a6c16099d0fd31854604ddc1cdf330cbff84bae9e9842cfdb2"} 01:26:27 INFO - Running post-run listener: copy_logs_to_upload_dir 01:26:27 INFO - Copying logs to upload dir... 01:26:27 INFO - mkdir: /builds/slave/test/build/upload/logs 01:26:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.414005 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-07 01:26:26.858886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:26:26.862862) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/246e2607a6e0e86ec66085dc9d88e60e43b67a475f31bb0f9aee8cb69344da08d179884548f99552ffae62cbbc11c3566351e3e620704b4f18d38258ba5f74d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a4cc845775b2ad6ed35dc01c6a1945749ce3a96e6f1f21dcc642c68e4de44aacc79c4e24c31754dbc0995f1f04560b2c58f64b888fde2638f3578475a6bdd92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fe1364b92dd4caa990866521d7047f0096c2b8e9168fcba5403fd466be180c24abf95a1820025a6c16099d0fd31854604ddc1cdf330cbff84bae9e9842cfdb2"} build_url:https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/DZJjAC0gSvOM5soOBxjo6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/246e2607a6e0e86ec66085dc9d88e60e43b67a475f31bb0f9aee8cb69344da08d179884548f99552ffae62cbbc11c3566351e3e620704b4f18d38258ba5f74d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a4cc845775b2ad6ed35dc01c6a1945749ce3a96e6f1f21dcc642c68e4de44aacc79c4e24c31754dbc0995f1f04560b2c58f64b888fde2638f3578475a6bdd92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fe1364b92dd4caa990866521d7047f0096c2b8e9168fcba5403fd466be180c24abf95a1820025a6c16099d0fd31854604ddc1cdf330cbff84bae9e9842cfdb2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:26:26.888531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:26:26.888888) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465286746.946165-1223695422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004344 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:26:26.971343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:26:26.971670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:26:26.971958) ========= ========= Total master_lag: 0.17 =========