builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1466511185.34 results: success (0) buildid: 20160621023402 builduid: d60a2bc7d6194f1aa48bf2ad910bcf31 revision: 9f182283211dbebccb57bbc9f4c8b9f7be8b91a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.342222) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.342806) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.343125) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.367721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.368394) ========= 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=db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 05:13:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-06-21 05:13:05 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093102 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.476995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.477421) ========= 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=db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014736 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.527652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:05.528053) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f182283211dbebccb57bbc9f4c8b9f7be8b91a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f182283211dbebccb57bbc9f4c8b9f7be8b91a0 --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=db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 05:13:05,936 truncating revision to first 12 chars 2016-06-21 05:13:05,936 Setting DEBUG logging. 2016-06-21 05:13:05,936 attempt 1/10 2016-06-21 05:13:05,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9f182283211d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 05:13:06,240 unpacking tar archive at: mozilla-aurora-9f182283211d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.687941 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:06.234098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:06.234900) ========= script_repo_revision: 9f182283211dbebccb57bbc9f4c8b9f7be8b91a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:06.235860) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:06.236562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 05:13:06.248366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-21 05:13:06.248792) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:13:06 INFO - MultiFileLogger online at 20160621 05:13:06 in /builds/slave/test 05:13:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:13:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:13:06 INFO - {'append_to_log': False, 05:13:06 INFO - 'base_work_dir': '/builds/slave/test', 05:13:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:13:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:13:06 INFO - 'branch': 'Mozilla-Aurora', 05:13:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:13:06 INFO - 'config_files': ('talos/linux_config.py',), 05:13:06 INFO - 'default_actions': ('clobber', 05:13:06 INFO - 'read-buildbot-config', 05:13:06 INFO - 'download-and-extract', 05:13:06 INFO - 'populate-webroot', 05:13:06 INFO - 'create-virtualenv', 05:13:06 INFO - 'install', 05:13:06 INFO - 'run-tests'), 05:13:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:13:06 INFO - 'download_minidump_stackwalk': True, 05:13:06 INFO - 'download_symbols': 'ondemand', 05:13:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:13:06 INFO - 'tooltool.py': '/tools/tooltool.py', 05:13:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:13:06 INFO - '/tools/misc-python/virtualenv.py')}, 05:13:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:13:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:13:06 INFO - 'installer_path': 'installer.exe', 05:13:06 INFO - 'log_level': 'info', 05:13:06 INFO - 'log_name': 'talos', 05:13:06 INFO - 'log_to_console': True, 05:13:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:13:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:13:06 INFO - 'opt_config_files': (), 05:13:06 INFO - 'pip_index': False, 05:13:06 INFO - 'sps_profile': False, 05:13:06 INFO - 'sps_profile_interval': 0, 05:13:06 INFO - 'suite': 'dromaeojs-e10s', 05:13:06 INFO - 'system_bits': '32', 05:13:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:13:06 INFO - 'title': 'talos-linux64-ix-031', 05:13:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:13:06 INFO - 'use_talos_json': True, 05:13:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:13:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:13:06 INFO - 'work_dir': 'build'} 05:13:06 INFO - ##### 05:13:06 INFO - ##### Running clobber step. 05:13:06 INFO - ##### 05:13:06 INFO - Running pre-action listener: _resource_record_pre_action 05:13:06 INFO - Running main action method: clobber 05:13:06 INFO - rmtree: /builds/slave/test/build 05:13:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:13:07 INFO - Running post-action listener: _resource_record_post_action 05:13:07 INFO - ##### 05:13:07 INFO - ##### Finished clobber step (success) 05:13:07 INFO - ##### 05:13:07 INFO - ##### 05:13:07 INFO - ##### Running read-buildbot-config step. 05:13:07 INFO - ##### 05:13:07 INFO - Running pre-action listener: _resource_record_pre_action 05:13:07 INFO - Running main action method: read_buildbot_config 05:13:07 INFO - Using buildbot properties: 05:13:07 INFO - { 05:13:07 INFO - "project": "", 05:13:07 INFO - "product": "firefox", 05:13:07 INFO - "script_repo_revision": "production", 05:13:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:13:07 INFO - "repository": "", 05:13:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:13:07 INFO - "buildid": "20160621023402", 05:13:07 INFO - "pgo_build": "True", 05:13:07 INFO - "basedir": "/builds/slave/test", 05:13:07 INFO - "buildnumber": 365, 05:13:07 INFO - "slavename": "talos-linux64-ix-031", 05:13:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:13:07 INFO - "platform": "ubuntu64_hw", 05:13:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:13:07 INFO - "branch": "mozilla-aurora", 05:13:07 INFO - "repo_path": "releases/mozilla-aurora", 05:13:07 INFO - "revision": "9f182283211dbebccb57bbc9f4c8b9f7be8b91a0", 05:13:07 INFO - "stage_platform": "linux64-pgo", 05:13:07 INFO - "builduid": "d60a2bc7d6194f1aa48bf2ad910bcf31", 05:13:07 INFO - "slavebuilddir": "test" 05:13:07 INFO - } 05:13:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 05:13:07 INFO - Running post-action listener: _resource_record_post_action 05:13:07 INFO - ##### 05:13:07 INFO - ##### Finished read-buildbot-config step (success) 05:13:07 INFO - ##### 05:13:07 INFO - ##### 05:13:07 INFO - ##### Running download-and-extract step. 05:13:07 INFO - ##### 05:13:07 INFO - Running pre-action listener: _resource_record_pre_action 05:13:07 INFO - Running main action method: download_and_extract 05:13:07 INFO - mkdir: /builds/slave/test/build/tests 05:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:07 INFO - https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:13:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:13:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:13:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:13:07 INFO - Downloaded 1361 bytes. 05:13:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:13:07 INFO - Using the following test package requirements: 05:13:07 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 05:13:07 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:13:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:13:07 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:13:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:13:07 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:13:07 INFO - u'jsshell-linux-x86_64.zip'], 05:13:07 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:13:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:13:07 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 05:13:07 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:13:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:13:07 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:13:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:13:07 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:13:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:13:07 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:13:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:13:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:07 INFO - https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:13:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:13:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:13:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:13:09 INFO - Downloaded 24472712 bytes. 05:13:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:13:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:13:10 INFO - Return code: 0 05:13:10 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:13:10 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')]} 05:13:10 INFO - https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:13:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:13:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:13:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:13:12 INFO - Downloaded 24472712 bytes. 05:13:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:13:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:13:13 INFO - Return code: 0 05:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:13 INFO - https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:13:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:13:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:13:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:13:14 INFO - Downloaded 10833369 bytes. 05:13:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:13:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:13:14 INFO - Return code: 0 05:13:14 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')]} 05:13:14 INFO - https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:13:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:13:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:13:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:13:17 INFO - Downloaded 63606494 bytes. 05:13:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:13:17 INFO - mkdir: /builds/slave/test/properties 05:13:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:13:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:13:17 INFO - Contents: 05:13:17 INFO - build_url:https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:13:18 INFO - Running post-action listener: _resource_record_post_action 05:13:18 INFO - Running post-action listener: set_extra_try_arguments 05:13:18 INFO - ##### 05:13:18 INFO - ##### Finished download-and-extract step (success) 05:13:18 INFO - ##### 05:13:18 INFO - ##### 05:13:18 INFO - ##### Running populate-webroot step. 05:13:18 INFO - ##### 05:13:18 INFO - Running pre-action listener: _resource_record_pre_action 05:13:18 INFO - Running main action method: populate_webroot 05:13:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:18 INFO - '--tppagecycles', 05:13:18 INFO - '7'], 05:13:18 INFO - 'tests': ['tsvgm']}}, 05:13:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:13:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:13:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:13:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:18 INFO - 'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:18 INFO - 'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['damp', 'tps']}, 05:13:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:18 INFO - 'tests': ['damp', 'tps']}, 05:13:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['dromaeo_dom']}, 05:13:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['a11yr', 05:13:18 INFO - 'ts_paint', 05:13:18 INFO - 'tpaint', 05:13:18 INFO - 'sessionrestore', 05:13:18 INFO - 'sessionrestore_no_auto_restore', 05:13:18 INFO - 'tabpaint']}, 05:13:18 INFO - 'other-e10s': {'tests': ['a11yr', 05:13:18 INFO - 'ts_paint', 05:13:18 INFO - 'tpaint', 05:13:18 INFO - 'sessionrestore', 05:13:18 INFO - 'sessionrestore_no_auto_restore', 05:13:18 INFO - 'tabpaint']}, 05:13:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:13:18 INFO - 'ts_paint', 05:13:18 INFO - 'tpaint', 05:13:18 INFO - 'sessionrestore', 05:13:18 INFO - 'sessionrestore_no_auto_restore', 05:13:18 INFO - 'tabpaint']}, 05:13:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:13:18 INFO - 'ts_paint', 05:13:18 INFO - 'tpaint', 05:13:18 INFO - 'sessionrestore', 05:13:18 INFO - 'sessionrestore_no_auto_restore', 05:13:18 INFO - 'tabpaint']}, 05:13:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['a11yr', 05:13:18 INFO - 'ts_paint', 05:13:18 INFO - 'tpaint', 05:13:18 INFO - 'sessionrestore', 05:13:18 INFO - 'sessionrestore_no_auto_restore', 05:13:18 INFO - 'tabpaint']}, 05:13:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['a11yr', 05:13:18 INFO - 'ts_paint', 05:13:18 INFO - 'tpaint', 05:13:18 INFO - 'sessionrestore', 05:13:18 INFO - 'sessionrestore_no_auto_restore', 05:13:18 INFO - 'tabpaint']}, 05:13:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['tsvgx', 05:13:18 INFO - 'tsvgr_opacity', 05:13:18 INFO - 'tart', 05:13:18 INFO - 'tscrollx', 05:13:18 INFO - 'cart']}, 05:13:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:13:18 INFO - 'tsvgr_opacity', 05:13:18 INFO - 'tart', 05:13:18 INFO - 'tscrollx', 05:13:18 INFO - 'cart']}, 05:13:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:18 INFO - 'talos_options': ['--disable-e10s'], 05:13:18 INFO - 'tests': ['tp5o']}, 05:13:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:18 INFO - 'tests': ['tp5o']}, 05:13:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:18 INFO - 'talos_options': ['--disable-e10s', 05:13:18 INFO - '--xperf_path', 05:13:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:18 INFO - 'tests': ['tp5n']}, 05:13:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:18 INFO - 'talos_options': ['--xperf_path', 05:13:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:18 INFO - 'tests': ['tp5n']}}, 05:13:18 INFO - 'talos.zip': {'path': '', 05:13:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:18 INFO - Running post-action listener: _resource_record_post_action 05:13:18 INFO - ##### 05:13:18 INFO - ##### Finished populate-webroot step (success) 05:13:18 INFO - ##### 05:13:18 INFO - ##### 05:13:18 INFO - ##### Running create-virtualenv step. 05:13:18 INFO - ##### 05:13:18 INFO - Running pre-action listener: _resource_record_pre_action 05:13:18 INFO - Running main action method: create_virtualenv 05:13:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:13:18 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 05:13:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:13:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:18 INFO - Using real prefix '/usr' 05:13:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:13:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:20 INFO - Installing pip.................done. 05:13:20 INFO - Return code: 0 05:13:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:20 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:20 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 05:13:20 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 05:13:20 INFO - Using env: {'DISPLAY': ':0', 05:13:20 INFO - 'HOME': '/home/cltbld', 05:13:20 INFO - 'LANG': 'en_US.UTF-8', 05:13:20 INFO - 'LANGUAGE': 'en_US:en', 05:13:20 INFO - 'LOGNAME': 'cltbld', 05:13:20 INFO - 'MAIL': '/var/mail/cltbld', 05:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:21 INFO - 'MOZ_NO_REMOTE': '1', 05:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:21 INFO - 'NO_EM_RESTART': '1', 05:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:21 INFO - 'PWD': '/builds/slave/test', 05:13:21 INFO - 'SHELL': '/bin/bash', 05:13:21 INFO - 'SHLVL': '1', 05:13:21 INFO - 'TERM': 'linux', 05:13:21 INFO - 'TMOUT': '86400', 05:13:21 INFO - 'USER': 'cltbld', 05:13:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:21 INFO - '_': '/tools/buildbot/bin/python'} 05:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:21 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 05:13:21 INFO - Cleaning up... 05:13:21 INFO - Return code: 0 05:13:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:21 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:21 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 05:13:21 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 05:13:21 INFO - Using env: {'DISPLAY': ':0', 05:13:21 INFO - 'HOME': '/home/cltbld', 05:13:21 INFO - 'LANG': 'en_US.UTF-8', 05:13:21 INFO - 'LANGUAGE': 'en_US:en', 05:13:21 INFO - 'LOGNAME': 'cltbld', 05:13:21 INFO - 'MAIL': '/var/mail/cltbld', 05:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:21 INFO - 'MOZ_NO_REMOTE': '1', 05:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:21 INFO - 'NO_EM_RESTART': '1', 05:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:21 INFO - 'PWD': '/builds/slave/test', 05:13:21 INFO - 'SHELL': '/bin/bash', 05:13:21 INFO - 'SHLVL': '1', 05:13:21 INFO - 'TERM': 'linux', 05:13:21 INFO - 'TMOUT': '86400', 05:13:21 INFO - 'USER': 'cltbld', 05:13:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:21 INFO - '_': '/tools/buildbot/bin/python'} 05:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:21 INFO - Downloading/unpacking psutil>=3.1.1 05:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:23 INFO - Installing collected packages: psutil 05:13:23 INFO - Running setup.py install for psutil 05:13:23 INFO - building 'psutil._psutil_linux' extension 05:13:23 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 05:13:23 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 05:13:23 INFO - building 'psutil._psutil_posix' extension 05:13:23 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 05:13:23 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 05:13:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:23 INFO - Successfully installed psutil 05:13:23 INFO - Cleaning up... 05:13:23 INFO - Return code: 0 05:13:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:13: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 mozsystemmonitor==0.3 05:13:23 INFO - Using env: {'DISPLAY': ':0', 05:13:23 INFO - 'HOME': '/home/cltbld', 05:13:23 INFO - 'LANG': 'en_US.UTF-8', 05:13:23 INFO - 'LANGUAGE': 'en_US:en', 05:13:23 INFO - 'LOGNAME': 'cltbld', 05:13:23 INFO - 'MAIL': '/var/mail/cltbld', 05:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:23 INFO - 'MOZ_NO_REMOTE': '1', 05:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:23 INFO - 'NO_EM_RESTART': '1', 05:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:23 INFO - 'PWD': '/builds/slave/test', 05:13:23 INFO - 'SHELL': '/bin/bash', 05:13:23 INFO - 'SHLVL': '1', 05:13:23 INFO - 'TERM': 'linux', 05:13:23 INFO - 'TMOUT': '86400', 05:13:23 INFO - 'USER': 'cltbld', 05:13:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:23 INFO - '_': '/tools/buildbot/bin/python'} 05:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:13:26 INFO - Installing collected packages: mozsystemmonitor 05:13:26 INFO - Running setup.py install for mozsystemmonitor 05:13:26 INFO - Successfully installed mozsystemmonitor 05:13:26 INFO - Cleaning up... 05:13:26 INFO - Return code: 0 05:13:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:26 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:26 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 05:13:26 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 05:13:26 INFO - Using env: {'DISPLAY': ':0', 05:13:26 INFO - 'HOME': '/home/cltbld', 05:13:26 INFO - 'LANG': 'en_US.UTF-8', 05:13:26 INFO - 'LANGUAGE': 'en_US:en', 05:13:26 INFO - 'LOGNAME': 'cltbld', 05:13:26 INFO - 'MAIL': '/var/mail/cltbld', 05:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:26 INFO - 'MOZ_NO_REMOTE': '1', 05:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:26 INFO - 'NO_EM_RESTART': '1', 05:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:26 INFO - 'PWD': '/builds/slave/test', 05:13:26 INFO - 'SHELL': '/bin/bash', 05:13:26 INFO - 'SHLVL': '1', 05:13:26 INFO - 'TERM': 'linux', 05:13:26 INFO - 'TMOUT': '86400', 05:13:26 INFO - 'USER': 'cltbld', 05:13:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:26 INFO - '_': '/tools/buildbot/bin/python'} 05:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:26 INFO - Downloading/unpacking jsonschema==2.5.1 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:13:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:13:28 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 05:13:28 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 05:13:28 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 05:13:28 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 05:13:28 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 05:13:28 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 05:13:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:13:28 INFO - warning: no files found matching '*.txt' 05:13:28 INFO - no previously-included directories found matching 'build' 05:13:28 INFO - no previously-included directories found matching 'dist' 05:13:28 INFO - no previously-included directories found matching '.git*' 05:13:28 INFO - Installing collected packages: jsonschema, functools32 05:13:28 INFO - Running setup.py install for functools32 05:13:28 INFO - warning: no files found matching '*.txt' 05:13:28 INFO - no previously-included directories found matching 'build' 05:13:28 INFO - no previously-included directories found matching 'dist' 05:13:28 INFO - no previously-included directories found matching '.git*' 05:13:28 INFO - Successfully installed jsonschema functools32 05:13:28 INFO - Cleaning up... 05:13:28 INFO - Return code: 0 05:13:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:13:28 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')]} 05:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:28 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')]} 05:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:28 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:28 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 05:13:28 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 05:13:28 INFO - Using env: {'DISPLAY': ':0', 05:13:28 INFO - 'HOME': '/home/cltbld', 05:13:28 INFO - 'LANG': 'en_US.UTF-8', 05:13:28 INFO - 'LANGUAGE': 'en_US:en', 05:13:28 INFO - 'LOGNAME': 'cltbld', 05:13:28 INFO - 'MAIL': '/var/mail/cltbld', 05:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:28 INFO - 'MOZ_NO_REMOTE': '1', 05:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:28 INFO - 'NO_EM_RESTART': '1', 05:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:28 INFO - 'PWD': '/builds/slave/test', 05:13:28 INFO - 'SHELL': '/bin/bash', 05:13:28 INFO - 'SHLVL': '1', 05:13:28 INFO - 'TERM': 'linux', 05:13:28 INFO - 'TMOUT': '86400', 05:13:28 INFO - 'USER': 'cltbld', 05:13:28 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:28 INFO - '_': '/tools/buildbot/bin/python'} 05:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:13:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 INFO - Downloading docopt-0.6.1.tar.gz 05:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:31 INFO - Running setup.py install for blobuploader 05:13:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:13:31 INFO - Running setup.py install for requests 05:13:32 INFO - Running setup.py install for docopt 05:13:32 INFO - Successfully installed blobuploader requests docopt 05:13:32 INFO - Cleaning up... 05:13:32 INFO - Return code: 0 05:13:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:32 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:32 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 05:13:32 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 05:13:32 INFO - Using env: {'DISPLAY': ':0', 05:13:32 INFO - 'HOME': '/home/cltbld', 05:13:32 INFO - 'LANG': 'en_US.UTF-8', 05:13:32 INFO - 'LANGUAGE': 'en_US:en', 05:13:32 INFO - 'LOGNAME': 'cltbld', 05:13:32 INFO - 'MAIL': '/var/mail/cltbld', 05:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:32 INFO - 'MOZ_NO_REMOTE': '1', 05:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:32 INFO - 'NO_EM_RESTART': '1', 05:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:32 INFO - 'PWD': '/builds/slave/test', 05:13:32 INFO - 'SHELL': '/bin/bash', 05:13:32 INFO - 'SHLVL': '1', 05:13:32 INFO - 'TERM': 'linux', 05:13:32 INFO - 'TMOUT': '86400', 05:13:32 INFO - 'USER': 'cltbld', 05:13:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:32 INFO - '_': '/tools/buildbot/bin/python'} 05:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:32 INFO - Running setup.py (path:/tmp/pip-iopQ9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:32 INFO - Running setup.py (path:/tmp/pip-3tIvPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:32 INFO - Running setup.py (path:/tmp/pip-x8Y3eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:32 INFO - Running setup.py (path:/tmp/pip-TSeED2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:32 INFO - Running setup.py (path:/tmp/pip-QIpMDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:32 INFO - Running setup.py (path:/tmp/pip-jXmOYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:32 INFO - Running setup.py (path:/tmp/pip-t3vtmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:33 INFO - Running setup.py (path:/tmp/pip-akNAOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:33 INFO - Running setup.py (path:/tmp/pip-ccQWfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:33 INFO - Running setup.py (path:/tmp/pip-7rlKZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:33 INFO - Running setup.py (path:/tmp/pip-SHYLJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:33 INFO - Running setup.py (path:/tmp/pip-wFRQM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:33 INFO - Running setup.py (path:/tmp/pip-PlLEVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:33 INFO - Running setup.py (path:/tmp/pip-Mnwdta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:33 INFO - Running setup.py (path:/tmp/pip-rBqbV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:33 INFO - Running setup.py (path:/tmp/pip-6x2QTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:33 INFO - Running setup.py (path:/tmp/pip-nEiwZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:33 INFO - Running setup.py install for manifestparser 05:13:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:13:33 INFO - Running setup.py install for mozcrash 05:13:33 INFO - Running setup.py install for mozdebug 05:13:34 INFO - Running setup.py install for mozdevice 05:13:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Running setup.py install for mozfile 05:13:34 INFO - Running setup.py install for mozhttpd 05:13:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Running setup.py install for mozinfo 05:13:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Running setup.py install for mozInstall 05:13:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Running setup.py install for mozleak 05:13:34 INFO - Running setup.py install for mozlog 05:13:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Running setup.py install for moznetwork 05:13:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:13:34 INFO - Running setup.py install for mozprocess 05:13:34 INFO - Running setup.py install for mozprofile 05:13:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:13:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:13:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:13:35 INFO - Running setup.py install for mozrunner 05:13:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:13:35 INFO - Running setup.py install for mozscreenshot 05:13:35 INFO - Running setup.py install for moztest 05:13:35 INFO - Running setup.py install for mozversion 05:13:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:13:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:35 INFO - Cleaning up... 05:13:35 INFO - Return code: 0 05:13:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:35 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')]} 05:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:35 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')]} 05:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:35 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:35 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 05:13:35 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 05:13:35 INFO - Using env: {'DISPLAY': ':0', 05:13:35 INFO - 'HOME': '/home/cltbld', 05:13:35 INFO - 'LANG': 'en_US.UTF-8', 05:13:35 INFO - 'LANGUAGE': 'en_US:en', 05:13:35 INFO - 'LOGNAME': 'cltbld', 05:13:35 INFO - 'MAIL': '/var/mail/cltbld', 05:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:35 INFO - 'MOZ_NO_REMOTE': '1', 05:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:35 INFO - 'NO_EM_RESTART': '1', 05:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:35 INFO - 'PWD': '/builds/slave/test', 05:13:35 INFO - 'SHELL': '/bin/bash', 05:13:35 INFO - 'SHLVL': '1', 05:13:35 INFO - 'TERM': 'linux', 05:13:35 INFO - 'TMOUT': '86400', 05:13:35 INFO - 'USER': 'cltbld', 05:13:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:35 INFO - '_': '/tools/buildbot/bin/python'} 05:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:35 INFO - Running setup.py (path:/tmp/pip-ytkcXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:35 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)) 05:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:35 INFO - Running setup.py (path:/tmp/pip-Mw3Xf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:35 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)) 05:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:35 INFO - Running setup.py (path:/tmp/pip-jDiywF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:35 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)) 05:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:35 INFO - Running setup.py (path:/tmp/pip-4OZv_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:36 INFO - Running setup.py (path:/tmp/pip-v2LfFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:36 INFO - Running setup.py (path:/tmp/pip-loQhdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:36 INFO - Running setup.py (path:/tmp/pip-R0_M7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:36 INFO - Running setup.py (path:/tmp/pip-EfmryZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:36 INFO - Running setup.py (path:/tmp/pip-kDlM7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:36 INFO - Running setup.py (path:/tmp/pip-q_YOlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:36 INFO - Running setup.py (path:/tmp/pip-raxk1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:36 INFO - Running setup.py (path:/tmp/pip-kxJShP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:36 INFO - Running setup.py (path:/tmp/pip-sUghNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:36 INFO - Running setup.py (path:/tmp/pip-eHgL1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:36 INFO - Running setup.py (path:/tmp/pip-YpCDuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:36 INFO - Running setup.py (path:/tmp/pip-lst_gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:36 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)) 05:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:36 INFO - Running setup.py (path:/tmp/pip-P6c4cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:36 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)) 05:13:36 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)) 05:13:36 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)) 05:13:36 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)) 05:13:36 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)) 05:13:36 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)) 05:13:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:38 INFO - Downloading blessings-1.6.tar.gz 05:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:13:38 INFO - Installing collected packages: blessings 05:13:38 INFO - Running setup.py install for blessings 05:13:39 INFO - Successfully installed blessings 05:13:39 INFO - Cleaning up... 05:13:39 INFO - Return code: 0 05:13:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:39 INFO - Reading from file tmpfile_stdout 05:13:39 INFO - Current package versions: 05:13:39 INFO - argparse == 1.2.1 05:13:39 INFO - blessings == 1.6 05:13:39 INFO - blobuploader == 1.2.4 05:13:39 INFO - docopt == 0.6.1 05:13:39 INFO - functools32 == 3.2.3-2 05:13:39 INFO - jsonschema == 2.5.1 05:13:39 INFO - manifestparser == 1.1 05:13:39 INFO - mozInstall == 1.12 05:13:39 INFO - mozcrash == 0.17 05:13:39 INFO - mozdebug == 0.1 05:13:39 INFO - mozdevice == 0.48 05:13:39 INFO - mozfile == 1.2 05:13:39 INFO - mozhttpd == 0.7 05:13:39 INFO - mozinfo == 0.9 05:13:39 INFO - mozleak == 0.1 05:13:39 INFO - mozlog == 3.2 05:13:39 INFO - moznetwork == 0.27 05:13:39 INFO - mozprocess == 0.22 05:13:39 INFO - mozprofile == 0.28 05:13:39 INFO - mozrunner == 6.11 05:13:39 INFO - mozscreenshot == 0.1 05:13:39 INFO - mozsystemmonitor == 0.3 05:13:39 INFO - moztest == 0.7 05:13:39 INFO - mozversion == 1.4 05:13:39 INFO - psutil == 3.1.1 05:13:39 INFO - requests == 1.2.3 05:13:39 INFO - wsgiref == 0.1.2 05:13:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:39 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:39 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 05:13:39 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 05:13:39 INFO - Using env: {'DISPLAY': ':0', 05:13:39 INFO - 'HOME': '/home/cltbld', 05:13:39 INFO - 'LANG': 'en_US.UTF-8', 05:13:39 INFO - 'LANGUAGE': 'en_US:en', 05:13:39 INFO - 'LOGNAME': 'cltbld', 05:13:39 INFO - 'MAIL': '/var/mail/cltbld', 05:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:39 INFO - 'MOZ_NO_REMOTE': '1', 05:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:39 INFO - 'NO_EM_RESTART': '1', 05:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:39 INFO - 'PWD': '/builds/slave/test', 05:13:39 INFO - 'SHELL': '/bin/bash', 05:13:39 INFO - 'SHLVL': '1', 05:13:39 INFO - 'TERM': 'linux', 05:13:39 INFO - 'TMOUT': '86400', 05:13:39 INFO - 'USER': 'cltbld', 05:13:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:39 INFO - '_': '/tools/buildbot/bin/python'} 05:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 INFO - Cleaning up... 05:13:39 INFO - Return code: 0 05:13:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:39 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:39 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 05:13:39 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 05:13:39 INFO - Using env: {'DISPLAY': ':0', 05:13:39 INFO - 'HOME': '/home/cltbld', 05:13:39 INFO - 'LANG': 'en_US.UTF-8', 05:13:39 INFO - 'LANGUAGE': 'en_US:en', 05:13:39 INFO - 'LOGNAME': 'cltbld', 05:13:39 INFO - 'MAIL': '/var/mail/cltbld', 05:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:39 INFO - 'MOZ_NO_REMOTE': '1', 05:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:39 INFO - 'NO_EM_RESTART': '1', 05:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:39 INFO - 'PWD': '/builds/slave/test', 05:13:39 INFO - 'SHELL': '/bin/bash', 05:13:39 INFO - 'SHLVL': '1', 05:13:39 INFO - 'TERM': 'linux', 05:13:39 INFO - 'TMOUT': '86400', 05:13:39 INFO - 'USER': 'cltbld', 05:13:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:39 INFO - '_': '/tools/buildbot/bin/python'} 05:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:13:39 INFO - Cleaning up... 05:13:39 INFO - Return code: 0 05:13:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:39 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 0x7f09636faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', '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 05:13:39 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 05:13:39 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 05:13:39 INFO - Using env: {'DISPLAY': ':0', 05:13:39 INFO - 'HOME': '/home/cltbld', 05:13:39 INFO - 'LANG': 'en_US.UTF-8', 05:13:39 INFO - 'LANGUAGE': 'en_US:en', 05:13:39 INFO - 'LOGNAME': 'cltbld', 05:13:39 INFO - 'MAIL': '/var/mail/cltbld', 05:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:39 INFO - 'MOZ_NO_REMOTE': '1', 05:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:39 INFO - 'NO_EM_RESTART': '1', 05:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:39 INFO - 'PWD': '/builds/slave/test', 05:13:39 INFO - 'SHELL': '/bin/bash', 05:13:39 INFO - 'SHLVL': '1', 05:13:39 INFO - 'TERM': 'linux', 05:13:39 INFO - 'TMOUT': '86400', 05:13:39 INFO - 'USER': 'cltbld', 05:13:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:39 INFO - '_': '/tools/buildbot/bin/python'} 05:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:39 INFO - Downloading/unpacking flake8 05:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:13:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:13:41 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 05:13:41 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 05:13:41 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 05:13:41 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 05:13:41 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 05:13:41 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 05:13:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:13:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:13:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:42 INFO - no previously-included directories found matching 'docs/_build' 05:13:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:13:42 INFO - Running setup.py install for pep8 05:13:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:42 INFO - no previously-included directories found matching 'docs/_build' 05:13:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:13:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:13:42 INFO - Cleaning up... 05:13:42 INFO - Return code: 0 05:13:42 INFO - Running post-action listener: _resource_record_post_action 05:13:42 INFO - Running post-action listener: _start_resource_monitoring 05:13:42 INFO - Starting resource monitoring. 05:13:42 INFO - ##### 05:13:42 INFO - ##### Finished create-virtualenv step (success) 05:13:42 INFO - ##### 05:13:42 INFO - ##### 05:13:42 INFO - ##### Running install step. 05:13:42 INFO - ##### 05:13:42 INFO - Running pre-action listener: _resource_record_pre_action 05:13:42 INFO - Running main action method: install 05:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:43 INFO - Reading from file tmpfile_stdout 05:13:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:13:43 INFO - Reading from file tmpfile_stdout 05:13:43 INFO - Output received: 05:13:43 INFO - Usage: mozinstall [options] installer 05:13:43 INFO - Options: 05:13:43 INFO - -h, --help show this help message and exit 05:13:43 INFO - -d DEST, --destination=DEST 05:13:43 INFO - Directory to install application into. [default: 05:13:43 INFO - "/builds/slave/test"] 05:13:43 INFO - --app=APP Application being installed. [default: firefox] 05:13:43 INFO - mkdir: /builds/slave/test/build/application 05:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:13:59 INFO - Reading from file tmpfile_stdout 05:13:59 INFO - Output received: 05:13:59 INFO - /builds/slave/test/build/application/firefox/firefox 05:13:59 INFO - Running post-action listener: _resource_record_post_action 05:13:59 INFO - ##### 05:13:59 INFO - ##### Finished install step (success) 05:13:59 INFO - ##### 05:13:59 INFO - ##### 05:13:59 INFO - ##### Running run-tests step. 05:13:59 INFO - ##### 05:13:59 INFO - Running pre-action listener: _resource_record_pre_action 05:13:59 INFO - Running main action method: run_tests 05:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:13:59 INFO - Python 2.7.3 05:13:59 INFO - Return code: 0 05:13:59 INFO - grabbing minidump binary from tooltool 05:13: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')]} 05:13:59 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 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:13:59 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 05:13:59 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 05:13:59 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 05:13:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:13:59 INFO - Return code: 0 05:13:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:13:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:13:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:13:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:13:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:14:00 INFO - Return code: 0 05:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:14:00 INFO - Using env: {'DISPLAY': ':0', 05:14:00 INFO - 'HOME': '/home/cltbld', 05:14:00 INFO - 'LANG': 'en_US.UTF-8', 05:14:00 INFO - 'LANGUAGE': 'en_US:en', 05:14:00 INFO - 'LOGNAME': 'cltbld', 05:14:00 INFO - 'MAIL': '/var/mail/cltbld', 05:14:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:14:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:00 INFO - 'MOZ_NO_REMOTE': '1', 05:14:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:00 INFO - 'NO_EM_RESTART': '1', 05:14:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:00 INFO - 'PWD': '/builds/slave/test', 05:14:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:14:00 INFO - 'SHELL': '/bin/bash', 05:14:00 INFO - 'SHLVL': '1', 05:14:00 INFO - 'TERM': 'linux', 05:14:00 INFO - 'TMOUT': '86400', 05:14:00 INFO - 'USER': 'cltbld', 05:14:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161', 05:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:00 INFO - '_': '/tools/buildbot/bin/python'} 05:14:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:14:00 INFO - mozversion application_buildid: 20160621023402 05:14:00 INFO - mozversion application_changeset: 9f182283211dbebccb57bbc9f4c8b9f7be8b91a0 05:14:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:14:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:14:00 INFO - mozversion application_name: Firefox 05:14:00 INFO - mozversion application_remotingname: firefox-dev 05:14:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:14:00 INFO - mozversion application_vendor: Mozilla 05:14:00 INFO - mozversion application_version: 49.0a2 05:14:00 INFO - mozversion platform_buildid: 20160621023402 05:14:00 INFO - mozversion platform_changeset: 9f182283211dbebccb57bbc9f4c8b9f7be8b91a0 05:14:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:14:00 INFO - mozversion platform_version: 49.0a2 05:14:00 INFO - using testdate: 1466511240 05:14:00 INFO - actual date: 1466511240 05:14:00 INFO - starting webserver on 'localhost:34631' 05:14:00 INFO - SUITE-START | Running 2 tests 05:14:00 INFO - TEST-START | dromaeo_css 05:14:00 INFO - operating with platform_type : linux_ 05:14:00 INFO - Initialising browser for dromaeo_css test... 05:14:00 INFO - TEST-INFO | started process 23035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppXcUx2/profile http://localhost:34631/getInfo.html) 05:14:04 INFO - PROCESS | 23035 | __metrics Screen width/height:1600/1200 05:14:04 INFO - PROCESS | 23035 | colorDepth:24 05:14:04 INFO - PROCESS | 23035 | Browser inner width/height: 1024/697 05:14:04 INFO - PROCESS | 23035 | __metrics 05:14:05 ERROR - PROCESS | 23035 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:14:06 INFO - TEST-INFO | 23035: exit 0 05:14:06 INFO - Browser initialized. 05:14:06 INFO - Running cycle 1/1 for dromaeo_css test... 05:14:06 INFO - TEST-INFO | started process 23162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppXcUx2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:18 INFO - PROCESS | 23162 | RSS: Main: 155799552 05:14:18 INFO - PROCESS | 23162 | 05:15:07 INFO - PROCESS | 23162 | 1466511307595 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] 05:17:15 INFO - PROCESS | 23162 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34631/tests/dromaeo/cssquery-ext.html) 05:17:16 INFO - PROCESS | 23162 | RSS: Main: 159444992 05:17:16 INFO - PROCESS | 23162 | 05:20:18 INFO - PROCESS | 23162 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-ext.html (next: http://localhost:34631/tests/dromaeo/cssquery-jquery.html) 05:20:19 INFO - PROCESS | 23162 | RSS: Main: 158003200 05:20:19 INFO - PROCESS | 23162 | 05:23:21 INFO - PROCESS | 23162 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34631/tests/dromaeo/cssquery-mootools.html) 05:23:21 INFO - PROCESS | 23162 | RSS: Main: 157495296 05:23:21 INFO - PROCESS | 23162 | 05:26:23 INFO - PROCESS | 23162 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34631/tests/dromaeo/cssquery-prototype.html) 05:26:24 INFO - PROCESS | 23162 | RSS: Main: 156909568 05:26:24 INFO - PROCESS | 23162 | 05:29:26 INFO - PROCESS | 23162 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34631/tests/dromaeo/cssquery-yui.html) 05:29:27 INFO - PROCESS | 23162 | RSS: Main: 159600640 05:29:27 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | Cycle 1(1): loaded http://localhost:34631/tests/dromaeo/cssquery-yui.html (next: http://localhost:34631/tests/dromaeo/cssquery-dojo.html) 05:32:29 INFO - PROCESS | 23162 | RSS: Main: 158965760 05:32:29 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | __start_tp_report 05:32:29 INFO - PROCESS | 23162 | _x_x_mozilla_page_load 05:32:29 INFO - PROCESS | 23162 | _x_x_mozilla_page_load_details 05:32:29 INFO - PROCESS | 23162 | |i|pagename|runs| 05:32:29 INFO - PROCESS | 23162 | |0;dojo.html;3439.4324936385497;3481.321142377236;3498.405271103912;3499.842507087181;3523.964760352397;5708.229389032479;5730.885382292352;5773.451522105393;5821.56338274629;5835.620684655494;5803.854903627412;5829.009068458362;5834.941650583492;5846.21076154719;5865.824025279248;5240.187770895517;5266;5337.199420086979;5349.491798279177;5350.491703288181;5188.792448302082;5196.558292545138;5359.169328754049;5360.061989151903;5364.463553644643;5294.947050529503;5303.390110137326;5365.973170134144;5386.596005299599;5409.107497262947;5330.946690533103;5342.2253773202865;5429.647072940285;5432.320959880015;5433.538149257318;5292.153255479144;5294.7617357219015;5313.229581710669;5349.3874861473;5376.973115134439;5542.196381524696;5648.943510564883;5650;5678.630888992202;5712.1431785232135;6269.529785266123;6288.779892703779;6293.496520278367;6294.276158241815;6295.213098362705;6102.420270074336;6325.683715814237;6368.936310636927;6372.2671892732005;6378.043293505965;5869.148973398833;5869.559783016291;5876.794312199053;5878.794242201545;5899.469047785677;6419.2296924369375;6462.256840463313;6477.676116194171;6510.056041873901;6537.378948999933;6179.3202747697715;6181.289151747516;6225.533085018642;6269.216347956505;6297.118403423525;6341.746330146742;6342;6343.207099112611;6379.393957574023;6392.584482008655;6352.777652782131;6363.300036995926;6370;6389.52078594098;6395.744170233232;6031.909521357183;6231.657258850716;6244.2819075805955;6336.049592561153;6376;4820.662553621213;4823.614110871192;4836.903261934742;4855.1260773061185;4863.683860549053;4312.805923733439;4325.6106950374615;4348.456442944632;4351.26028575143;4365.497967733688;5799.3620701722775;5927.4665280125;5998.190244317048;6019.578629495981;6063.302720187146;6062.120992456069;6177.598456100339;6229.96885015572;6256.280527739277;6348.77779277723;6042.12389203563;6054.816738558284;6056.3035250946705;6076.27084749824;6079.240094988127;5227.876006658511;5367.919481207785;5387.595930305243;5398.703071331114;5410.8917821643345;6550.050242714875;6565.21217453899;6602.1747281589805;6617.602943823386;6618.7021584028835;6366.904496432465;6369.90445143314;6372.426481616677;6381.649009304533;6397.744090236339;6216.813495595139;6458.967705161444;6546.967265163834;6557.9344206557325;6581.835454113685;6265.404786545271;6275.466585340298;6297.590656607306;6309.842253943688;6318.399752023551;6416.743330266737;6419.037144428373;6421.486281097595;6431.163948686641;6435.806925792233;6003.459688628044;6094.360092190256;6122.632642041492;6141.117811340085;6174.969125154345;6153.784617538365;6191.907121393273;6201.286852012076;6204.3795620437595;6205.503559715122;5909.645421274738;6082.939170608414;6124.14262003311;6125.693715314305;6137.84655383619;6127.464420129145;6138.723757430837;6152.077188421773;6242.3133455320785;6258.655773932477;6057.7581595773645;6061.878762424815;6091.086337049478;6105.328413874381;6130.295016073031 05:32:29 INFO - PROCESS | 23162 | |1;ext.html;655.4821690864218;666.9628727329005;668.933106689331;684.254162962371;704.4892452971593;38554.807225963865;40193.397099043505;41649.37525937106;41816;42060.15879682404;42414;43062.138757224915;43151.13697726052;43223.567764322346;43246.78376608121;8667.306615470747;8888.60001299943;8889.68886088987;8895.599698013573;8895.733128006137;8751.95624021879;8842.159994800515;8868.423552469101;8915.955420222923;8926.062763409846;8873.778155546099;8950.597223124942;8952.239059679903;8964.731058068268;8967.865482017774;8900.732978010637;8940.73177804667;8945.821083578325;8966.551672416419;8972.685955991574;8788.384813063089;8852.291816654651;8873.06832782555;8882.777930551723;8888.466691998501;36791.81604091962;40437.393439098436;40659.593404065876;40688.79655601703;40723;3459.187091033605;3693.8707145249787;3750;3861.3242682530445;3893.552241492208;31437;32099.518507222412;32242.838785806154;32392.83803580967;33056.6694333056;4430.534793846664;4465.285554311295;4487.39420178275;4492.7528985905765;4587.380703605004;310824;312325;313581;314131.4293428541;315096;37535.436968445494;37723.434148487795;37844.24311513754;37933.43099853504;38007;38263.42604860929;40142.397864032064;40206.396904046465;40355;40395.39406908899;16816.159192040348;17063.402780902856;17066;17089.829101708823;17098.14509274531;14167.291635418187;14215.50245741394;14265;14273.357698903574;14304.141751494944;8972.8654070189;9086.727398178065;9146.314026448043;9168.81662366749;9191.218746406497;3474.305138972165;3523.207278362348;3564.4475106358555;3571.4464258040043;3595;1051.8527406163143;1056.6882769582992;1060.2260349944584;1177.840991466141;1190.975760845672;33147.66852331494;33962.66037339595;34237.14407139841;34372.82813585916;34458.82770586131;1111.4831603304501;1127.7180704823795;1157.427073598574;1265.7911444611536;1327.9468821247042;16447;16752.664946701;16793.91603041977;16942;16962.83037169637;804182.8954276072;818211;821572;826431;830562;63957.68021159864;64604;64717;64782.35217647763;65022.349776502575;1429.8713115819626;1447.9276036198148;1450.2096357485195;1453.2678564299051;1457.0820383158543;32444.51333229956;33917.15207119842;33977;34108.14729631779;34156.82921585376;54232.72883635556;54498.18252726133;54803.451965479835;54873;54936;532716;534979;535313;535534;537226.2554748962;30501.389972199988;30580.694193058676;30795.846020769754;30974;31065;50262.246066308304;50856.74571627118;51124.74437627937;51351.743241283555;52129.739351303004;43038.35442468428;43585.782071089445;44266.3360049606;44321.33517997297;44937.550624493335;43466.78266608647;44109;44386;44999.775001126094;45490.31764523601;42857;43495.130097398505;43830.12339753251;44111.77944110259;44312.77843610761;33507.329853402305;35856.4984059256;36340.454893176095;36347.63652363548;36422.8178859104;29882.85058574693;30209.09372718822;30546.694533054386;30579.541306879968;30667.846660766554 05:32:29 INFO - PROCESS | 23162 | |2;jquery.html;428.5478819845066;430.5758827554859;431.247473159337;436.5307294658241;440.5000324631544;18725.906370468147;19871.503212419677;20514.384568462952;20862.478438039056;20908.163673453044;19477.61044779107;19660;19865.503362415948;20012.399628011182;20196.596068078667;5536.640118392312;5764.991126552857;5795.82612521625;5799.478046975772;5815.185873977646;4301.075268817203;5785.103308987113;6118.1434599156155;6427.132337134473;6429.164208652868;6400.967995160041;6410.455111315544;6450.548461607689;6460.127882735841;6491.7078731457195;6284.8743025139465;6412.39082287182;6416.7754128605275;6473.061406096113;6497.805065848032;5570.972145139289;5721.856953576153;5722.427757224286;5725.370209276976;5735.311762588516;23925;24022.399440013964;24109.879450602635;24304;24511.264662060166;2335.486193037529;2415.649730789026;2522.533331333691;2524.3058159006237;3061.8315992620396;14946.551603451913;15103.773443398359;15336.309866056054;15445.227738613024;15521.146336951464;2036.4705176654177;2078.688196770481;2085.9061342239634;2124.808767210943;2135.092585651092;79858.60070699609;80266.59866700628;81160;82468;83776.58111709403;11035.282706624044;11113.944430277797;11224.719382015515;11284.943575282236;11363.431828408711;15497.922510387376;15533.533993980198;15562.144082075369;15602;15619.921900390425;8584;8587.613557389932;8658.437201581877;8707.735988642999;8956.596953136994;8353.33173346131;8357.707480238163;8395.916040839513;8461.873071903927;8510.148985101565;6795.320467953264;6898.827529311707;6981.755638552626;6997.230304666483;7034;1820.4993626752484;1924.4322924737237;2073.5541858500496;2079.0955934168687;2113.7569179544244;989.9703008909744;994.9403884862598;1036.8081904847627;1046.6807623674852;1148.9540418383172;12187.390630468619;12363.381830908418;12474.75050498985;12690.49238030487;12908.870911290955;448.26484565312916;478.6553681349423;480.2436163043221;497.477648469106;527.1381291588204;6355.872882542416;6739.528233023641;10889.109394711568;11968.222065565711;12054.578089766816;417814;425280;510405;517785;548810;94062.0593794067;105537;107713;110313.44843275732;110572.4471377638;496.15158079683425;512.7077565787465;517.056372120881;518.3753576939779;519.5531842615272;11130.721731956766;11513.36676482768;17047.48857534276;18221.817781822014;18396.448106556825;42608;42923.78538107289;43188;43829.68510944677;44911.10177796491;58178;58222;59923.700381499555;60163;61349.38650613437;9284.396514226553;9304.860427093463;9313.301502387483;9342.859857102285;9529.142377186086;10550.419726915094;11355.602553910574;14558.41766329335;14632.414703411745;14691.41234350614;11495.73546909856;11964.940175299067;12057.095717821374;12207.633770986884;12648.43082061291;12080.75838483243;12159.878401215874;12176.208546444454;12319.384030798603;12370.13409061357;11652;11798.469068892093;11946.880531194924;12366.44351004189;12436.564720234748;9279.72160835176;9348.345615806827;9437.669681561112;9459.810803783748;9515.857262141211;9278.164965153168;12395.132340736061;12568.937155314165;12607.936960315139;12776.936115319735 05:32:29 INFO - PROCESS | 23162 | |3;mootools.html;1564.0850102689926;1626.2925627352101;1821.8542516598666;1912.397594757652;1921.6829223178177;8633.827323453526;9373.531323433826;9405.576749046293;9918.603255869766;9959;9420.152186303232;9580.52097395131;9652.951735241313;9765.609375624985;9769.218462522998;2488.991958256904;2514.497100579882;2515.779846774313;2516.735742747013;2519.1812660885194;2451.681281433411;2513.761192686701;2550.4389034412493;2553.5658937980493;2555.629433732108;2514.4845306712173;2517.1315896015844;2567.3709941064467;2568.8073394495395;2572.0611976628584;2471.88876500557;2488.228649118779;2507.4232926427026;2507.636392723063;2516.7609077137736;2439.829211955164;2463.2610216935027;2472.357187131359;2476.5666008448447;2497.900083996638;9641.855372169422;9679.661211857621;9702.563384647709;9763.560639771227;9764.414135151843;5740.68426236561;5747.080467125282;5785.942140578582;5808.448197421239;5893.7053147342895;3771.9811400943095;3870.1872606752618;3884.864029758973;3949;4045.7167998240134;1214.4110106598293;1232.9136960412775;1242.0560374115646;1248.2759999200441;1250.8874201321835;14051.78922316166;14093.5067272646;14130.15219086858;14149.71700565983;14163.150210987375;5023.497650234947;5067.695938243717;5090.134677104901;5108.259302401131;5190.195519694454;11596.072314214842;11607.883921160848;11655.18413711032;11676.532938682527;11763.764724705457;5738.311402631711;5751.683657398799;5754.971225143848;5765.250517432707;5776.046952252831;4694.2723877799;5109.6678715883345;5236.554892834076;5246.816361427332;5375.220593013991;4402.25161722508;4413.514513403523;4426.778661066934;4452.265376212953;4464.687471877002;1368.4594585139014;1404.1575054967143;1411.2802470739791;1436.3823555871077;1438.9208593527246;950.2303134461108;997.586001809241;1040.328987802863;1092.3227598888582;1125.2067292558727;6582.868342633216;6733;6779.15260592426;6824.112865327575;6843.144606924135;487.4467479410823;488.49684824630685;490.9533594308535;500.83472454090065;501.2456253338702;4679.836205732783;4692;4756.7859446325;4768.499307572724;4773.260144677581;11875.703107422383;12422.192557483735;12448.25310481374;12466.127371083938;12538.874611253954;11685.240459370114;12073.698157546132;12129.939350303192;12412.441440135215;12423.378831058591;9145.77135571616;9283.62865485373;9292.67475638336;9295.163435290857;9305.069493050642;6606.306337834458;6808.489363297674;6847.897281540681;6892.758753443605;6956.40870526011;11316.717082073013;11350.148738844784;11429.085673145963;11570.94214528922;11640.185187036826;11729.237599556001;11777.764444710887;11873.643790686294;11876.109291802977;11973.700657483632;7967.760967170994;8554.57227138653;8680.609372578376;8739.300855931637;8910.064443233367;9666.661666841626;9676.75808104803;9707.514624268617;9735.756606084904;9754.561044752862;8567.657293708182;8773.868391974253;8774.956125219333;8841.734747957571;8863.113688631085;8531.360147988802;8563.058063613122;8585.18440748128;8707.738767836974;8785.253253473526;7293.307135822089;7345.485815992829;7383.556986580822;7427.628618568941;7428.405727541892;5804.506616937608;5934.317553481233;5986.191864098291;6090.817275481742;6138.662373569497;5789.694344067567;5927.407259274038;5935.732892019783;5981.491573216325;6010 05:32:29 INFO - PROCESS | 23162 | |4;prototype.html;321.5658860538273;327.52672388398764;350.2190116041228;357.4227622389841;361.1747157744554;5785.537157027438;5808.477237048664;5842.824715258544;5850.59045866789;5874.88250234995;5716.742746576404;5746.798862039829;5756.165356023374;5769.240381683585;5788.884222315552;4244.278472659656;4365.454318210223;4489.977550112245;4501.639868810504;4517.299818528133;4406.184855801671;4444.911101777962;4473.530279320673;4479.3504941783585;4533.093381323732;4473.642108631302;4508.864734057984;4521.412216411862;4531.456225252974;4538.500764915857;4342.934855977147;4405.493368262627;4416.542540961507;4432;4452.955470445287;3935.370340745467;3954.4463775071513;3957.6042395760483;3964.6630036446936;3992.7604343739467;5567.192757050246;5592.888142237173;5596.4403559644115;5606.55147588192;5612.270404847384;5069.214271787879;5130.281760553526;5144.176931690911;5160.122779127557;5161.81933632321;5976.820695379146;5979.760809567612;6030.728617212192;6036.607620504653;6111.205543279345;4347;4426.44669416323;4430.313301438282;4432.423784907974;4439.489458712257;6231.844203894939;6236.594621349643;6306.621602703853;6321.273053598849;6330.208723909512;4417.845375411909;4469.709468884512;4479.932801007987;4489.5959363656775;4525.637948964075;4098.856540021085;4548.727076375428;4573.679842410999;4576.885577860514;4593.839215627437;4949.381327334083;4991.226359914219;5016.44819069902;5017.397912250553;5024.673396229234;6036.788712395045;6080.726367313481;6087.9391206087375;6091.390860913962;6172.259328880563;1542.7994360733258;1544.4825983295723;1545.9304331305118;1564.296066769958;1572.52824152756;978.9118979291898;989.1641562879355;1017.8625885505362;1035.7980193862275;1055.767731099157;5830.504407125357;5834.445727655866;5853.858497593013;5870.26621672291;5891.7054147292465;6216.191895053614;6227.283862355887;6292.370762923671;6307.148534947723;6316.9368306317265;5667.271482197887;5966.522678185735;5988.760449582055;6023.216981792427;6033;3314.1548905029063;3332.9333413331597;3341.365140623274;3360.781549199294;3376.4597664374073;6303.432691057827;6454.870902582016;6526.184226971629;6553.180852393451;6596.703148358335;6362.777302794472;6372.872542549216;6396.168498095218;6410.743570257137;6419.074277716666;6163.8150855474405;6467.741290348427;6503;6539.149910511603;6598.43913267368;6292.206721084469;6363.522735794926;6372.936270637234;6390.169277993831;6400.199975003125;6026.7287972040485;6276.717547710273;6279.434850863444;6294.685265736786;6349.904751428639;6529.216494020748;6548.770793022221;6573.769918052845;6576.539642224999;6594.911839546421;4385.824567017284;4429.867103986886;4455.131249406335;4468.843590474317;4482.462104547475;6031.215941927697;6313.842153946188;6357.618542887441;6364.809055728336;6404.839879003062;6119.8776024478375;6136.355682653436;6137.140800287874;6138;6162.537809664383;6026.397360263939;6096.329403765671;6114.419130182626;6137.171481849893;6156.476699480594;5935.703214839327;6034.909476357946;6042.305134909541;6071.117953434449;6096.536831160578;6168.827922694673;6193.659348735863;6197.96901015492;6222.315545289924;6224.128621993015;5868.212599015434;5936.673482958478;5959.910601340896;6019.72911219005;6044.788432404845 05:32:29 INFO - PROCESS | 23162 | |5;yui.html;808.4462143431746;819.066264458517;908.3459908865616;910.0171814440405;925.9675911343104;14516.274186290697;15030.924845375772;15258.313375898084;15272.312745926418;15354;15823.683526329496;15881.52355429336;15905.125218112998;15912.761308580351;15970.84029159708;854.8546747053016;860.4407135362034;904.864270359448;908.2234689340618;908.8863892013499;871.5555066915887;873.4191762477944;873.462820365477;875.3434923807145;876.4390789894472;920.4109370003204;929.4794914847673;930.1489137439235;931.6226928094098;932.5756780664781;910.8679241509944;913.5934509143434;916.5325683901225;917.7155081924591;919.5540163020896;670.0518765946181;673.5756473421714;674.8414122681166;675.2774531251563;676.8713944350607;13772.793408098887;13789.862101378958;13812.37844297009;13816.861831381759;13827.861721382758;15620.687586248325;15665.29506172225;15864.920675396665;15987.360505579763;16103.516894493185;12173.513059477611;12461.875381246253;12541.059420543495;12638;13311.40098695561;4022.1352409231863;4046.6560342370935;4078.7552746835286;4085.632293093606;4196.790160491963;71204.28795712028;82093;82369.17630823675;82559.761603576;82704.58647706783;11982.700432489257;12201.633950981484;12238.938805306094;12248.693782655504;12333.62999110028;21928.232511862007;21986.230481933057;22019.22932697348;22054.33836984893;22100.447488812908;8817.559122043873;8880.689175878813;8946.418482798597;8975.640974361084;9054.86417703735;5226.3205783248695;5234.685918844882;5313.867153321198;5357.142857142916;5412.648177868426;3619.9819000905354;3707.6107008763693;3729.7202709796875;3732.570754363283;3734.458503516975;633.2685747961112;650.4926157597082;653.5817077070678;658.7990662847877;660.5607271164718;632.5098049012053;657.2737125476375;667.6161207305819;711.3562226185311;803.6968061268183;10466.510763326785;10847;10943;10969.83545246822;10990.17573681977;777.3703300326754;780.2899361580934;810.0401024785648;811.2252798577344;814.0597609760736;5117.411497677815;5132.615053870974;5328.760205790749;5378.085725426687;5474.863128421821;70430.64784676147;70938.64530677313;71561;84659.57670211732;115059.12352191095;65612.67193664;91240.08759912448;101174.49412752889;101749;103089.48455257676;92287.5385623081;92671;94334.52832735793;94476.52761736147;95938.52030739802;9767.658131965347;9796.265280103878;9810.264230182907;10354.171666266831;10393.688189354332;52682.73658631682;53123.73438132785;54135.18797217966;54319;55700.16449753338;74286;77030;77774;79934;80882;12629.670762013186;12725.61823145307;12839.101262911507;12950.870491294967;13040.152390094614;14353.712925741636;14381.280935952951;14381.352839122055;14602.269886505845;14674.55976320712;13174.275414852274;13539.661508461973;13596.320183990958;13646.86353136456;13692;12941.482340706267;13092.607221783363;13117.1473854203;13276.402561884932;13376.331183440983;13163.078584499377;13460;13460.865391345962;13948;15281.083135011935;11461.770764584828;11514.42427878586;11742.58900938463;12537.310447925453;12808.551700690432;12852.807207891701;13070.346482675637;13090.214587124803;13101.803472947722;13259.801102983656 05:32:29 INFO - PROCESS | 23162 | __end_tp_report 05:32:29 INFO - PROCESS | 23162 | __start_cc_report 05:32:29 INFO - PROCESS | 23162 | _x_x_mozilla_cycle_collect,336 05:32:29 INFO - PROCESS | 23162 | __end_cc_report 05:32:29 INFO - PROCESS | 23162 | __startTimestamp1466512349838__endTimestamp 05:32:29 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | ------- Summary: start ------- 05:32:29 INFO - PROCESS | 23162 | Number of tests: 6 05:32:29 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | [#0] dojo.html Cycles:165 Average:5853.62 Median:6091.09 stddev:666.65 (10.9%) stddev-sans-first:641.23 05:32:29 INFO - PROCESS | 23162 | Values: 3439.4 3481.3 3498.4 3499.8 3524.0 5708.2 5730.9 5773.5 5821.6 5835.6 5803.9 5829.0 5834.9 5846.2 5865.8 5240.2 5266.0 5337.2 5349.5 5350.5 5188.8 5196.6 5359.2 5360.1 5364.5 5294.9 5303.4 5366.0 5386.6 5409.1 5330.9 5342.2 5429.6 5432.3 5433.5 5292.2 5294.8 5313.2 5349.4 5377.0 5542.2 5648.9 5650.0 5678.6 5712.1 6269.5 6288.8 6293.5 6294.3 6295.2 6102.4 6325.7 6368.9 6372.3 6378.0 5869.1 5869.6 5876.8 5878.8 5899.5 6419.2 6462.3 6477.7 6510.1 6537.4 6179.3 6181.3 6225.5 6269.2 6297.1 6341.7 6342.0 6343.2 6379.4 6392.6 6352.8 6363.3 6370.0 6389.5 6395.7 6031.9 6231.7 6244.3 6336.0 6376.0 4820.7 4823.6 4836.9 4855.1 4863.7 4312.8 4325.6 4348.5 4351.3 4365.5 5799.4 5927.5 5998.2 6019.6 6063.3 6062.1 6177.6 6230.0 6256.3 6348.8 6042.1 6054.8 6056.3 6076.3 6079.2 5227.9 5367.9 5387.6 5398.7 5410.9 6550.1 6565.2 6602.2 6617.6 6618.7 6366.9 6369.9 6372.4 6381.6 6397.7 6216.8 6459.0 6547.0 6557.9 6581.8 6265.4 6275.5 6297.6 6309.8 6318.4 6416.7 6419.0 6421.5 6431.2 6435.8 6003.5 6094.4 6122.6 6141.1 6175.0 6153.8 6191.9 6201.3 6204.4 6205.5 5909.6 6082.9 6124.1 6125.7 6137.8 6127.5 6138.7 6152.1 6242.3 6258.7 6057.8 6061.9 6091.1 6105.3 6130.3 05:32:29 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | [#1] ext.html Cycles:180 Average:69091.63 Median:40705.90 stddev:160041.73 (393.2%) stddev-sans-first:160408.20 05:32:29 INFO - PROCESS | 23162 | Values: 655.5 667.0 668.9 684.3 704.5 38554.8 40193.4 41649.4 41816.0 42060.2 42414.0 43062.1 43151.1 43223.6 43246.8 8667.3 8888.6 8889.7 8895.6 8895.7 8752.0 8842.2 8868.4 8916.0 8926.1 8873.8 8950.6 8952.2 8964.7 8967.9 8900.7 8940.7 8945.8 8966.6 8972.7 8788.4 8852.3 8873.1 8882.8 8888.5 36791.8 40437.4 40659.6 40688.8 40723.0 3459.2 3693.9 3750.0 3861.3 3893.6 31437.0 32099.5 32242.8 32392.8 33056.7 4430.5 4465.3 4487.4 4492.8 4587.4 310824.0 312325.0 313581.0 314131.4 315096.0 37535.4 37723.4 37844.2 37933.4 38007.0 38263.4 40142.4 40206.4 40355.0 40395.4 16816.2 17063.4 17066.0 17089.8 17098.1 14167.3 14215.5 14265.0 14273.4 14304.1 8972.9 9086.7 9146.3 9168.8 9191.2 3474.3 3523.2 3564.4 3571.4 3595.0 1051.9 1056.7 1060.2 1177.8 1191.0 33147.7 33962.7 34237.1 34372.8 34458.8 1111.5 1127.7 1157.4 1265.8 1327.9 16447.0 16752.7 16793.9 16942.0 16962.8 804182.9 818211.0 821572.0 826431.0 830562.0 63957.7 64604.0 64717.0 64782.4 65022.3 1429.9 1447.9 1450.2 1453.3 1457.1 32444.5 33917.2 33977.0 34108.1 34156.8 54232.7 54498.2 54803.5 54873.0 54936.0 532716.0 534979.0 535313.0 535534.0 537226.3 30501.4 30580.7 30795.8 30974.0 31065.0 50262.2 50856.7 51124.7 51351.7 52129.7 43038.4 43585.8 44266.3 44321.3 44937.6 43466.8 44109.0 44386.0 44999.8 45490.3 42857.0 43495.1 43830.1 44111.8 44312.8 33507.3 35856.5 36340.5 36347.6 36422.8 29882.9 30209.1 30546.7 30579.5 30667.8 05:32:29 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | [#2] jquery.html Cycles:180 Average:29481.50 Median:233944.00 stddev:80650.09 (34.5%) stddev-sans-first:80846.83 05:32:29 INFO - PROCESS | 23162 | Values: 428.5 430.6 431.2 436.5 440.5 18725.9 19871.5 20514.4 20862.5 20908.2 19477.6 19660.0 19865.5 20012.4 20196.6 5536.6 5765.0 5795.8 5799.5 5815.2 4301.1 5785.1 6118.1 6427.1 6429.2 6401.0 6410.5 6450.5 6460.1 6491.7 6284.9 6412.4 6416.8 6473.1 6497.8 5571.0 5721.9 5722.4 5725.4 5735.3 23925.0 24022.4 24109.9 24304.0 24511.3 2335.5 2415.6 2522.5 2524.3 3061.8 14946.6 15103.8 15336.3 15445.2 15521.1 2036.5 2078.7 2085.9 2124.8 2135.1 79858.6 80266.6 81160.0 82468.0 83776.6 11035.3 11113.9 11224.7 11284.9 11363.4 15497.9 15533.5 15562.1 15602.0 15619.9 8584.0 8587.6 8658.4 8707.7 8956.6 8353.3 8357.7 8395.9 8461.9 8510.1 6795.3 6898.8 6981.8 6997.2 7034.0 1820.5 1924.4 2073.6 2079.1 2113.8 990.0 994.9 1036.8 1046.7 1149.0 12187.4 12363.4 12474.8 12690.5 12908.9 448.3 478.7 480.2 497.5 527.1 6355.9 6739.5 10889.1 11968.2 12054.6 417814.0 425280.0 510405.0 517785.0 548810.0 94062.1 105537.0 107713.0 110313.4 110572.4 496.2 512.7 517.1 518.4 519.6 11130.7 11513.4 17047.5 18221.8 18396.4 42608.0 42923.8 43188.0 43829.7 44911.1 58178.0 58222.0 59923.7 60163.0 61349.4 9284.4 9304.9 9313.3 9342.9 9529.1 10550.4 11355.6 14558.4 14632.4 14691.4 11495.7 11964.9 12057.1 12207.6 12648.4 12080.8 12159.9 12176.2 12319.4 12370.1 11652.0 11798.5 11946.9 12366.4 12436.6 9279.7 9348.3 9437.7 9459.8 9515.9 9278.2 12395.1 12568.9 12607.9 12776.9 05:32:29 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | [#3] mootools.html Cycles:180 Average:6487.67 Median:489.73 stddev:3764.68 (768.7%) stddev-sans-first:3757.06 05:32:29 INFO - PROCESS | 23162 | Values: 1564.1 1626.3 1821.9 1912.4 1921.7 8633.8 9373.5 9405.6 9918.6 9959.0 9420.2 9580.5 9653.0 9765.6 9769.2 2489.0 2514.5 2515.8 2516.7 2519.2 2451.7 2513.8 2550.4 2553.6 2555.6 2514.5 2517.1 2567.4 2568.8 2572.1 2471.9 2488.2 2507.4 2507.6 2516.8 2439.8 2463.3 2472.4 2476.6 2497.9 9641.9 9679.7 9702.6 9763.6 9764.4 5740.7 5747.1 5785.9 5808.4 5893.7 3772.0 3870.2 3884.9 3949.0 4045.7 1214.4 1232.9 1242.1 1248.3 1250.9 14051.8 14093.5 14130.2 14149.7 14163.2 5023.5 5067.7 5090.1 5108.3 5190.2 11596.1 11607.9 11655.2 11676.5 11763.8 5738.3 5751.7 5755.0 5765.3 5776.0 4694.3 5109.7 5236.6 5246.8 5375.2 4402.3 4413.5 4426.8 4452.3 4464.7 1368.5 1404.2 1411.3 1436.4 1438.9 950.2 997.6 1040.3 1092.3 1125.2 6582.9 6733.0 6779.2 6824.1 6843.1 487.4 488.5 491.0 500.8 501.2 4679.8 4692.0 4756.8 4768.5 4773.3 11875.7 12422.2 12448.3 12466.1 12538.9 11685.2 12073.7 12129.9 12412.4 12423.4 9145.8 9283.6 9292.7 9295.2 9305.1 6606.3 6808.5 6847.9 6892.8 6956.4 11316.7 11350.1 11429.1 11570.9 11640.2 11729.2 11777.8 11873.6 11876.1 11973.7 7967.8 8554.6 8680.6 8739.3 8910.1 9666.7 9676.8 9707.5 9735.8 9754.6 8567.7 8773.9 8775.0 8841.7 8863.1 8531.4 8563.1 8585.2 8707.7 8785.3 7293.3 7345.5 7383.6 7427.6 7428.4 5804.5 5934.3 5986.2 6090.8 6138.7 5789.7 5927.4 5935.7 5981.5 6010.0 05:32:29 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | [#4] prototype.html Cycles:180 Average:5135.72 Median:5861.04 stddev:1528.90 (26.1%) stddev-sans-first:1489.87 05:32:29 INFO - PROCESS | 23162 | Values: 321.6 327.5 350.2 357.4 361.2 5785.5 5808.5 5842.8 5850.6 5874.9 5716.7 5746.8 5756.2 5769.2 5788.9 4244.3 4365.5 4490.0 4501.6 4517.3 4406.2 4444.9 4473.5 4479.4 4533.1 4473.6 4508.9 4521.4 4531.5 4538.5 4342.9 4405.5 4416.5 4432.0 4453.0 3935.4 3954.4 3957.6 3964.7 3992.8 5567.2 5592.9 5596.4 5606.6 5612.3 5069.2 5130.3 5144.2 5160.1 5161.8 5976.8 5979.8 6030.7 6036.6 6111.2 4347.0 4426.4 4430.3 4432.4 4439.5 6231.8 6236.6 6306.6 6321.3 6330.2 4417.8 4469.7 4479.9 4489.6 4525.6 4098.9 4548.7 4573.7 4576.9 4593.8 4949.4 4991.2 5016.4 5017.4 5024.7 6036.8 6080.7 6087.9 6091.4 6172.3 1542.8 1544.5 1545.9 1564.3 1572.5 978.9 989.2 1017.9 1035.8 1055.8 5830.5 5834.4 5853.9 5870.3 5891.7 6216.2 6227.3 6292.4 6307.1 6316.9 5667.3 5966.5 5988.8 6023.2 6033.0 3314.2 3332.9 3341.4 3360.8 3376.5 6303.4 6454.9 6526.2 6553.2 6596.7 6362.8 6372.9 6396.2 6410.7 6419.1 6163.8 6467.7 6503.0 6539.1 6598.4 6292.2 6363.5 6372.9 6390.2 6400.2 6026.7 6276.7 6279.4 6294.7 6349.9 6529.2 6548.8 6573.8 6576.5 6594.9 4385.8 4429.9 4455.1 4468.8 4482.5 6031.2 6313.8 6357.6 6364.8 6404.8 6119.9 6136.4 6137.1 6138.0 6162.5 6026.4 6096.3 6114.4 6137.2 6156.5 5935.7 6034.9 6042.3 6071.1 6096.5 6168.8 6193.7 6198.0 6222.3 6224.1 5868.2 5936.7 5959.9 6019.7 6044.8 05:32:29 INFO - PROCESS | 23162 | 05:32:29 INFO - PROCESS | 23162 | [#5] yui.html Cycles:180 Average:20475.84 Median:4657.10 stddev:28167.74 (604.8%) stddev-sans-first:28208.05 05:32:29 INFO - PROCESS | 23162 | Values: 808.4 819.1 908.3 910.0 926.0 14516.3 15030.9 15258.3 15272.3 15354.0 15823.7 15881.5 15905.1 15912.8 15970.8 854.9 860.4 904.9 908.2 908.9 871.6 873.4 873.5 875.3 876.4 920.4 929.5 930.1 931.6 932.6 910.9 913.6 916.5 917.7 919.6 670.1 673.6 674.8 675.3 676.9 13772.8 13789.9 13812.4 13816.9 13827.9 15620.7 15665.3 15864.9 15987.4 16103.5 12173.5 12461.9 12541.1 12638.0 13311.4 4022.1 4046.7 4078.8 4085.6 4196.8 71204.3 82093.0 82369.2 82559.8 82704.6 11982.7 12201.6 12238.9 12248.7 12333.6 21928.2 21986.2 22019.2 22054.3 22100.4 8817.6 8880.7 8946.4 8975.6 9054.9 5226.3 5234.7 5313.9 5357.1 5412.6 3620.0 3707.6 3729.7 3732.6 3734.5 633.3 650.5 653.6 658.8 660.6 632.5 657.3 667.6 711.4 803.7 10466.5 10847.0 10943.0 10969.8 10990.2 777.4 780.3 810.0 811.2 814.1 5117.4 5132.6 5328.8 5378.1 5474.9 70430.6 70938.6 71561.0 84659.6 115059.1 65612.7 91240.1 101174.5 101749.0 103089.5 92287.5 92671.0 94334.5 94476.5 95938.5 9767.7 9796.3 9810.3 10354.2 10393.7 52682.7 53123.7 54135.2 54319.0 55700.2 74286.0 77030.0 77774.0 79934.0 80882.0 12629.7 12725.6 12839.1 12950.9 13040.2 14353.7 14381.3 14381.4 14602.3 14674.6 13174.3 13539.7 13596.3 13646.9 13692.0 12941.5 13092.6 13117.1 13276.4 13376.3 13163.1 13460.0 13460.9 13948.0 15281.1 11461.8 11514.4 11742.6 12537.3 12808.6 12852.8 13070.3 13090.2 13101.8 13259.8 05:32:29 INFO - PROCESS | 23162 | -------- Summary: end -------- 05:32:29 INFO - PROCESS | 23162 | 05:32:30 INFO - TEST-INFO | 23162: exit 0 05:32:30 INFO - TEST-OK | dromaeo_css | took 1110185ms 05:32:30 INFO - TEST-START | kraken 05:32:30 INFO - operating with platform_type : linux_ 05:32:30 INFO - Initialising browser for kraken test... 05:32:30 INFO - TEST-INFO | started process 23403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa4AshV/profile http://localhost:34631/getInfo.html) 05:32:35 INFO - PROCESS | 23403 | __metrics Screen width/height:1600/1200 05:32:35 INFO - PROCESS | 23403 | colorDepth:24 05:32:35 INFO - PROCESS | 23403 | Browser inner width/height: 1024/697 05:32:35 INFO - PROCESS | 23403 | __metrics 05:32:35 ERROR - PROCESS | 23403 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:32:36 INFO - TEST-INFO | 23403: exit 0 05:32:36 INFO - Browser initialized. 05:32:36 INFO - Running cycle 1/1 for kraken test... 05:32:36 INFO - TEST-INFO | started process 23531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa4AshV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:48 INFO - PROCESS | 23531 | RSS: Main: 156319744 05:32:48 INFO - PROCESS | 23531 | 05:32:50 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34631/tests/kraken/driver.html?testName=audio-beat-detection) 05:32:51 INFO - PROCESS | 23531 | RSS: Main: 161284096 05:32:51 INFO - PROCESS | 23531 | 05:32:54 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34631/tests/kraken/driver.html?testName=audio-dft) 05:32:54 INFO - PROCESS | 23531 | RSS: Main: 160686080 05:32:54 INFO - PROCESS | 23531 | 05:32:57 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34631/tests/kraken/driver.html?testName=audio-fft) 05:32:58 INFO - PROCESS | 23531 | RSS: Main: 161427456 05:32:58 INFO - PROCESS | 23531 | 05:33:00 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34631/tests/kraken/driver.html?testName=audio-oscillator) 05:33:01 INFO - PROCESS | 23531 | RSS: Main: 161357824 05:33:01 INFO - PROCESS | 23531 | 05:33:03 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34631/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:33:03 INFO - PROCESS | 23531 | RSS: Main: 161005568 05:33:03 INFO - PROCESS | 23531 | 05:33:07 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34631/tests/kraken/driver.html?testName=imaging-darkroom) 05:33:07 INFO - PROCESS | 23531 | RSS: Main: 161599488 05:33:07 INFO - PROCESS | 23531 | 05:33:11 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34631/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:11 INFO - PROCESS | 23531 | RSS: Main: 161611776 05:33:11 INFO - PROCESS | 23531 | 05:33:14 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34631/tests/kraken/driver.html?testName=json-parse-financial) 05:33:15 INFO - PROCESS | 23531 | RSS: Main: 160858112 05:33:15 INFO - PROCESS | 23531 | 05:33:16 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34631/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:17 INFO - PROCESS | 23531 | RSS: Main: 160391168 05:33:17 INFO - PROCESS | 23531 | 05:33:19 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:19 INFO - PROCESS | 23531 | RSS: Main: 161271808 05:33:19 INFO - PROCESS | 23531 | 05:33:21 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:22 INFO - PROCESS | 23531 | RSS: Main: 161808384 05:33:22 INFO - PROCESS | 23531 | 05:33:24 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:25 INFO - PROCESS | 23531 | RSS: Main: 161636352 05:33:25 INFO - PROCESS | 23531 | 05:33:28 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:33:28 INFO - PROCESS | 23531 | RSS: Main: 161611776 05:33:28 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | Cycle 1(1): loaded http://localhost:34631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34631/tests/kraken/driver.html?testName=ai-astar) 05:33:30 INFO - PROCESS | 23531 | RSS: Main: 162160640 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | __start_tp_report 05:33:30 INFO - PROCESS | 23531 | _x_x_mozilla_page_load 05:33:30 INFO - PROCESS | 23531 | _x_x_mozilla_page_load_details 05:33:30 INFO - PROCESS | 23531 | |i|pagename|runs| 05:33:30 INFO - PROCESS | 23531 | |0;ai-astar;113;105;113;112;112;113;111;110;111;113 05:33:30 INFO - PROCESS | 23531 | |1;audio-beat-detection;150;126;153;172;125;157;151;126;176;124 05:33:30 INFO - PROCESS | 23531 | |2;audio-dft;164;162;163;163;163;161;164;163;166;163 05:33:30 INFO - PROCESS | 23531 | |3;audio-fft;75;75;76;178;76;75;75;79;182;76 05:33:30 INFO - PROCESS | 23531 | |4;audio-oscillator;85;86;146;86;86;89;147;85;85;151 05:33:30 INFO - PROCESS | 23531 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;119 05:33:30 INFO - PROCESS | 23531 | |6;imaging-darkroom;147;154;147;146;147;149;147;147;146;146 05:33:30 INFO - PROCESS | 23531 | |7;imaging-desaturate;95;95;97;95;95;96;96;95;96;96 05:33:30 INFO - PROCESS | 23531 | |8;json-parse-financial;52;52;52;54;53;53;53;54;53;60 05:33:30 INFO - PROCESS | 23531 | |9;json-stringify-tinderbox;65;66;65;65;65;65;64;66;65;66 05:33:30 INFO - PROCESS | 23531 | |10;stanford-crypto-aes;81;82;76;78;79;77;77;78;105;78 05:33:30 INFO - PROCESS | 23531 | |11;stanford-crypto-ccm;128;118;120;119;118;125;134;130;132;121 05:33:30 INFO - PROCESS | 23531 | |12;stanford-crypto-pbkdf2;160;161;157;154;160;157;156;153;161;157 05:33:30 INFO - PROCESS | 23531 | |13;stanford-crypto-sha256-iterative;65;62;68;65;62;62;61;64;67;63 05:33:30 INFO - PROCESS | 23531 | __end_tp_report 05:33:30 INFO - PROCESS | 23531 | __start_cc_report 05:33:30 INFO - PROCESS | 23531 | _x_x_mozilla_cycle_collect,866 05:33:30 INFO - PROCESS | 23531 | __end_cc_report 05:33:30 INFO - PROCESS | 23531 | __startTimestamp1466512410746__endTimestamp 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | ------- Summary: start ------- 05:33:30 INFO - PROCESS | 23531 | Number of tests: 14 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:2.45 (2.2%) stddev-sans-first:2.52 05:33:30 INFO - PROCESS | 23531 | Values: 113.0 105.0 113.0 112.0 112.0 113.0 111.0 110.0 111.0 113.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:152.00 stddev:19.75 (13.0%) stddev-sans-first:20.90 05:33:30 INFO - PROCESS | 23531 | Values: 150.0 126.0 153.0 172.0 125.0 157.0 151.0 126.0 176.0 124.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 05:33:30 INFO - PROCESS | 23531 | Values: 164.0 162.0 163.0 163.0 163.0 161.0 164.0 163.0 166.0 163.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#3] audio-fft Cycles:10 Average:96.70 Median:75.50 stddev:43.93 (58.2%) stddev-sans-first:45.89 05:33:30 INFO - PROCESS | 23531 | Values: 75.0 75.0 76.0 178.0 76.0 75.0 75.0 79.0 182.0 76.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:85.50 stddev:30.00 (35.1%) stddev-sans-first:30.97 05:33:30 INFO - PROCESS | 23531 | Values: 85.0 86.0 146.0 86.0 86.0 89.0 147.0 85.0 85.0 151.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:33:30 INFO - PROCESS | 23531 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 119.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:2.41 (1.6%) stddev-sans-first:2.55 05:33:30 INFO - PROCESS | 23531 | Values: 147.0 154.0 147.0 146.0 147.0 149.0 147.0 147.0 146.0 146.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:33:30 INFO - PROCESS | 23531 | Values: 95.0 95.0 97.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:2.37 (4.5%) stddev-sans-first:2.44 05:33:30 INFO - PROCESS | 23531 | Values: 52.0 52.0 52.0 54.0 53.0 53.0 53.0 54.0 53.0 60.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 05:33:30 INFO - PROCESS | 23531 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 64.0 66.0 65.0 66.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:78.00 stddev:8.60 (11.0%) stddev-sans-first:9.12 05:33:30 INFO - PROCESS | 23531 | Values: 81.0 82.0 76.0 78.0 79.0 77.0 77.0 78.0 105.0 78.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.50 stddev:6.11 (4.8%) stddev-sans-first:6.35 05:33:30 INFO - PROCESS | 23531 | Values: 128.0 118.0 120.0 119.0 118.0 125.0 134.0 130.0 132.0 121.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:158.50 stddev:2.84 (1.8%) stddev-sans-first:2.87 05:33:30 INFO - PROCESS | 23531 | Values: 160.0 161.0 157.0 154.0 160.0 157.0 156.0 153.0 161.0 157.0 05:33:30 INFO - PROCESS | 23531 | 05:33:30 INFO - PROCESS | 23531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:2.33 (3.6%) stddev-sans-first:2.44 05:33:30 INFO - PROCESS | 23531 | Values: 65.0 62.0 68.0 65.0 62.0 62.0 61.0 64.0 67.0 63.0 05:33:30 INFO - PROCESS | 23531 | -------- Summary: end -------- 05:33:30 INFO - PROCESS | 23531 | 05:33:31 INFO - TEST-INFO | 23531: exit 0 05:33:31 INFO - TEST-OK | kraken | took 61184ms 05:33:31 INFO - SUITE-END | took 1171s 05:33:31 INFO - Completed test suite (00:19:31) 05:33:31 INFO - javascript benchmark 05:33:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7626.051397056634, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3439.4324936385497, 3481.321142377236, 3498.405271103912, 3499.842507087181, 3523.964760352397, 5708.229389032479, 5730.885382292352, 5773.451522105393, 5821.56338274629, 5835.620684655494, 5803.854903627412, 5829.009068458362, 5834.941650583492, 5846.21076154719, 5865.824025279248, 5240.187770895517, 5266.0, 5337.199420086979, 5349.491798279177, 5350.491703288181, 5188.792448302082, 5196.558292545138, 5359.169328754049, 5360.061989151903, 5364.463553644643, 5294.947050529503, 5303.390110137326, 5365.973170134144, 5386.596005299599, 5409.107497262947, 5330.946690533103, 5342.2253773202865, 5429.647072940285, 5432.320959880015, 5433.538149257318, 5292.153255479144, 5294.7617357219015, 5313.229581710669, 5349.3874861473, 5376.973115134439, 5542.196381524696, 5648.943510564883, 5650.0, 5678.630888992202, 5712.1431785232135, 6269.529785266123, 6288.779892703779, 6293.496520278367, 6294.276158241815, 6295.213098362705, 6102.420270074336, 6325.683715814237, 6368.936310636927, 6372.2671892732005, 6378.043293505965, 5869.148973398833, 5869.559783016291, 5876.794312199053, 5878.794242201545, 5899.469047785677, 6419.2296924369375, 6462.256840463313, 6477.676116194171, 6510.056041873901, 6537.378948999933, 6179.3202747697715, 6181.289151747516, 6225.533085018642, 6269.216347956505, 6297.118403423525, 6341.746330146742, 6342.0, 6343.207099112611, 6379.393957574023, 6392.584482008655, 6352.777652782131, 6363.300036995926, 6370.0, 6389.52078594098, 6395.744170233232, 6031.909521357183, 6231.657258850716, 6244.2819075805955, 6336.049592561153, 6376.0, 4820.662553621213, 4823.614110871192, 4836.903261934742, 4855.1260773061185, 4863.683860549053, 4312.805923733439, 4325.6106950374615, 4348.456442944632, 4351.26028575143, 4365.497967733688, 5799.3620701722775, 5927.4665280125, 5998.190244317048, 6019.578629495981, 6063.302720187146, 6062.120992456069, 6177.598456100339, 6229.96885015572, 6256.280527739277, 6348.77779277723, 6042.12389203563, 6054.816738558284, 6056.3035250946705, 6076.27084749824, 6079.240094988127, 5227.876006658511, 5367.919481207785, 5387.595930305243, 5398.703071331114, 5410.8917821643345, 6550.050242714875, 6565.21217453899, 6602.1747281589805, 6617.602943823386, 6618.7021584028835, 6366.904496432465, 6369.90445143314, 6372.426481616677, 6381.649009304533, 6397.744090236339, 6216.813495595139, 6458.967705161444, 6546.967265163834, 6557.9344206557325, 6581.835454113685, 6265.404786545271, 6275.466585340298, 6297.590656607306, 6309.842253943688, 6318.399752023551, 6416.743330266737, 6419.037144428373, 6421.486281097595, 6431.163948686641, 6435.806925792233, 6003.459688628044, 6094.360092190256, 6122.632642041492, 6141.117811340085, 6174.969125154345, 6153.784617538365, 6191.907121393273, 6201.286852012076, 6204.3795620437595, 6205.503559715122, 5909.645421274738, 6082.939170608414, 6124.14262003311, 6125.693715314305, 6137.84655383619, 6127.464420129145, 6138.723757430837, 6152.077188421773, 6242.3133455320785, 6258.655773932477, 6057.7581595773645, 6061.878762424815, 6091.086337049478, 6105.328413874381, 6130.295016073031], "value": 5809.353559823516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.4821690864218, 666.9628727329005, 668.933106689331, 684.254162962371, 704.4892452971593, 38554.807225963865, 40193.397099043505, 41649.37525937106, 41816.0, 42060.15879682404, 42414.0, 43062.138757224915, 43151.13697726052, 43223.567764322346, 43246.78376608121, 8667.306615470747, 8888.60001299943, 8889.68886088987, 8895.599698013573, 8895.733128006137, 8751.95624021879, 8842.159994800515, 8868.423552469101, 8915.955420222923, 8926.062763409846, 8873.778155546099, 8950.597223124942, 8952.239059679903, 8964.731058068268, 8967.865482017774, 8900.732978010637, 8940.73177804667, 8945.821083578325, 8966.551672416419, 8972.685955991574, 8788.384813063089, 8852.291816654651, 8873.06832782555, 8882.777930551723, 8888.466691998501, 36791.81604091962, 40437.393439098436, 40659.593404065876, 40688.79655601703, 40723.0, 3459.187091033605, 3693.8707145249787, 3750.0, 3861.3242682530445, 3893.552241492208, 31437.0, 32099.518507222412, 32242.838785806154, 32392.83803580967, 33056.6694333056, 4430.534793846664, 4465.285554311295, 4487.39420178275, 4492.7528985905765, 4587.380703605004, 310824.0, 312325.0, 313581.0, 314131.4293428541, 315096.0, 37535.436968445494, 37723.434148487795, 37844.24311513754, 37933.43099853504, 38007.0, 38263.42604860929, 40142.397864032064, 40206.396904046465, 40355.0, 40395.39406908899, 16816.159192040348, 17063.402780902856, 17066.0, 17089.829101708823, 17098.14509274531, 14167.291635418187, 14215.50245741394, 14265.0, 14273.357698903574, 14304.141751494944, 8972.8654070189, 9086.727398178065, 9146.314026448043, 9168.81662366749, 9191.218746406497, 3474.305138972165, 3523.207278362348, 3564.4475106358555, 3571.4464258040043, 3595.0, 1051.8527406163143, 1056.6882769582992, 1060.2260349944584, 1177.840991466141, 1190.975760845672, 33147.66852331494, 33962.66037339595, 34237.14407139841, 34372.82813585916, 34458.82770586131, 1111.4831603304501, 1127.7180704823795, 1157.427073598574, 1265.7911444611536, 1327.9468821247042, 16447.0, 16752.664946701, 16793.91603041977, 16942.0, 16962.83037169637, 804182.8954276072, 818211.0, 821572.0, 826431.0, 830562.0, 63957.68021159864, 64604.0, 64717.0, 64782.35217647763, 65022.349776502575, 1429.8713115819626, 1447.9276036198148, 1450.2096357485195, 1453.2678564299051, 1457.0820383158543, 32444.51333229956, 33917.15207119842, 33977.0, 34108.14729631779, 34156.82921585376, 54232.72883635556, 54498.18252726133, 54803.451965479835, 54873.0, 54936.0, 532716.0, 534979.0, 535313.0, 535534.0, 537226.2554748962, 30501.389972199988, 30580.694193058676, 30795.846020769754, 30974.0, 31065.0, 50262.246066308304, 50856.74571627118, 51124.74437627937, 51351.743241283555, 52129.739351303004, 43038.35442468428, 43585.782071089445, 44266.3360049606, 44321.33517997297, 44937.550624493335, 43466.78266608647, 44109.0, 44386.0, 44999.775001126094, 45490.31764523601, 42857.0, 43495.130097398505, 43830.12339753251, 44111.77944110259, 44312.77843610761, 33507.329853402305, 35856.4984059256, 36340.454893176095, 36347.63652363548, 36422.8178859104, 29882.85058574693, 30209.09372718822, 30546.694533054386, 30579.541306879968, 30667.846660766554], "value": 19757.69389629879, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.5478819845066, 430.5758827554859, 431.247473159337, 436.5307294658241, 440.5000324631544, 18725.906370468147, 19871.503212419677, 20514.384568462952, 20862.478438039056, 20908.163673453044, 19477.61044779107, 19660.0, 19865.503362415948, 20012.399628011182, 20196.596068078667, 5536.640118392312, 5764.991126552857, 5795.82612521625, 5799.478046975772, 5815.185873977646, 4301.075268817203, 5785.103308987113, 6118.1434599156155, 6427.132337134473, 6429.164208652868, 6400.967995160041, 6410.455111315544, 6450.548461607689, 6460.127882735841, 6491.7078731457195, 6284.8743025139465, 6412.39082287182, 6416.7754128605275, 6473.061406096113, 6497.805065848032, 5570.972145139289, 5721.856953576153, 5722.427757224286, 5725.370209276976, 5735.311762588516, 23925.0, 24022.399440013964, 24109.879450602635, 24304.0, 24511.264662060166, 2335.486193037529, 2415.649730789026, 2522.533331333691, 2524.3058159006237, 3061.8315992620396, 14946.551603451913, 15103.773443398359, 15336.309866056054, 15445.227738613024, 15521.146336951464, 2036.4705176654177, 2078.688196770481, 2085.9061342239634, 2124.808767210943, 2135.092585651092, 79858.60070699609, 80266.59866700628, 81160.0, 82468.0, 83776.58111709403, 11035.282706624044, 11113.944430277797, 11224.719382015515, 11284.943575282236, 11363.431828408711, 15497.922510387376, 15533.533993980198, 15562.144082075369, 15602.0, 15619.921900390425, 8584.0, 8587.613557389932, 8658.437201581877, 8707.735988642999, 8956.596953136994, 8353.33173346131, 8357.707480238163, 8395.916040839513, 8461.873071903927, 8510.148985101565, 6795.320467953264, 6898.827529311707, 6981.755638552626, 6997.230304666483, 7034.0, 1820.4993626752484, 1924.4322924737237, 2073.5541858500496, 2079.0955934168687, 2113.7569179544244, 989.9703008909744, 994.9403884862598, 1036.8081904847627, 1046.6807623674852, 1148.9540418383172, 12187.390630468619, 12363.381830908418, 12474.75050498985, 12690.49238030487, 12908.870911290955, 448.26484565312916, 478.6553681349423, 480.2436163043221, 497.477648469106, 527.1381291588204, 6355.872882542416, 6739.528233023641, 10889.109394711568, 11968.222065565711, 12054.578089766816, 417814.0, 425280.0, 510405.0, 517785.0, 548810.0, 94062.0593794067, 105537.0, 107713.0, 110313.44843275732, 110572.4471377638, 496.15158079683425, 512.7077565787465, 517.056372120881, 518.3753576939779, 519.5531842615272, 11130.721731956766, 11513.36676482768, 17047.48857534276, 18221.817781822014, 18396.448106556825, 42608.0, 42923.78538107289, 43188.0, 43829.68510944677, 44911.10177796491, 58178.0, 58222.0, 59923.700381499555, 60163.0, 61349.38650613437, 9284.396514226553, 9304.860427093463, 9313.301502387483, 9342.859857102285, 9529.142377186086, 10550.419726915094, 11355.602553910574, 14558.41766329335, 14632.414703411745, 14691.41234350614, 11495.73546909856, 11964.940175299067, 12057.095717821374, 12207.633770986884, 12648.43082061291, 12080.75838483243, 12159.878401215874, 12176.208546444454, 12319.384030798603, 12370.13409061357, 11652.0, 11798.469068892093, 11946.880531194924, 12366.44351004189, 12436.564720234748, 9279.72160835176, 9348.345615806827, 9437.669681561112, 9459.810803783748, 9515.857262141211, 9278.164965153168, 12395.132340736061, 12568.937155314165, 12607.936960315139, 12776.936115319735], "value": 9253.606658877985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1564.0850102689926, 1626.2925627352101, 1821.8542516598666, 1912.397594757652, 1921.6829223178177, 8633.827323453526, 9373.531323433826, 9405.576749046293, 9918.603255869766, 9959.0, 9420.152186303232, 9580.52097395131, 9652.951735241313, 9765.609375624985, 9769.218462522998, 2488.991958256904, 2514.497100579882, 2515.779846774313, 2516.735742747013, 2519.1812660885194, 2451.681281433411, 2513.761192686701, 2550.4389034412493, 2553.5658937980493, 2555.629433732108, 2514.4845306712173, 2517.1315896015844, 2567.3709941064467, 2568.8073394495395, 2572.0611976628584, 2471.88876500557, 2488.228649118779, 2507.4232926427026, 2507.636392723063, 2516.7609077137736, 2439.829211955164, 2463.2610216935027, 2472.357187131359, 2476.5666008448447, 2497.900083996638, 9641.855372169422, 9679.661211857621, 9702.563384647709, 9763.560639771227, 9764.414135151843, 5740.68426236561, 5747.080467125282, 5785.942140578582, 5808.448197421239, 5893.7053147342895, 3771.9811400943095, 3870.1872606752618, 3884.864029758973, 3949.0, 4045.7167998240134, 1214.4110106598293, 1232.9136960412775, 1242.0560374115646, 1248.2759999200441, 1250.8874201321835, 14051.78922316166, 14093.5067272646, 14130.15219086858, 14149.71700565983, 14163.150210987375, 5023.497650234947, 5067.695938243717, 5090.134677104901, 5108.259302401131, 5190.195519694454, 11596.072314214842, 11607.883921160848, 11655.18413711032, 11676.532938682527, 11763.764724705457, 5738.311402631711, 5751.683657398799, 5754.971225143848, 5765.250517432707, 5776.046952252831, 4694.2723877799, 5109.6678715883345, 5236.554892834076, 5246.816361427332, 5375.220593013991, 4402.25161722508, 4413.514513403523, 4426.778661066934, 4452.265376212953, 4464.687471877002, 1368.4594585139014, 1404.1575054967143, 1411.2802470739791, 1436.3823555871077, 1438.9208593527246, 950.2303134461108, 997.586001809241, 1040.328987802863, 1092.3227598888582, 1125.2067292558727, 6582.868342633216, 6733.0, 6779.15260592426, 6824.112865327575, 6843.144606924135, 487.4467479410823, 488.49684824630685, 490.9533594308535, 500.83472454090065, 501.2456253338702, 4679.836205732783, 4692.0, 4756.7859446325, 4768.499307572724, 4773.260144677581, 11875.703107422383, 12422.192557483735, 12448.25310481374, 12466.127371083938, 12538.874611253954, 11685.240459370114, 12073.698157546132, 12129.939350303192, 12412.441440135215, 12423.378831058591, 9145.77135571616, 9283.62865485373, 9292.67475638336, 9295.163435290857, 9305.069493050642, 6606.306337834458, 6808.489363297674, 6847.897281540681, 6892.758753443605, 6956.40870526011, 11316.717082073013, 11350.148738844784, 11429.085673145963, 11570.94214528922, 11640.185187036826, 11729.237599556001, 11777.764444710887, 11873.643790686294, 11876.109291802977, 11973.700657483632, 7967.760967170994, 8554.57227138653, 8680.609372578376, 8739.300855931637, 8910.064443233367, 9666.661666841626, 9676.75808104803, 9707.514624268617, 9735.756606084904, 9754.561044752862, 8567.657293708182, 8773.868391974253, 8774.956125219333, 8841.734747957571, 8863.113688631085, 8531.360147988802, 8563.058063613122, 8585.18440748128, 8707.738767836974, 8785.253253473526, 7293.307135822089, 7345.485815992829, 7383.556986580822, 7427.628618568941, 7428.405727541892, 5804.506616937608, 5934.317553481233, 5986.191864098291, 6090.817275481742, 6138.662373569497, 5789.694344067567, 5927.407259274038, 5935.732892019783, 5981.491573216325, 6010.0], "value": 5068.476804360393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.5658860538273, 327.52672388398764, 350.2190116041228, 357.4227622389841, 361.1747157744554, 5785.537157027438, 5808.477237048664, 5842.824715258544, 5850.59045866789, 5874.88250234995, 5716.742746576404, 5746.798862039829, 5756.165356023374, 5769.240381683585, 5788.884222315552, 4244.278472659656, 4365.454318210223, 4489.977550112245, 4501.639868810504, 4517.299818528133, 4406.184855801671, 4444.911101777962, 4473.530279320673, 4479.3504941783585, 4533.093381323732, 4473.642108631302, 4508.864734057984, 4521.412216411862, 4531.456225252974, 4538.500764915857, 4342.934855977147, 4405.493368262627, 4416.542540961507, 4432.0, 4452.955470445287, 3935.370340745467, 3954.4463775071513, 3957.6042395760483, 3964.6630036446936, 3992.7604343739467, 5567.192757050246, 5592.888142237173, 5596.4403559644115, 5606.55147588192, 5612.270404847384, 5069.214271787879, 5130.281760553526, 5144.176931690911, 5160.122779127557, 5161.81933632321, 5976.820695379146, 5979.760809567612, 6030.728617212192, 6036.607620504653, 6111.205543279345, 4347.0, 4426.44669416323, 4430.313301438282, 4432.423784907974, 4439.489458712257, 6231.844203894939, 6236.594621349643, 6306.621602703853, 6321.273053598849, 6330.208723909512, 4417.845375411909, 4469.709468884512, 4479.932801007987, 4489.5959363656775, 4525.637948964075, 4098.856540021085, 4548.727076375428, 4573.679842410999, 4576.885577860514, 4593.839215627437, 4949.381327334083, 4991.226359914219, 5016.44819069902, 5017.397912250553, 5024.673396229234, 6036.788712395045, 6080.726367313481, 6087.9391206087375, 6091.390860913962, 6172.259328880563, 1542.7994360733258, 1544.4825983295723, 1545.9304331305118, 1564.296066769958, 1572.52824152756, 978.9118979291898, 989.1641562879355, 1017.8625885505362, 1035.7980193862275, 1055.767731099157, 5830.504407125357, 5834.445727655866, 5853.858497593013, 5870.26621672291, 5891.7054147292465, 6216.191895053614, 6227.283862355887, 6292.370762923671, 6307.148534947723, 6316.9368306317265, 5667.271482197887, 5966.522678185735, 5988.760449582055, 6023.216981792427, 6033.0, 3314.1548905029063, 3332.9333413331597, 3341.365140623274, 3360.781549199294, 3376.4597664374073, 6303.432691057827, 6454.870902582016, 6526.184226971629, 6553.180852393451, 6596.703148358335, 6362.777302794472, 6372.872542549216, 6396.168498095218, 6410.743570257137, 6419.074277716666, 6163.8150855474405, 6467.741290348427, 6503.0, 6539.149910511603, 6598.43913267368, 6292.206721084469, 6363.522735794926, 6372.936270637234, 6390.169277993831, 6400.199975003125, 6026.7287972040485, 6276.717547710273, 6279.434850863444, 6294.685265736786, 6349.904751428639, 6529.216494020748, 6548.770793022221, 6573.769918052845, 6576.539642224999, 6594.911839546421, 4385.824567017284, 4429.867103986886, 4455.131249406335, 4468.843590474317, 4482.462104547475, 6031.215941927697, 6313.842153946188, 6357.618542887441, 6364.809055728336, 6404.839879003062, 6119.8776024478375, 6136.355682653436, 6137.140800287874, 6138.0, 6162.537809664383, 6026.397360263939, 6096.329403765671, 6114.419130182626, 6137.171481849893, 6156.476699480594, 5935.703214839327, 6034.909476357946, 6042.305134909541, 6071.117953434449, 6096.536831160578, 6168.827922694673, 6193.659348735863, 6197.96901015492, 6222.315545289924, 6224.128621993015, 5868.212599015434, 5936.673482958478, 5959.910601340896, 6019.72911219005, 6044.788432404845], "value": 4641.016584660193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.4462143431746, 819.066264458517, 908.3459908865616, 910.0171814440405, 925.9675911343104, 14516.274186290697, 15030.924845375772, 15258.313375898084, 15272.312745926418, 15354.0, 15823.683526329496, 15881.52355429336, 15905.125218112998, 15912.761308580351, 15970.84029159708, 854.8546747053016, 860.4407135362034, 904.864270359448, 908.2234689340618, 908.8863892013499, 871.5555066915887, 873.4191762477944, 873.462820365477, 875.3434923807145, 876.4390789894472, 920.4109370003204, 929.4794914847673, 930.1489137439235, 931.6226928094098, 932.5756780664781, 910.8679241509944, 913.5934509143434, 916.5325683901225, 917.7155081924591, 919.5540163020896, 670.0518765946181, 673.5756473421714, 674.8414122681166, 675.2774531251563, 676.8713944350607, 13772.793408098887, 13789.862101378958, 13812.37844297009, 13816.861831381759, 13827.861721382758, 15620.687586248325, 15665.29506172225, 15864.920675396665, 15987.360505579763, 16103.516894493185, 12173.513059477611, 12461.875381246253, 12541.059420543495, 12638.0, 13311.40098695561, 4022.1352409231863, 4046.6560342370935, 4078.7552746835286, 4085.632293093606, 4196.790160491963, 71204.28795712028, 82093.0, 82369.17630823675, 82559.761603576, 82704.58647706783, 11982.700432489257, 12201.633950981484, 12238.938805306094, 12248.693782655504, 12333.62999110028, 21928.232511862007, 21986.230481933057, 22019.22932697348, 22054.33836984893, 22100.447488812908, 8817.559122043873, 8880.689175878813, 8946.418482798597, 8975.640974361084, 9054.86417703735, 5226.3205783248695, 5234.685918844882, 5313.867153321198, 5357.142857142916, 5412.648177868426, 3619.9819000905354, 3707.6107008763693, 3729.7202709796875, 3732.570754363283, 3734.458503516975, 633.2685747961112, 650.4926157597082, 653.5817077070678, 658.7990662847877, 660.5607271164718, 632.5098049012053, 657.2737125476375, 667.6161207305819, 711.3562226185311, 803.6968061268183, 10466.510763326785, 10847.0, 10943.0, 10969.83545246822, 10990.17573681977, 777.3703300326754, 780.2899361580934, 810.0401024785648, 811.2252798577344, 814.0597609760736, 5117.411497677815, 5132.615053870974, 5328.760205790749, 5378.085725426687, 5474.863128421821, 70430.64784676147, 70938.64530677313, 71561.0, 84659.57670211732, 115059.12352191095, 65612.67193664, 91240.08759912448, 101174.49412752889, 101749.0, 103089.48455257676, 92287.5385623081, 92671.0, 94334.52832735793, 94476.52761736147, 95938.52030739802, 9767.658131965347, 9796.265280103878, 9810.264230182907, 10354.171666266831, 10393.688189354332, 52682.73658631682, 53123.73438132785, 54135.18797217966, 54319.0, 55700.16449753338, 74286.0, 77030.0, 77774.0, 79934.0, 80882.0, 12629.670762013186, 12725.61823145307, 12839.101262911507, 12950.870491294967, 13040.152390094614, 14353.712925741636, 14381.280935952951, 14381.352839122055, 14602.269886505845, 14674.55976320712, 13174.275414852274, 13539.661508461973, 13596.320183990958, 13646.86353136456, 13692.0, 12941.482340706267, 13092.607221783363, 13117.1473854203, 13276.402561884932, 13376.331183440983, 13163.078584499377, 13460.0, 13460.865391345962, 13948.0, 15281.083135011935, 11461.770764584828, 11514.42427878586, 11742.58900938463, 12537.310447925453, 12808.551700690432, 12852.807207891701, 13070.346482675637, 13090.214587124803, 13101.803472947722, 13259.801102983656], "value": 7872.203048021274, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 113.0, 112.0, 112.0, 113.0, 111.0, 110.0, 111.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 153.0, 172.0, 125.0, 157.0, 151.0, 126.0, 176.0, 124.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 163.0, 163.0, 161.0, 164.0, 163.0, 166.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 178.0, 76.0, 75.0, 75.0, 79.0, 182.0, 76.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 146.0, 86.0, 86.0, 89.0, 147.0, 85.0, 85.0, 151.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 154.0, 147.0, 146.0, 147.0, 149.0, 147.0, 147.0, 146.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 54.0, 53.0, 53.0, 53.0, 54.0, 53.0, 60.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 76.0, 78.0, 79.0, 77.0, 77.0, 78.0, 105.0, 78.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 118.0, 120.0, 119.0, 118.0, 125.0, 134.0, 130.0, 132.0, 121.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 157.0, 154.0, 160.0, 157.0, 156.0, 153.0, 161.0, 157.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 68.0, 65.0, 62.0, 62.0, 61.0, 64.0, 67.0, 63.0], "value": 63.9, "unit": "score"}]}]} 05:33:31 INFO - Return code: 0 05:33:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:33:32 ERROR - # TBPL SUCCESS # 05:33:32 INFO - Running post-action listener: _resource_record_post_action 05:33:32 INFO - ##### 05:33:32 INFO - ##### Finished run-tests step (success) 05:33:32 INFO - ##### 05:33:32 INFO - Running post-run listener: _resource_record_post_run 05:33:32 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 511369216; Read time: 388; Write time: 492800 05:33:32 INFO - TinderboxPrint: CPU usage
13.3% 05:33:32 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 388 05:33:32 INFO - TinderboxPrint: I/O write bytes / time
511,369,216 / 492,800 05:33:32 INFO - TinderboxPrint: CPU idle
8,219.8 (86.6%) 05:33:32 INFO - TinderboxPrint: CPU user
1,211.4 (12.8%) 05:33:32 INFO - TinderboxPrint: Swap in / out
0 / 0 05:33:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 264134656; Read time: 188; Write time: 315268 05:33:32 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247234560; Read time: 200; Write time: 177532 05:33:32 INFO - Running post-run listener: _upload_blobber_files 05:33:32 INFO - Blob upload gear active. 05:33:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:33:32 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 05:33:32 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:33:32 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:33:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:33 INFO - (blobuploader) - INFO - Done attempting. 05:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:37 INFO - (blobuploader) - INFO - Done attempting. 05:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:38 INFO - (blobuploader) - INFO - Done attempting. 05:33:38 INFO - (blobuploader) - INFO - Iteration through files over. 05:33:38 INFO - Return code: 0 05:33:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:33:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:33:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fdfd964146242c4bca7889fadc987be8bab0da46ee7c8cd81896181d9a2d3aed9ee998c18677c13ff5fad5ccd3a487288d26e0505fde378da765c7aea46a636", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3ff50df1c0d3986a188e6122101821f3eb2e4e3ad855aad4671b5a09ac25d7f39a3fa39dc6dda6d784d4428198171070c7920cbfb8abc7ef2ac96b4bf7d9801", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be1f9e089f176191359ef54d76346ec98649da062e354596296462faaac7be9197b8097b6950654e25565aa759cc33ef6abbb04426247108c2b70fa82c5476fb"} 05:33:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:33:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:33:38 INFO - Contents: 05:33:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fdfd964146242c4bca7889fadc987be8bab0da46ee7c8cd81896181d9a2d3aed9ee998c18677c13ff5fad5ccd3a487288d26e0505fde378da765c7aea46a636", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3ff50df1c0d3986a188e6122101821f3eb2e4e3ad855aad4671b5a09ac25d7f39a3fa39dc6dda6d784d4428198171070c7920cbfb8abc7ef2ac96b4bf7d9801", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be1f9e089f176191359ef54d76346ec98649da062e354596296462faaac7be9197b8097b6950654e25565aa759cc33ef6abbb04426247108c2b70fa82c5476fb"} 05:33:38 INFO - Running post-run listener: copy_logs_to_upload_dir 05:33:38 INFO - Copying logs to upload dir... 05:33:38 INFO - mkdir: /builds/slave/test/build/upload/logs 05:33:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.603279 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-21 05:33:37.874661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 05:33:37.878736) ========= 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=db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fdfd964146242c4bca7889fadc987be8bab0da46ee7c8cd81896181d9a2d3aed9ee998c18677c13ff5fad5ccd3a487288d26e0505fde378da765c7aea46a636", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3ff50df1c0d3986a188e6122101821f3eb2e4e3ad855aad4671b5a09ac25d7f39a3fa39dc6dda6d784d4428198171070c7920cbfb8abc7ef2ac96b4bf7d9801", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be1f9e089f176191359ef54d76346ec98649da062e354596296462faaac7be9197b8097b6950654e25565aa759cc33ef6abbb04426247108c2b70fa82c5476fb"} build_url:https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/WuWv7NEaQiy4ncoTMeToZQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fdfd964146242c4bca7889fadc987be8bab0da46ee7c8cd81896181d9a2d3aed9ee998c18677c13ff5fad5ccd3a487288d26e0505fde378da765c7aea46a636", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3ff50df1c0d3986a188e6122101821f3eb2e4e3ad855aad4671b5a09ac25d7f39a3fa39dc6dda6d784d4428198171070c7920cbfb8abc7ef2ac96b4bf7d9801", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be1f9e089f176191359ef54d76346ec98649da062e354596296462faaac7be9197b8097b6950654e25565aa759cc33ef6abbb04426247108c2b70fa82c5476fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 05:33:37.906484) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:33:37.906836) ========= 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=db0483c52d987ecb441a263b000001ad-1466511184.955642-1903544161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:33:37.998378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 05:33:37.998929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 05:33:37.999445) ========= ========= Total master_lag: 0.20 =========