builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1468753017.15 results: success (0) buildid: 20160717012752 builduid: 7c8d6ca086b34c96a848242cc25eaaba revision: a9770a4ce6c6cbfa6c492eb5b7fcf747ee1139f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.147964) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.148378) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.148926) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.206933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.207224) ========= 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-1468752846.605155-1654954396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 03:56:57-- 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% 70.8M=0s 2016-07-17 03:56:57 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135309 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.366258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.366594) ========= 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-1468752846.605155-1654954396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014222 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.420689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:57.421049) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a9770a4ce6c6cbfa6c492eb5b7fcf747ee1139f9 --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 a9770a4ce6c6cbfa6c492eb5b7fcf747ee1139f9 --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-1468752846.605155-1654954396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 03:56:57,677 truncating revision to first 12 chars 2016-07-17 03:56:57,677 Setting DEBUG logging. 2016-07-17 03:56:57,677 attempt 1/10 2016-07-17 03:56:57,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a9770a4ce6c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 03:56:58,076 unpacking tar archive at: mozilla-aurora-a9770a4ce6c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:58.168051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:58.168383) ========= script_repo_revision: a9770a4ce6c6cbfa6c492eb5b7fcf747ee1139f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:58.168804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:58.169106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 03:56:58.180122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-17 03:56:58.180469) ========= /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-1468752846.605155-1654954396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:56:58 INFO - MultiFileLogger online at 20160717 03:56:58 in /builds/slave/test 03:56:58 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 03:56:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:56:58 INFO - {'append_to_log': False, 03:56:58 INFO - 'base_work_dir': '/builds/slave/test', 03:56:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:56:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:56:58 INFO - 'branch': 'Mozilla-Aurora', 03:56:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:56:58 INFO - 'config_files': ('talos/linux_config.py',), 03:56:58 INFO - 'default_actions': ('clobber', 03:56:58 INFO - 'read-buildbot-config', 03:56:58 INFO - 'download-and-extract', 03:56:58 INFO - 'populate-webroot', 03:56:58 INFO - 'create-virtualenv', 03:56:58 INFO - 'install', 03:56:58 INFO - 'run-tests'), 03:56:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:56:58 INFO - 'download_minidump_stackwalk': True, 03:56:58 INFO - 'download_symbols': 'ondemand', 03:56:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:56:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:56:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:56:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:56:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:56:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:56:58 INFO - 'installer_path': 'installer.exe', 03:56:58 INFO - 'log_level': 'info', 03:56:58 INFO - 'log_name': 'talos', 03:56:58 INFO - 'log_to_console': True, 03:56:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:56:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:56:58 INFO - 'opt_config_files': (), 03:56:58 INFO - 'pip_index': False, 03:56:58 INFO - 'sps_profile': False, 03:56:58 INFO - 'sps_profile_interval': 0, 03:56:58 INFO - 'suite': 'dromaeojs-e10s', 03:56:58 INFO - 'system_bits': '32', 03:56:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:56:58 INFO - 'title': 'talos-linux64-ix-031', 03:56:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:56:58 INFO - 'use_talos_json': True, 03:56:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:56:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:56:58 INFO - 'work_dir': 'build'} 03:56:58 INFO - ##### 03:56:58 INFO - ##### Running clobber step. 03:56:58 INFO - ##### 03:56:58 INFO - Running pre-action listener: _resource_record_pre_action 03:56:58 INFO - Running main action method: clobber 03:56:58 INFO - rmtree: /builds/slave/test/build 03:56:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:56:59 INFO - Running post-action listener: _resource_record_post_action 03:56:59 INFO - ##### 03:56:59 INFO - ##### Finished clobber step (success) 03:56:59 INFO - ##### 03:56:59 INFO - ##### 03:56:59 INFO - ##### Running read-buildbot-config step. 03:56:59 INFO - ##### 03:56:59 INFO - Running pre-action listener: _resource_record_pre_action 03:56:59 INFO - Running main action method: read_buildbot_config 03:56:59 INFO - Using buildbot properties: 03:56:59 INFO - { 03:56:59 INFO - "project": "", 03:56:59 INFO - "product": "firefox", 03:56:59 INFO - "script_repo_revision": "production", 03:56:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:56:59 INFO - "repository": "", 03:56:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:56:59 INFO - "buildid": "20160717012752", 03:56:59 INFO - "pgo_build": "True", 03:56:59 INFO - "basedir": "/builds/slave/test", 03:56:59 INFO - "buildnumber": 450, 03:56:59 INFO - "slavename": "talos-linux64-ix-031", 03:56:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:56:59 INFO - "platform": "ubuntu64_hw", 03:56:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:56:59 INFO - "branch": "mozilla-aurora", 03:56:59 INFO - "repo_path": "releases/mozilla-aurora", 03:56:59 INFO - "revision": "a9770a4ce6c6cbfa6c492eb5b7fcf747ee1139f9", 03:56:59 INFO - "stage_platform": "linux64-pgo", 03:56:59 INFO - "builduid": "7c8d6ca086b34c96a848242cc25eaaba", 03:56:59 INFO - "slavebuilddir": "test" 03:56:59 INFO - } 03:56:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:56:59 INFO - Running post-action listener: _resource_record_post_action 03:56:59 INFO - ##### 03:56:59 INFO - ##### Finished read-buildbot-config step (success) 03:56:59 INFO - ##### 03:56:59 INFO - ##### 03:56:59 INFO - ##### Running download-and-extract step. 03:56:59 INFO - ##### 03:56:59 INFO - Running pre-action listener: _resource_record_pre_action 03:56:59 INFO - Running main action method: download_and_extract 03:56:59 INFO - mkdir: /builds/slave/test/build/tests 03:56: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')]} 03:56:59 INFO - https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:06 INFO - Downloaded 1361 bytes. 03:57:06 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:57:06 INFO - Using the following test package requirements: 03:57:06 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:57:06 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:06 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:57:06 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:06 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:57:06 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:06 INFO - u'jsshell-linux-x86_64.zip'], 03:57:06 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:06 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:57:06 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:57:06 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:06 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:57:06 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:06 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:57:06 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:06 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:57:06 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:06 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:57:06 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:06 INFO - https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:57:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:57:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:08 INFO - Downloaded 24490992 bytes. 03:57:08 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'] 03:57:08 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 03:57:09 INFO - Return code: 0 03:57:09 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 03:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:09 INFO - https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:57:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:57:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:11 INFO - Downloaded 24490992 bytes. 03:57:11 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'] 03:57:11 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 03:57:12 INFO - Return code: 0 03:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:12 INFO - https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:57:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:57:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:57:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:13 INFO - Downloaded 10833369 bytes. 03:57:13 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'] 03:57:13 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 03:57:13 INFO - Return code: 0 03:57: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')]} 03:57:13 INFO - https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:57:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:57:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:57:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IALm5pLnTO6kxtegWvLzLg/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 03:57:15 INFO - Downloaded 63641865 bytes. 03:57:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:57:15 INFO - mkdir: /builds/slave/test/properties 03:57:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:57:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:57:15 INFO - Contents: 03:57:15 INFO - build_url:https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:57:16 INFO - Running post-action listener: _resource_record_post_action 03:57:16 INFO - Running post-action listener: set_extra_try_arguments 03:57:16 INFO - ##### 03:57:16 INFO - ##### Finished download-and-extract step (success) 03:57:16 INFO - ##### 03:57:16 INFO - ##### 03:57:16 INFO - ##### Running populate-webroot step. 03:57:16 INFO - ##### 03:57:16 INFO - Running pre-action listener: _resource_record_pre_action 03:57:16 INFO - Running main action method: populate_webroot 03:57:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:57:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:57:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:57:16 INFO - '--tppagecycles', 03:57:16 INFO - '7'], 03:57:16 INFO - 'tests': ['tsvgm']}}, 03:57:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:57:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:57:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:57:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:57:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:16 INFO - 'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:16 INFO - 'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['damp', 'tps']}, 03:57:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:16 INFO - 'tests': ['damp', 'tps']}, 03:57:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['dromaeo_dom']}, 03:57:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:57:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['a11yr', 03:57:16 INFO - 'ts_paint', 03:57:16 INFO - 'tpaint', 03:57:16 INFO - 'sessionrestore', 03:57:16 INFO - 'sessionrestore_no_auto_restore', 03:57:16 INFO - 'tabpaint']}, 03:57:16 INFO - 'other-e10s': {'tests': ['a11yr', 03:57:16 INFO - 'ts_paint', 03:57:16 INFO - 'tpaint', 03:57:16 INFO - 'sessionrestore', 03:57:16 INFO - 'sessionrestore_no_auto_restore', 03:57:16 INFO - 'tabpaint']}, 03:57:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:57:16 INFO - 'ts_paint', 03:57:16 INFO - 'tpaint', 03:57:16 INFO - 'sessionrestore', 03:57:16 INFO - 'sessionrestore_no_auto_restore', 03:57:16 INFO - 'tabpaint']}, 03:57:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:57:16 INFO - 'ts_paint', 03:57:16 INFO - 'tpaint', 03:57:16 INFO - 'sessionrestore', 03:57:16 INFO - 'sessionrestore_no_auto_restore', 03:57:16 INFO - 'tabpaint']}, 03:57:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['a11yr', 03:57:16 INFO - 'ts_paint', 03:57:16 INFO - 'tpaint', 03:57:16 INFO - 'sessionrestore', 03:57:16 INFO - 'sessionrestore_no_auto_restore', 03:57:16 INFO - 'tabpaint']}, 03:57:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['a11yr', 03:57:16 INFO - 'ts_paint', 03:57:16 INFO - 'tpaint', 03:57:16 INFO - 'sessionrestore', 03:57:16 INFO - 'sessionrestore_no_auto_restore', 03:57:16 INFO - 'tabpaint']}, 03:57:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['tsvgx', 03:57:16 INFO - 'tsvgr_opacity', 03:57:16 INFO - 'tart', 03:57:16 INFO - 'tscrollx', 03:57:16 INFO - 'cart']}, 03:57:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:57:16 INFO - 'tsvgr_opacity', 03:57:16 INFO - 'tart', 03:57:16 INFO - 'tscrollx', 03:57:16 INFO - 'cart']}, 03:57:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:16 INFO - 'talos_options': ['--disable-e10s'], 03:57:16 INFO - 'tests': ['tp5o']}, 03:57:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:16 INFO - 'tests': ['tp5o']}, 03:57:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:16 INFO - 'talos_options': ['--disable-e10s', 03:57:16 INFO - '--xperf_path', 03:57:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:16 INFO - 'tests': ['tp5n']}, 03:57:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:16 INFO - 'talos_options': ['--xperf_path', 03:57:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:16 INFO - 'tests': ['tp5n']}}, 03:57:16 INFO - 'talos.zip': {'path': '', 03:57:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:57:16 INFO - Running post-action listener: _resource_record_post_action 03:57:16 INFO - ##### 03:57:16 INFO - ##### Finished populate-webroot step (success) 03:57:16 INFO - ##### 03:57:16 INFO - ##### 03:57:16 INFO - ##### Running create-virtualenv step. 03:57:16 INFO - ##### 03:57:16 INFO - Running pre-action listener: _resource_record_pre_action 03:57:16 INFO - Running main action method: create_virtualenv 03:57:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:57:16 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 03:57:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:57:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:57:16 INFO - Using real prefix '/usr' 03:57:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:57:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:57:18 INFO - Installing pip.................done. 03:57:18 INFO - Return code: 0 03:57:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:18 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 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57:18 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 03:57:18 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 03:57:18 INFO - Using env: {'DISPLAY': ':0', 03:57:18 INFO - 'HOME': '/home/cltbld', 03:57:18 INFO - 'LANG': 'en_US.UTF-8', 03:57:18 INFO - 'LANGUAGE': 'en_US:en', 03:57:18 INFO - 'LOGNAME': 'cltbld', 03:57:18 INFO - 'MAIL': '/var/mail/cltbld', 03:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:18 INFO - 'MOZ_NO_REMOTE': '1', 03:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:18 INFO - 'NO_EM_RESTART': '1', 03:57:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:18 INFO - 'PWD': '/builds/slave/test', 03:57:18 INFO - 'SHELL': '/bin/bash', 03:57:18 INFO - 'SHLVL': '1', 03:57:18 INFO - 'TERM': 'linux', 03:57:18 INFO - 'TMOUT': '86400', 03:57:18 INFO - 'USER': 'cltbld', 03:57:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:18 INFO - '_': '/tools/buildbot/bin/python'} 03:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:18 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 03:57:18 INFO - Cleaning up... 03:57:18 INFO - Return code: 0 03:57:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:18 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 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57:18 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 03:57:18 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 03:57:18 INFO - Using env: {'DISPLAY': ':0', 03:57:18 INFO - 'HOME': '/home/cltbld', 03:57:18 INFO - 'LANG': 'en_US.UTF-8', 03:57:18 INFO - 'LANGUAGE': 'en_US:en', 03:57:18 INFO - 'LOGNAME': 'cltbld', 03:57:18 INFO - 'MAIL': '/var/mail/cltbld', 03:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:18 INFO - 'MOZ_NO_REMOTE': '1', 03:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:18 INFO - 'NO_EM_RESTART': '1', 03:57:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:18 INFO - 'PWD': '/builds/slave/test', 03:57:18 INFO - 'SHELL': '/bin/bash', 03:57:18 INFO - 'SHLVL': '1', 03:57:18 INFO - 'TERM': 'linux', 03:57:18 INFO - 'TMOUT': '86400', 03:57:18 INFO - 'USER': 'cltbld', 03:57:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:18 INFO - '_': '/tools/buildbot/bin/python'} 03:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:19 INFO - Downloading/unpacking psutil>=3.1.1 03:57:19 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 03:57:19 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 03:57:19 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 03:57:19 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 03:57:19 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 03:57:19 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 03:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:57:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:21 INFO - Installing collected packages: psutil 03:57:21 INFO - Running setup.py install for psutil 03:57:21 INFO - building 'psutil._psutil_linux' extension 03:57:21 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 03:57:21 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 03:57:21 INFO - building 'psutil._psutil_posix' extension 03:57:21 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 03:57:21 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 03:57:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:21 INFO - Successfully installed psutil 03:57:21 INFO - Cleaning up... 03:57:21 INFO - Return code: 0 03:57:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:57: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 mozsystemmonitor==0.3 03:57:21 INFO - Using env: {'DISPLAY': ':0', 03:57:21 INFO - 'HOME': '/home/cltbld', 03:57:21 INFO - 'LANG': 'en_US.UTF-8', 03:57:21 INFO - 'LANGUAGE': 'en_US:en', 03:57:21 INFO - 'LOGNAME': 'cltbld', 03:57:21 INFO - 'MAIL': '/var/mail/cltbld', 03:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:21 INFO - 'MOZ_NO_REMOTE': '1', 03:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:21 INFO - 'NO_EM_RESTART': '1', 03:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:21 INFO - 'PWD': '/builds/slave/test', 03:57:21 INFO - 'SHELL': '/bin/bash', 03:57:21 INFO - 'SHLVL': '1', 03:57:21 INFO - 'TERM': 'linux', 03:57:21 INFO - 'TMOUT': '86400', 03:57:21 INFO - 'USER': 'cltbld', 03:57:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:21 INFO - '_': '/tools/buildbot/bin/python'} 03:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:57:23 INFO - Installing collected packages: mozsystemmonitor 03:57:23 INFO - Running setup.py install for mozsystemmonitor 03:57:23 INFO - Successfully installed mozsystemmonitor 03:57:23 INFO - Cleaning up... 03:57:24 INFO - Return code: 0 03:57:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:57:24 INFO - Using env: {'DISPLAY': ':0', 03:57:24 INFO - 'HOME': '/home/cltbld', 03:57:24 INFO - 'LANG': 'en_US.UTF-8', 03:57:24 INFO - 'LANGUAGE': 'en_US:en', 03:57:24 INFO - 'LOGNAME': 'cltbld', 03:57:24 INFO - 'MAIL': '/var/mail/cltbld', 03:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:24 INFO - 'MOZ_NO_REMOTE': '1', 03:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:24 INFO - 'NO_EM_RESTART': '1', 03:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:24 INFO - 'PWD': '/builds/slave/test', 03:57:24 INFO - 'SHELL': '/bin/bash', 03:57:24 INFO - 'SHLVL': '1', 03:57:24 INFO - 'TERM': 'linux', 03:57:24 INFO - 'TMOUT': '86400', 03:57:24 INFO - 'USER': 'cltbld', 03:57:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:24 INFO - '_': '/tools/buildbot/bin/python'} 03:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:24 INFO - Downloading/unpacking jsonschema==2.5.1 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:26 INFO - warning: no files found matching '*.txt' 03:57:26 INFO - no previously-included directories found matching 'build' 03:57:26 INFO - no previously-included directories found matching 'dist' 03:57:26 INFO - no previously-included directories found matching '.git*' 03:57:26 INFO - Installing collected packages: jsonschema, functools32 03:57:26 INFO - Running setup.py install for functools32 03:57:26 INFO - warning: no files found matching '*.txt' 03:57:26 INFO - no previously-included directories found matching 'build' 03:57:26 INFO - no previously-included directories found matching 'dist' 03:57:26 INFO - no previously-included directories found matching '.git*' 03:57:26 INFO - Successfully installed jsonschema functools32 03:57:26 INFO - Cleaning up... 03:57:26 INFO - Return code: 0 03:57:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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', '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 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:57: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 blobuploader==1.2.4 03:57:26 INFO - Using env: {'DISPLAY': ':0', 03:57:26 INFO - 'HOME': '/home/cltbld', 03:57:26 INFO - 'LANG': 'en_US.UTF-8', 03:57:26 INFO - 'LANGUAGE': 'en_US:en', 03:57:26 INFO - 'LOGNAME': 'cltbld', 03:57:26 INFO - 'MAIL': '/var/mail/cltbld', 03:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:26 INFO - 'MOZ_NO_REMOTE': '1', 03:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:26 INFO - 'NO_EM_RESTART': '1', 03:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:26 INFO - 'PWD': '/builds/slave/test', 03:57:26 INFO - 'SHELL': '/bin/bash', 03:57:26 INFO - 'SHLVL': '1', 03:57:26 INFO - 'TERM': 'linux', 03:57:26 INFO - 'TMOUT': '86400', 03:57:26 INFO - 'USER': 'cltbld', 03:57:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:26 INFO - '_': '/tools/buildbot/bin/python'} 03:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:26 INFO - Downloading/unpacking blobuploader==1.2.4 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:28 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:29 INFO - Downloading docopt-0.6.1.tar.gz 03:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:29 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:29 INFO - Running setup.py install for blobuploader 03:57:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:29 INFO - Running setup.py install for requests 03:57:29 INFO - Running setup.py install for docopt 03:57:30 INFO - Successfully installed blobuploader requests docopt 03:57:30 INFO - Cleaning up... 03:57:30 INFO - Return code: 0 03:57:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:30 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 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57:30 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 03:57:30 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 03:57:30 INFO - Using env: {'DISPLAY': ':0', 03:57:30 INFO - 'HOME': '/home/cltbld', 03:57:30 INFO - 'LANG': 'en_US.UTF-8', 03:57:30 INFO - 'LANGUAGE': 'en_US:en', 03:57:30 INFO - 'LOGNAME': 'cltbld', 03:57:30 INFO - 'MAIL': '/var/mail/cltbld', 03:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:30 INFO - 'MOZ_NO_REMOTE': '1', 03:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:30 INFO - 'NO_EM_RESTART': '1', 03:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:30 INFO - 'PWD': '/builds/slave/test', 03:57:30 INFO - 'SHELL': '/bin/bash', 03:57:30 INFO - 'SHLVL': '1', 03:57:30 INFO - 'TERM': 'linux', 03:57:30 INFO - 'TMOUT': '86400', 03:57:30 INFO - 'USER': 'cltbld', 03:57:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:30 INFO - '_': '/tools/buildbot/bin/python'} 03:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:30 INFO - Running setup.py (path:/tmp/pip-Dozpn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:30 INFO - Running setup.py (path:/tmp/pip-vbGzK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:30 INFO - Running setup.py (path:/tmp/pip-I1XmZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:30 INFO - Running setup.py (path:/tmp/pip-hyb4rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:30 INFO - Running setup.py (path:/tmp/pip-qLt2ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:30 INFO - Running setup.py (path:/tmp/pip-YOIq69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:30 INFO - Running setup.py (path:/tmp/pip-CAqpYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:30 INFO - Running setup.py (path:/tmp/pip-HSQAU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:30 INFO - Running setup.py (path:/tmp/pip-DzA2x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:30 INFO - Running setup.py (path:/tmp/pip-0f36pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:31 INFO - Running setup.py (path:/tmp/pip-OhWd9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:31 INFO - Running setup.py (path:/tmp/pip-LGgS5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:31 INFO - Running setup.py (path:/tmp/pip-IIDLDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:31 INFO - Running setup.py (path:/tmp/pip-Iw79f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:31 INFO - Running setup.py (path:/tmp/pip-Sk00TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:31 INFO - Running setup.py (path:/tmp/pip-98GPiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:31 INFO - Running setup.py (path:/tmp/pip-es8y70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:31 INFO - Running setup.py install for manifestparser 03:57:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:31 INFO - Running setup.py install for mozcrash 03:57:31 INFO - Running setup.py install for mozdebug 03:57:31 INFO - Running setup.py install for mozdevice 03:57:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:57:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:31 INFO - Running setup.py install for mozfile 03:57:32 INFO - Running setup.py install for mozhttpd 03:57:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Running setup.py install for mozinfo 03:57:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Running setup.py install for mozInstall 03:57:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Running setup.py install for mozleak 03:57:32 INFO - Running setup.py install for mozlog 03:57:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Running setup.py install for moznetwork 03:57:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Running setup.py install for mozprocess 03:57:32 INFO - Running setup.py install for mozprofile 03:57:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:32 INFO - Running setup.py install for mozrunner 03:57:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:33 INFO - Running setup.py install for mozscreenshot 03:57:33 INFO - Running setup.py install for moztest 03:57:33 INFO - Running setup.py install for mozversion 03:57:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:33 INFO - Cleaning up... 03:57:33 INFO - Return code: 0 03:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:33 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')]} 03:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:33 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')]} 03:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:33 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 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57:33 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 03:57:33 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 03:57:33 INFO - Using env: {'DISPLAY': ':0', 03:57:33 INFO - 'HOME': '/home/cltbld', 03:57:33 INFO - 'LANG': 'en_US.UTF-8', 03:57:33 INFO - 'LANGUAGE': 'en_US:en', 03:57:33 INFO - 'LOGNAME': 'cltbld', 03:57:33 INFO - 'MAIL': '/var/mail/cltbld', 03:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:33 INFO - 'MOZ_NO_REMOTE': '1', 03:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:33 INFO - 'NO_EM_RESTART': '1', 03:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:33 INFO - 'PWD': '/builds/slave/test', 03:57:33 INFO - 'SHELL': '/bin/bash', 03:57:33 INFO - 'SHLVL': '1', 03:57:33 INFO - 'TERM': 'linux', 03:57:33 INFO - 'TMOUT': '86400', 03:57:33 INFO - 'USER': 'cltbld', 03:57:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:33 INFO - '_': '/tools/buildbot/bin/python'} 03:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:33 INFO - Running setup.py (path:/tmp/pip-YG7vjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:33 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)) 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:33 INFO - Running setup.py (path:/tmp/pip-yrE94s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:33 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)) 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:33 INFO - Running setup.py (path:/tmp/pip-mSN9xP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:33 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)) 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:33 INFO - Running setup.py (path:/tmp/pip-VCU85x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:33 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)) 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:33 INFO - Running setup.py (path:/tmp/pip-KgpSsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:33 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)) 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:33 INFO - Running setup.py (path:/tmp/pip-pYQW7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:33 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)) 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:33 INFO - Running setup.py (path:/tmp/pip-omq7AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:34 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:34 INFO - Running setup.py (path:/tmp/pip-yC6EXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:34 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:34 INFO - Running setup.py (path:/tmp/pip-trTNxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:34 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:34 INFO - Running setup.py (path:/tmp/pip-dsW7Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:34 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:34 INFO - Running setup.py (path:/tmp/pip-YhlPVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:34 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:34 INFO - Running setup.py (path:/tmp/pip-7NziAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:34 INFO - Running setup.py (path:/tmp/pip-AFPzUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:34 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:34 INFO - Running setup.py (path:/tmp/pip-eufZJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:34 INFO - Running setup.py (path:/tmp/pip-qTHwIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:34 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:34 INFO - Running setup.py (path:/tmp/pip-VNDmOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:34 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)) 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:34 INFO - Running setup.py (path:/tmp/pip-Efe2bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:34 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)) 03:57:34 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)) 03:57:34 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)) 03:57:34 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)) 03:57:34 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)) 03:57:34 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)) 03:57:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:36 INFO - Downloading blessings-1.6.tar.gz 03:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:57:36 INFO - Installing collected packages: blessings 03:57:36 INFO - Running setup.py install for blessings 03:57:36 INFO - Successfully installed blessings 03:57:36 INFO - Cleaning up... 03:57:37 INFO - Return code: 0 03:57:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:57:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:37 INFO - Reading from file tmpfile_stdout 03:57:37 INFO - Current package versions: 03:57:37 INFO - argparse == 1.2.1 03:57:37 INFO - blessings == 1.6 03:57:37 INFO - blobuploader == 1.2.4 03:57:37 INFO - docopt == 0.6.1 03:57:37 INFO - functools32 == 3.2.3-2 03:57:37 INFO - jsonschema == 2.5.1 03:57:37 INFO - manifestparser == 1.1 03:57:37 INFO - mozInstall == 1.12 03:57:37 INFO - mozcrash == 0.17 03:57:37 INFO - mozdebug == 0.1 03:57:37 INFO - mozdevice == 0.48 03:57:37 INFO - mozfile == 1.2 03:57:37 INFO - mozhttpd == 0.7 03:57:37 INFO - mozinfo == 0.9 03:57:37 INFO - mozleak == 0.1 03:57:37 INFO - mozlog == 3.2 03:57:37 INFO - moznetwork == 0.27 03:57:37 INFO - mozprocess == 0.23 03:57:37 INFO - mozprofile == 0.28 03:57:37 INFO - mozrunner == 6.12 03:57:37 INFO - mozscreenshot == 0.1 03:57:37 INFO - mozsystemmonitor == 0.3 03:57:37 INFO - moztest == 0.7 03:57:37 INFO - mozversion == 1.4 03:57:37 INFO - psutil == 3.1.1 03:57:37 INFO - requests == 1.2.3 03:57:37 INFO - wsgiref == 0.1.2 03:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:37 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 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57:37 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 03:57:37 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 03:57:37 INFO - Using env: {'DISPLAY': ':0', 03:57:37 INFO - 'HOME': '/home/cltbld', 03:57:37 INFO - 'LANG': 'en_US.UTF-8', 03:57:37 INFO - 'LANGUAGE': 'en_US:en', 03:57:37 INFO - 'LOGNAME': 'cltbld', 03:57:37 INFO - 'MAIL': '/var/mail/cltbld', 03:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:37 INFO - 'MOZ_NO_REMOTE': '1', 03:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:37 INFO - 'NO_EM_RESTART': '1', 03:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:37 INFO - 'PWD': '/builds/slave/test', 03:57:37 INFO - 'SHELL': '/bin/bash', 03:57:37 INFO - 'SHLVL': '1', 03:57:37 INFO - 'TERM': 'linux', 03:57:37 INFO - 'TMOUT': '86400', 03:57:37 INFO - 'USER': 'cltbld', 03:57:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:37 INFO - '_': '/tools/buildbot/bin/python'} 03:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 INFO - Cleaning up... 03:57:37 INFO - Return code: 0 03:57:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:57:37 INFO - Using env: {'DISPLAY': ':0', 03:57:37 INFO - 'HOME': '/home/cltbld', 03:57:37 INFO - 'LANG': 'en_US.UTF-8', 03:57:37 INFO - 'LANGUAGE': 'en_US:en', 03:57:37 INFO - 'LOGNAME': 'cltbld', 03:57:37 INFO - 'MAIL': '/var/mail/cltbld', 03:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:37 INFO - 'MOZ_NO_REMOTE': '1', 03:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:37 INFO - 'NO_EM_RESTART': '1', 03:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:37 INFO - 'PWD': '/builds/slave/test', 03:57:37 INFO - 'SHELL': '/bin/bash', 03:57:37 INFO - 'SHLVL': '1', 03:57:37 INFO - 'TERM': 'linux', 03:57:37 INFO - 'TMOUT': '86400', 03:57:37 INFO - 'USER': 'cltbld', 03:57:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:37 INFO - '_': '/tools/buildbot/bin/python'} 03:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:57:37 INFO - Cleaning up... 03:57:37 INFO - Return code: 0 03:57:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a7451af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, '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-1468752846.605155-1654954396', '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 03:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:57:37 INFO - Using env: {'DISPLAY': ':0', 03:57:37 INFO - 'HOME': '/home/cltbld', 03:57:37 INFO - 'LANG': 'en_US.UTF-8', 03:57:37 INFO - 'LANGUAGE': 'en_US:en', 03:57:37 INFO - 'LOGNAME': 'cltbld', 03:57:37 INFO - 'MAIL': '/var/mail/cltbld', 03:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:37 INFO - 'MOZ_NO_REMOTE': '1', 03:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:37 INFO - 'NO_EM_RESTART': '1', 03:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:37 INFO - 'PWD': '/builds/slave/test', 03:57:37 INFO - 'SHELL': '/bin/bash', 03:57:37 INFO - 'SHLVL': '1', 03:57:37 INFO - 'TERM': 'linux', 03:57:37 INFO - 'TMOUT': '86400', 03:57:37 INFO - 'USER': 'cltbld', 03:57:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:37 INFO - '_': '/tools/buildbot/bin/python'} 03:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:37 INFO - Downloading/unpacking flake8 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:57:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:57:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:57:40 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 03:57:40 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 03:57:40 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 03:57:40 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 03:57:40 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 03:57:40 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 03:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:57:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:57:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:57:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:57:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:57:40 INFO - no previously-included directories found matching 'docs/_build' 03:57:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:57:40 INFO - Running setup.py install for pep8 03:57:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:57:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:57:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:57:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:57:40 INFO - no previously-included directories found matching 'docs/_build' 03:57:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:57:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:57:40 INFO - Cleaning up... 03:57:40 INFO - Return code: 0 03:57:40 INFO - Running post-action listener: _resource_record_post_action 03:57:40 INFO - Running post-action listener: _start_resource_monitoring 03:57:40 INFO - Starting resource monitoring. 03:57:40 INFO - ##### 03:57:40 INFO - ##### Finished create-virtualenv step (success) 03:57:40 INFO - ##### 03:57:40 INFO - ##### 03:57:40 INFO - ##### Running install step. 03:57:40 INFO - ##### 03:57:40 INFO - Running pre-action listener: _resource_record_pre_action 03:57:40 INFO - Running main action method: install 03:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:40 INFO - Reading from file tmpfile_stdout 03:57:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:57:41 INFO - Reading from file tmpfile_stdout 03:57:41 INFO - Output received: 03:57:41 INFO - Usage: mozinstall [options] installer 03:57:41 INFO - Options: 03:57:41 INFO - -h, --help show this help message and exit 03:57:41 INFO - -d DEST, --destination=DEST 03:57:41 INFO - Directory to install application into. [default: 03:57:41 INFO - "/builds/slave/test"] 03:57:41 INFO - --app=APP Application being installed. [default: firefox] 03:57:41 INFO - mkdir: /builds/slave/test/build/application 03:57:41 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'] 03:57:41 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 03:57:56 INFO - Reading from file tmpfile_stdout 03:57:56 INFO - Output received: 03:57:56 INFO - /builds/slave/test/build/application/firefox/firefox 03:57:56 INFO - Running post-action listener: _resource_record_post_action 03:57:56 INFO - ##### 03:57:56 INFO - ##### Finished install step (success) 03:57:56 INFO - ##### 03:57:56 INFO - ##### 03:57:56 INFO - ##### Running run-tests step. 03:57:56 INFO - ##### 03:57:56 INFO - Running pre-action listener: _resource_record_pre_action 03:57:56 INFO - Running main action method: run_tests 03:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:56 INFO - Python 2.7.3 03:57:56 INFO - Return code: 0 03:57:56 INFO - grabbing minidump binary from tooltool 03:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:56 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 0x204f1c0>, '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 0x20500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2050550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:56 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 03:57:56 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 03:57:56 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 03:57:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:56 INFO - Return code: 0 03:57:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:57:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:57:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:57:57 INFO - Return code: 0 03:57:57 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/IALm5pLnTO6kxtegWvLzLg/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 03:57:57 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/IALm5pLnTO6kxtegWvLzLg/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 03:57:57 INFO - Using env: {'DISPLAY': ':0', 03:57:57 INFO - 'HOME': '/home/cltbld', 03:57:57 INFO - 'LANG': 'en_US.UTF-8', 03:57:57 INFO - 'LANGUAGE': 'en_US:en', 03:57:57 INFO - 'LOGNAME': 'cltbld', 03:57:57 INFO - 'MAIL': '/var/mail/cltbld', 03:57:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:57 INFO - 'MOZ_NO_REMOTE': '1', 03:57:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:57 INFO - 'NO_EM_RESTART': '1', 03:57:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:57 INFO - 'PWD': '/builds/slave/test', 03:57:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:57 INFO - 'SHELL': '/bin/bash', 03:57:57 INFO - 'SHLVL': '1', 03:57:57 INFO - 'TERM': 'linux', 03:57:57 INFO - 'TMOUT': '86400', 03:57:57 INFO - 'USER': 'cltbld', 03:57:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468752846.605155-1654954396', 03:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:57 INFO - '_': '/tools/buildbot/bin/python'} 03:57:57 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/IALm5pLnTO6kxtegWvLzLg/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 03:57:58 INFO - mozversion application_buildid: 20160717012752 03:57:58 INFO - mozversion application_changeset: a9770a4ce6c6cbfa6c492eb5b7fcf747ee1139f9 03:57:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:57:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:58 INFO - mozversion application_name: Firefox 03:57:58 INFO - mozversion application_remotingname: firefox-dev 03:57:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:58 INFO - mozversion application_vendor: Mozilla 03:57:58 INFO - mozversion application_version: 49.0a2 03:57:58 INFO - mozversion platform_buildid: 20160717012752 03:57:58 INFO - mozversion platform_changeset: a9770a4ce6c6cbfa6c492eb5b7fcf747ee1139f9 03:57:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:58 INFO - mozversion platform_version: 49.0a2 03:57:58 INFO - using testdate: 1468753078 03:57:58 INFO - actual date: 1468753078 03:57:58 INFO - starting webserver on 'localhost:59107' 03:57:58 INFO - SUITE-START | Running 2 tests 03:57:58 INFO - TEST-START | dromaeo_css 03:57:58 INFO - operating with platform_type : linux_ 03:57:58 INFO - Initialising browser for dromaeo_css test... 03:57:58 INFO - TEST-INFO | started process 4274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Wn5An/profile http://localhost:59107/getInfo.html) 03:58:02 INFO - PROCESS | 4274 | __metrics Screen width/height:1600/1200 03:58:02 INFO - PROCESS | 4274 | colorDepth:24 03:58:02 INFO - PROCESS | 4274 | Browser inner width/height: 1024/697 03:58:02 INFO - PROCESS | 4274 | __metrics 03:58:03 ERROR - PROCESS | 4274 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:58:04 INFO - TEST-INFO | 4274: exit 0 03:58:04 INFO - Browser initialized. 03:58:04 INFO - Running cycle 1/1 for dromaeo_css test... 03:58:04 INFO - TEST-INFO | started process 4407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Wn5An/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:15 INFO - PROCESS | 4407 | RSS: Main: 156184576 03:58:15 INFO - PROCESS | 4407 | 03:59:05 INFO - PROCESS | 4407 | 1468753145581 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] 04:01:13 INFO - PROCESS | 4407 | Cycle 1(1): loaded http://localhost:59107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59107/tests/dromaeo/cssquery-ext.html) 04:01:14 INFO - PROCESS | 4407 | RSS: Main: 160354304 04:01:14 INFO - PROCESS | 4407 | 04:04:16 INFO - PROCESS | 4407 | Cycle 1(1): loaded http://localhost:59107/tests/dromaeo/cssquery-ext.html (next: http://localhost:59107/tests/dromaeo/cssquery-jquery.html) 04:04:17 INFO - PROCESS | 4407 | RSS: Main: 158121984 04:04:17 INFO - PROCESS | 4407 | 04:07:18 INFO - PROCESS | 4407 | Cycle 1(1): loaded http://localhost:59107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59107/tests/dromaeo/cssquery-mootools.html) 04:07:19 INFO - PROCESS | 4407 | RSS: Main: 156643328 04:07:19 INFO - PROCESS | 4407 | 04:10:21 INFO - PROCESS | 4407 | Cycle 1(1): loaded http://localhost:59107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59107/tests/dromaeo/cssquery-prototype.html) 04:10:21 INFO - PROCESS | 4407 | RSS: Main: 155971584 04:10:21 INFO - PROCESS | 4407 | 04:13:24 INFO - PROCESS | 4407 | Cycle 1(1): loaded http://localhost:59107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59107/tests/dromaeo/cssquery-yui.html) 04:13:24 INFO - PROCESS | 4407 | RSS: Main: 157736960 04:13:24 INFO - PROCESS | 4407 | 04:16:26 INFO - PROCESS | 4407 | Cycle 1(1): loaded http://localhost:59107/tests/dromaeo/cssquery-yui.html (next: http://localhost:59107/tests/dromaeo/cssquery-dojo.html) 04:16:27 INFO - PROCESS | 4407 | RSS: Main: 159580160 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - PROCESS | 4407 | __start_tp_report 04:16:27 INFO - PROCESS | 4407 | _x_x_mozilla_page_load 04:16:27 INFO - PROCESS | 4407 | _x_x_mozilla_page_load_details 04:16:27 INFO - PROCESS | 4407 | |i|pagename|runs| 04:16:27 INFO - PROCESS | 4407 | |0;dojo.html;3379.9493007604888;3381.4758712399585;3418.8803391881274;3419.4699821527665;3432.0733401981465;5683.090705487112;5736.971315143423;5751.56863235257;5763.250777398932;5835.474807267345;5780.393058728836;5794.942050579493;5819.592628516006;5830.4461076197695;5846.064629659255;5156.716380599075;5243.659162154467;5254.0805359062015;5309.33633295838;5348.411674715798;5120.769565369549;5188.7146206958605;5305.071612467822;5305.920411193835;5315.681059136445;5250.212468129773;5264.8157314494;5270.420253772082;5285.312909321783;5324.733763311839;5240.056789777838;5245.816396426107;5333.946660533384;5339.599530035263;5343.171808369709;5202.791888324463;5266.8683282917855;5302.787888484456;5306.602004849613;5315.495027972336;5505.064139096363;5529.668219906778;5596.468335508121;5602.691851948141;5639.15412688096;6150.569460137792;6180.3201647818705;6189.783357582463;6198.008318668992;6201.565890387675;6267.592606480564;6286.214223222098;6289.811305660837;6292.1820163378925;6293.087502312139;5583.553315734732;5677.545796336283;5764.33710123337;5765.4811067004175;5790.913136302959;6280.755122125837;6310.148130002391;6337.746490140435;6344.619322840552;6350.618962862243;6010.068439391901;6087.817365479043;6114.205153330038;6118.816435506942;6120.234970628671;6002.069679199731;6103.206583144163;6105.877882442326;6144.016957286902;6147.877042459215;6130.478909292671;6147.354527774519;6151.538634602333;6157;6160.260768707783;5971.343152253248;6140.293866205354;6150.969245153835;6151.507879369729;6166.691665416712;4668.206404911173;4675.555822196886;4717.716936983723;4746.7389293589185;4752.833650822205;4197.711515585878;4223.282042052859;4227.196832601796;4268.445102136764;4272.764997925144;5768.653880767168;5780.53755699543;5920.052791553331;5951.464368206882;6003.0695242237525;6000.789972350947;6066.75732970685;6110.285381942539;6113.537117903944;6243.843903902348;5893.6463812171405;5931.199288096138;5945.762169513171;5956.821295361146;5976.5218782497295;5093.719845408464;5290.92063619046;5302.2046692996355;5310.044192045391;5310.601704872072;6464.030395440722;6521.902171467432;6551.148350714377;6565.540412171103;6565.80302590923;6234.1583886174785;6257.749690012349;6271.184745982993;6273.404026617464;6314.4632706218645;6234.470070044097;6358.872822543616;6576.210854697467;6591.110200122922;6601.042848786995;6021.608595441282;6150.384961503813;6153.353897840662;6154.938450615616;6156.045812899008;6177.444030037318;6209.2548894133;6230.221222347207;6231.626102433868;6252.968735156295;5792.797252096157;5959.433853783884;6016.699165041818;6093.329733729375;6114.2357205349335;6009.36901625323;6079.118527813531;6101.633901965719;6102.938970610415;6103.6032657877095;5961.642301461926;5979.043353063489;5986.491148252448;5992.13114098462;6008.429199226067;5837.182794408701;5939.732712028055;6035.969820150871;6057.909576276313;6086.786962456293;5927.14056461802;5976.372480889444;5979.730912109053;5981.0729336952845;5991.131285963598 04:16:27 INFO - PROCESS | 4407 | |1;ext.html;612.7303986246052;638.7828138432933;655.3806652713188;665.8235567574592;684.2131548718976;43119.35320970184;48232.517674823284;48245.51754482454;48274;48429.51570484298;48214;48515.51484485154;48547.51452485474;48707.51292487074;48796.26805597919;8962.641494340218;9090.136437038504;9144.359894807332;9148.63405463784;9167.633294668205;8880.24517915978;8981.056989016157;8987.730368088967;9016.594253258587;9036.954815225914;9101;9123.04208058151;9134;9134.543272836365;9136.954315228415;9054.049324820899;9113.179813816789;9117.954410227972;9125.771855703593;9143.862842057375;9017.323700722472;9077.45535267886;9106.134917182857;9106.27149828012;9150.450972941644;44631.77684111591;44977.77511112456;45276.3208551872;45366.77316613429;45427.31859022117;3788;3840.9231815363537;3916.921661566781;3974.7813870237123;4018.136100738326;34800.82599587011;35323.82338088319;35788.46317305243;35982.64017359819;36064.819675901716;4650.306870517529;4727.716337019755;4802.711837289774;4804.23132298834;4855.5387238212315;381895;382486;383423;383719;386196.9999999972;36135.27729445396;37100;67938;68468.31531684619;68473.65763171251;39509.40735888964;39652.80173599113;39755.80122099371;39823.2035359297;39918.20163596712;17578.12109394525;17797.46607601774;17981.730274045898;17991;18007.09964501796;15058.849411505746;15140.318685659171;15155;15174.089554626536;15178.165200914056;9240.907590924138;9265.814683706423;9298.209652179641;9308.767280818034;9320.347575669639;3482.753623912562;3519.2433626770367;3559.18138828071;3559.2189851591315;3598.7997343838424;1114.375949468284;1132.8640563132312;1142.4173671427632;1204.349651188366;1204.4459548607563;34821.651783481844;34926.82536587301;35247.29505409877;35276;35507;1225.1730082194483;1227.9570215042431;1247.1020864977384;1258.3456602566614;1261.9432125554372;18386.908065459585;18487.729207271;18491.352802651843;18511.35210267634;18775;546345;574861;579716;580655;853317;62911;63052;63441.365586344466;63477.04784428237;63638.68180659067;1505.2548988250885;1525.862672359493;1527.0532269992898;1529.05962832857;1541.175471122944;34178.14554636154;34360.48459273163;34364.48453273153;34846.825765871006;34932.65067349294;56561;56912.43087569237;56939.715301423224;57044;57172.42827571671;396146;398829;399049;402941;404400;30400.239994000327;30408.847955760964;30681.8465907669;30744.84627576848;30749.23126921845;51502.74248628733;51593.74203128961;52931;53085.46914530805;54899.72550137224;45943;46607.766961164976;46926.76536617295;47485.76257118831;48017.75991120162;45197.54802451933;45337;45900.540994589624;46615.766921165174;46649.3002604968;45020.54979450163;45261.32108018317;46162.769186153855;46388.53611463977;46717;40245.39631905465;40291;40372.596274036885;40520.189596208504;40528.87209929744;29132.708672913;29310.560341594468;29503.26241843971;29598.55602165926;29676.40647187001 04:16:27 INFO - PROCESS | 4407 | |2;jquery.html;414.3494713300119;418.94763154605675;419.1198483185313;429.62193269922466;446.59136889745884;19191.904040479796;20350.491237719063;20998.160073597057;21563.353099407042;21608.675869861927;18316.898151601494;18367.724484132716;18717.438476845717;19114.522136946583;20331.28840490583;5645.8588535286635;5989.161517387569;5995.370486098962;6002.8799424011495;6026.427489388523;5679.261695979517;5735.827925162252;5755.971220143893;5759.078547432412;5825.330087039981;5766;5770.076787713967;5781.19063331134;5793.536517078624;5803.129530570427;5612.130119831432;5788.739506722208;5799.884002319972;5860.824175274749;5869.50109240715;5193.63644544882;5208.791648334062;5213.478652134794;5217.50433708797;5233.319668443116;23900.52198956011;24002.75997240023;24440.755592444202;24836.3790905227;24856.627150592754;2552.527782360269;2617.0971014999795;2622.659054322926;2664.7601715845667;2682.4769170011855;14851;15105.924470377688;15608.141552214624;15644.92177539105;15944;2005.5186755178797;2053.3429302623167;2081.5599326932534;2089.8432617553594;2105.505206276524;85021.57489212576;85094.57452712697;85498.14501854964;86180;87612;9458.243340532741;10027.345487994546;10030.799384012278;10122.949385253027;10621.468926553642;12868.420921058574;12935.353232338346;12956.093073484766;12980.286084265455;13071.281079540526;8368.497890126611;8377.664893404317;8396;8443.57782110892;8493.915060849436;8793.912060879436;8892.244159246407;8926.73219803407;8977.730668079968;9071.410358326688;3983.6695533112875;3993.2412841560013;4052.9594704052583;4056.513218413809;4084.346504559256;1875.2499000399675;1935.2936178295101;1937.5543624966338;1974.2004488182308;2008.5079155606677;1046.5970601318395;1047.460557812727;1050.2963014780116;1088.086007753475;1122.3490375582144;19691.21235150578;19832.90083549573;20046.599068018848;20197.49506262355;20240.595188096155;1046.5918291866178;1056.3133962924007;1064.5316060933164;1092.1044743310567;1111.3054341036852;11236.719082023015;11260.43697815106;11457.968782809421;11465;11526.423678816192;507407;509028;519163;526210;526464;99869;100118.4994075025;100540.49729751305;102639.48680256552;103516.48241758742;1081.70793885652;1092.9125669946386;1104.2711810205226;1115.3865374044406;1121.6915348279288;17043.40348087811;17928.820711792716;18301.816981830012;18435.446936591925;18517.166727497566;44388.55611443844;44677.55322446864;44788.552114478436;45585;46621.30068048914;57262.7136864313;59001.70499147477;59468.405315946286;59816;67034.66482667555;8943.731688049369;8979.865302020606;9065.954670226607;9194.54027298619;9236.399634023766;13702.054058377496;14062.929685351508;14099.859001409855;14208.857911420753;14288.214148221947;12045.457954392248;12143.75712485763;12191.695207619881;12203.511859525519;12395.876041239471;11949.789288981567;12100.334481603597;12229.571964981184;12276.81584776247;12417.31704756247;12274.509019639114;12469.251844889335;12499.500019999097;12554.497820087094;12601.936990314989;8853.51305678194;8960.775980600538;9084.727458176265;9105.590248438704;9387.202087822337;12148.514059437524;12733.490660373482;12746.362681865685;12778.23330600167;12928.806067909178 04:16:27 INFO - PROCESS | 4407 | |3;mootools.html;1487.9851201487986;1552.6894621075785;1768.8496477799386;1949.454152837206;1956.256622483456;8765.123487651232;9513.619455221791;9524.142827145555;10173.186145108391;10244.28290019698;9559.808803823937;9852.162566181883;9923.156531694796;9926.55330510127;9965.853926798402;2512.246326102171;2536.6195070739445;2538.9746102538925;2544.8345857519294;2546.6689330387026;2479.442125521752;2537.581299085649;2538.7715105640486;2545.0710490670863;2546.961795573068;2529.759672831078;2531.974680253192;2579.496998085365;2589.469158822437;2594.13096612635;2466.260121963413;2469.76537228963;2487.0797804812155;2497.7377375375504;2515.207709571479;2429.671994280767;2456.6929133858266;2482.2801387597574;2489.0417189382038;2529.544681957247;9719.271054670928;9766.414015159113;9799.412035277906;9803.705888823346;9819.459929703864;5792.971035144839;5924.081767326072;5934.406559344075;5945.405459454063;5947.137665038588;3551.449525323579;3591.6228795976567;3651.1602331463914;3749.268892565951;3756.380197267448;1197.7604479104214;1275.7065874848745;1288.3939914804519;1289.4390939941156;1294.139397300794;14261.28693565328;14331.713365732627;14364.712705745827;14378.640533986629;14411.279436028157;4928.211486162197;5070.340855688737;5080.390353157571;5117.2068329409;5184.585233181337;11711.648650540497;11784.528618855322;11826.290422574673;11841.407929603485;11844.28934263947;5803.767849286066;5937.079752638348;5950.761969521171;5952.434518720715;5952.940470595238;4764.237721964469;5202.97398513005;5342.252084708144;5359.785608575691;5378.058839703036;4403.3174857897075;4423.093265880551;4486.214912390318;4489.393931819228;4538.818447262072;1412.3644360038024;1428.8714015738633;1430.6709456824988;1467.5817392043216;1471.2937789860928;1030.3560274828233;1107.5237647811518;1111.4998250787178;1121.1367247219596;1142.2917790969486;6908.516403851682;6956.339147780953;6974.0585021022525;7006.754763583352;7060.717571297193;473.8388947757779;478.18708196066825;481.9734914579732;482.7031375703987;485.41265069265876;4833.73414462208;4864.464908860094;4868.099401610713;4880.804767809319;4909;11533.365664888512;11912.2257053293;12125.575604853788;12538.310392928293;12552.12135150549;12265.141440099107;12271.57049503263;12357.32034738098;12363;12383.876161238453;8672.089430609694;8720.694775682947;8747.737567872973;8776.166264205018;8791.384603077724;6822.761203357859;7041.295870412918;7117.857642847218;7139.607321597362;7158.248383919614;11292.153088518558;11401.20191586581;11762;11776.057915366579;11776.293422394683;11622.88377116218;11717.882821172021;11859.940700296444;11898.464569094238;12038;8023.237792409712;8483.109273526437;8515.659373624985;8692.478451292942;8828.690995815115;9782.168515676247;9796;9871.901280987386;9889.109980101824;9929.553170107218;8511;8535.103814099679;8602.18279263494;8718.43330183536;8758.868616970878;8302.086770455124;8376.204260595234;8478.618462169341;8524.488530688179;8575.871361929701;7550.433717471102;7576;7586.962065189638;7620.885686714814;7625.580593067212;5837.416258374129;6057;6086.60437071589;6123.571350005457;6196.504279657706;6104.9389506106145;6135.355787642234;6156.815295541141;6192.752289908353;6217.813465596039 04:16:27 INFO - PROCESS | 4407 | |4;prototype.html;347.3695243133712;350.6756250468316;351.89619062376596;355.53069947669053;356.9161247106931;5641.351244606872;5689.516391106756;5700.800471983482;5701.857453563663;5760.36635970043;5645.915311270334;5660.150977353399;5679.204911312419;5686.09022556391;5688.402717714632;3959.3370784270674;4348.673849461287;4353.825846966118;4367.2575662137515;4370.934435983463;4330.761808100553;4364.192624364487;4366.912661746763;4372.825086996516;4376.803043863034;4338.587834155766;4349.499422699164;4356.106998065389;4366.978165109186;4374.868753937371;4280.828766849322;4352.7605981670995;4362.432883725095;4381.298992161239;4389.868303950887;3814.275287695357;3822.2928758179823;3845.1732877431486;3846.807659617008;3853.595372485877;5457.263269458652;5496.890062198733;5521.4478552144865;5530.944690553083;5563.082091454905;4935.259711043336;5022.4726403727445;5027.49725027498;5045.763787871995;5051.873703157414;5828.9417105828825;5830.3586605473365;5904.911426328608;5931.851703707399;5934.495567876736;4279.315309550489;4289.742615443083;4308.095299987007;4324.978375108136;4340.8480703175555;5945.492159625798;6098.420650038239;6103.176071230371;6178.783742569033;6206.224221972254;4366.279563871925;4374.825006999748;4383.189110014658;4402.933955990663;4414.757188354672;4430.601245887886;4449.555044495589;4490.101979604092;4490.663200259928;4501.459824821042;4830.589399900978;4987.276844857475;5023.472535383805;5037.614655969564;5053.343065401475;5841.970790146022;5916.408359164049;5916.674582897982;5969.9702101285775;5985.730642121115;1494;1527.938882444712;1548.1717281254475;1554.9144797036272;1572.2453222453057;975.9219262458986;989.1641562879355;992.6797359511831;1037.2790910317408;1071.6088627650852;5771.134329850556;5810.750688601971;5846.795362162304;5851.502622277154;5865.325487568899;6098.573099883054;6141.07883817431;6141.907871381933;6145.600535965148;6172.506199504029;5634;5828.358880523139;5842.503387212135;5863.589548731633;5895.616784908967;3274.7052765250764;3283.195617073832;3293.670632936687;3295.1597342677464;3299.7955746152484;6127.662978536134;6383.265924418658;6391.648459334689;6396.872062558723;6456.322086180978;6166.876662466815;6175.59858609189;6189.721462534197;6194.907076393858;6230.190075290183;6239.502519395403;6310.013717421125;6388.584741991755;6424.74301027963;6434.903476447857;6138.048602466625;6164.4143806338325;6188.690565471798;6192.380761923771;6250.343713909974;6031.577789554689;6047.334793172659;6047.334793172836;6049.427148941219;6088.4215999479975;6237.126802247598;6315.515853774267;6321.115043893767;6325.1144839721555;6326.060793703872;4368.2355587772645;4387.232234359039;4395.890102747457;4397.516273209881;4398.560143985704;5900.5574581907385;6066.939330606638;6094.202210347869;6109.205803245727;6125.540584456095;5928.199693041557;5950.613210141327;5960.582759206987;5970.0746384310505;6017.578769486094;5952.987992041277;5962.344142144448;5962.628595422991;5963.254593175853;5984.162217289496;5728.856778580569;5761.39505351932;5898.94101058984;5963.0459126539545;5966.612170208922;6058.848528786815;6078.72645730952;6095.634261944298;6102.969485152724;6111.938880611137;5780.653160810365;5837.795677151279;5959.91060134107;5987.970060149672;6003.669798160969 04:16:27 INFO - PROCESS | 4407 | |5;yui.html;786.0959896119465;791.4064451661254;865.8614621660533;881.3037700216829;931.1573026411098;15519.224038798056;15944.36222551098;15959.441419550318;16588;16837.663246735057;14537.273136343194;15496.612584685388;15875.682486350266;15907.44323948662;15957.601059973507;861.1087524412235;872.9083446238149;884.995575022124;887.7336798960318;896.2650626486284;874.899386570543;878.2622597018503;878.5387671472496;884.6903583745669;888.4269646078276;926.073926073926;926.4024704065873;927.5594092805931;927.8469052606312;929.4841363043508;913.5295322908707;915.0803442540238;915.7939463620665;918.728974952384;919.6505327975393;672.4049216443434;673.8955461903364;674.4031532094083;675.6216518749516;677.0217036382429;15970.920145399316;16108.436204732778;16120;16161.272742726487;16270.349186032545;15332.310046047955;15342.463013794464;15366.539003829903;15372.461963831323;15590.376384944588;12875.391588845298;12890.87109128906;12981.156224845448;13074.673133171651;13077.476900923952;3645.5260816094005;3752.587215406303;3757.1922036761953;3776.4712940188397;3876.3604005339084;74816;78075.6096219521;78797.84808607648;78885.60557197235;80027.59986200032;11765.176437649283;11857.703557410961;11958.342291173894;11959.701007474709;12041.939790300992;22280.66579001316;22316.65675104123;22439.10243590238;22516.32451026472;22635.094596216295;8465.957670211732;8628.094050124771;8661.220490155916;8705.216530512283;8928.955355223312;4988.27669987857;5052.949470505321;5066.670666406671;5067.645264831426;5196.948030519647;3492.877749278763;3588.5155504006625;3617.7286703497343;3618.222082252328;3620.0768803955348;633.2938773267773;647.0165348669996;647.4011539326104;648.5946283572767;648.7567162314132;635.5709895820303;672.9327067293232;690.6650274616807;709.8118998465411;737.5242968285426;9672.274579406572;9833.704988850346;9894.703158905244;9976.750581235527;10057.346272492265;572.6420986883198;640.3244576971247;646.5797231799368;680.3536640191837;694.5763084518439;4567.10941366437;4675.7895894684825;4730.881727956828;4787.569118779326;4869.074875773592;117204;117334.41332793453;118575;122824;123759.3812030934;60535.23710764578;61049.69475152596;78577;102830;107993;90534.64198037035;93831.53084234535;93932.53033734788;94224.52887735654;94529.5273523628;8819.11808819113;8958.148975847284;9059.139381758723;9088.681896133869;9146.49694266795;52466;52504;53146.20280695715;54950.72524637351;55075.89848202933;73446.63276683583;79643;79755.60122199352;80372.59813700894;81130;10622.787544249226;10748.462576870968;10771.838422423827;11055;11087.72280692989;11873.406329683654;11902.642920712393;12346.567870124503;12519.436625351698;12584.056195785535;10897.891021089688;11211.775764484828;11360.431978401211;11369.829452558384;11518.07855371585;11697;11770.470328835394;12144.817827732415;13142.60572182836;13179.868201317864;12063.276203427471;12307.507699691912;12438.37808109609;12558.246505209716;12788.552400665933;10592.390735768236;10794.082502987334;10819.513121909376;10942.234043617189;11501.309921404743;10441.477926103817;10764.138868890626;11195.552177912792;11199;11318.547258109913 04:16:27 INFO - PROCESS | 4407 | __end_tp_report 04:16:27 INFO - PROCESS | 4407 | __start_cc_report 04:16:27 INFO - PROCESS | 4407 | _x_x_mozilla_cycle_collect,337 04:16:27 INFO - PROCESS | 4407 | __end_cc_report 04:16:27 INFO - PROCESS | 4407 | __startTimestamp1468754187232__endTimestamp 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - PROCESS | 4407 | ------- Summary: start ------- 04:16:27 INFO - PROCESS | 4407 | Number of tests: 6 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - PROCESS | 4407 | [#0] dojo.html Cycles:165 Average:5747.74 Median:5979.04 stddev:653.38 (10.9%) stddev-sans-first:628.43 04:16:27 INFO - PROCESS | 4407 | Values: 3379.9 3381.5 3418.9 3419.5 3432.1 5683.1 5737.0 5751.6 5763.3 5835.5 5780.4 5794.9 5819.6 5830.4 5846.1 5156.7 5243.7 5254.1 5309.3 5348.4 5120.8 5188.7 5305.1 5305.9 5315.7 5250.2 5264.8 5270.4 5285.3 5324.7 5240.1 5245.8 5333.9 5339.6 5343.2 5202.8 5266.9 5302.8 5306.6 5315.5 5505.1 5529.7 5596.5 5602.7 5639.2 6150.6 6180.3 6189.8 6198.0 6201.6 6267.6 6286.2 6289.8 6292.2 6293.1 5583.6 5677.5 5764.3 5765.5 5790.9 6280.8 6310.1 6337.7 6344.6 6350.6 6010.1 6087.8 6114.2 6118.8 6120.2 6002.1 6103.2 6105.9 6144.0 6147.9 6130.5 6147.4 6151.5 6157.0 6160.3 5971.3 6140.3 6151.0 6151.5 6166.7 4668.2 4675.6 4717.7 4746.7 4752.8 4197.7 4223.3 4227.2 4268.4 4272.8 5768.7 5780.5 5920.1 5951.5 6003.1 6000.8 6066.8 6110.3 6113.5 6243.8 5893.6 5931.2 5945.8 5956.8 5976.5 5093.7 5290.9 5302.2 5310.0 5310.6 6464.0 6521.9 6551.1 6565.5 6565.8 6234.2 6257.7 6271.2 6273.4 6314.5 6234.5 6358.9 6576.2 6591.1 6601.0 6021.6 6150.4 6153.4 6154.9 6156.0 6177.4 6209.3 6230.2 6231.6 6253.0 5792.8 5959.4 6016.7 6093.3 6114.2 6009.4 6079.1 6101.6 6102.9 6103.6 5961.6 5979.0 5986.5 5992.1 6008.4 5837.2 5939.7 6036.0 6057.9 6086.8 5927.1 5976.4 5979.7 5981.1 5991.1 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - PROCESS | 4407 | [#1] ext.html Cycles:180 Average:63548.36 Median:45109.05 stddev:129956.06 (288.1%) stddev-sans-first:130234.71 04:16:27 INFO - PROCESS | 4407 | Values: 612.7 638.8 655.4 665.8 684.2 43119.4 48232.5 48245.5 48274.0 48429.5 48214.0 48515.5 48547.5 48707.5 48796.3 8962.6 9090.1 9144.4 9148.6 9167.6 8880.2 8981.1 8987.7 9016.6 9037.0 9101.0 9123.0 9134.0 9134.5 9137.0 9054.0 9113.2 9118.0 9125.8 9143.9 9017.3 9077.5 9106.1 9106.3 9150.5 44631.8 44977.8 45276.3 45366.8 45427.3 3788.0 3840.9 3916.9 3974.8 4018.1 34800.8 35323.8 35788.5 35982.6 36064.8 4650.3 4727.7 4802.7 4804.2 4855.5 381895.0 382486.0 383423.0 383719.0 386197.0 36135.3 37100.0 67938.0 68468.3 68473.7 39509.4 39652.8 39755.8 39823.2 39918.2 17578.1 17797.5 17981.7 17991.0 18007.1 15058.8 15140.3 15155.0 15174.1 15178.2 9240.9 9265.8 9298.2 9308.8 9320.3 3482.8 3519.2 3559.2 3559.2 3598.8 1114.4 1132.9 1142.4 1204.3 1204.4 34821.7 34926.8 35247.3 35276.0 35507.0 1225.2 1228.0 1247.1 1258.3 1261.9 18386.9 18487.7 18491.4 18511.4 18775.0 546345.0 574861.0 579716.0 580655.0 853317.0 62911.0 63052.0 63441.4 63477.0 63638.7 1505.3 1525.9 1527.1 1529.1 1541.2 34178.1 34360.5 34364.5 34846.8 34932.7 56561.0 56912.4 56939.7 57044.0 57172.4 396146.0 398829.0 399049.0 402941.0 404400.0 30400.2 30408.8 30681.8 30744.8 30749.2 51502.7 51593.7 52931.0 53085.5 54899.7 45943.0 46607.8 46926.8 47485.8 48017.8 45197.5 45337.0 45900.5 46615.8 46649.3 45020.5 45261.3 46162.8 46388.5 46717.0 40245.4 40291.0 40372.6 40520.2 40528.9 29132.7 29310.6 29503.3 29598.6 29676.4 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - PROCESS | 4407 | [#2] jquery.html Cycles:180 Average:30681.62 Median:11834.43 stddev:85480.11 (722.3%) stddev-sans-first:85689.69 04:16:27 INFO - PROCESS | 4407 | Values: 414.3 418.9 419.1 429.6 446.6 19191.9 20350.5 20998.2 21563.4 21608.7 18316.9 18367.7 18717.4 19114.5 20331.3 5645.9 5989.2 5995.4 6002.9 6026.4 5679.3 5735.8 5756.0 5759.1 5825.3 5766.0 5770.1 5781.2 5793.5 5803.1 5612.1 5788.7 5799.9 5860.8 5869.5 5193.6 5208.8 5213.5 5217.5 5233.3 23900.5 24002.8 24440.8 24836.4 24856.6 2552.5 2617.1 2622.7 2664.8 2682.5 14851.0 15105.9 15608.1 15644.9 15944.0 2005.5 2053.3 2081.6 2089.8 2105.5 85021.6 85094.6 85498.1 86180.0 87612.0 9458.2 10027.3 10030.8 10122.9 10621.5 12868.4 12935.4 12956.1 12980.3 13071.3 8368.5 8377.7 8396.0 8443.6 8493.9 8793.9 8892.2 8926.7 8977.7 9071.4 3983.7 3993.2 4053.0 4056.5 4084.3 1875.2 1935.3 1937.6 1974.2 2008.5 1046.6 1047.5 1050.3 1088.1 1122.3 19691.2 19832.9 20046.6 20197.5 20240.6 1046.6 1056.3 1064.5 1092.1 1111.3 11236.7 11260.4 11458.0 11465.0 11526.4 507407.0 509028.0 519163.0 526210.0 526464.0 99869.0 100118.5 100540.5 102639.5 103516.5 1081.7 1092.9 1104.3 1115.4 1121.7 17043.4 17928.8 18301.8 18435.4 18517.2 44388.6 44677.6 44788.6 45585.0 46621.3 57262.7 59001.7 59468.4 59816.0 67034.7 8943.7 8979.9 9066.0 9194.5 9236.4 13702.1 14062.9 14099.9 14208.9 14288.2 12045.5 12143.8 12191.7 12203.5 12395.9 11949.8 12100.3 12229.6 12276.8 12417.3 12274.5 12469.3 12499.5 12554.5 12601.9 8853.5 8960.8 9084.7 9105.6 9387.2 12148.5 12733.5 12746.4 12778.2 12928.8 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - PROCESS | 4407 | [#3] mootools.html Cycles:180 Average:6530.25 Median:482.34 stddev:3783.64 (784.4%) stddev-sans-first:3775.28 04:16:27 INFO - PROCESS | 4407 | Values: 1488.0 1552.7 1768.8 1949.5 1956.3 8765.1 9513.6 9524.1 10173.2 10244.3 9559.8 9852.2 9923.2 9926.6 9965.9 2512.2 2536.6 2539.0 2544.8 2546.7 2479.4 2537.6 2538.8 2545.1 2547.0 2529.8 2532.0 2579.5 2589.5 2594.1 2466.3 2469.8 2487.1 2497.7 2515.2 2429.7 2456.7 2482.3 2489.0 2529.5 9719.3 9766.4 9799.4 9803.7 9819.5 5793.0 5924.1 5934.4 5945.4 5947.1 3551.4 3591.6 3651.2 3749.3 3756.4 1197.8 1275.7 1288.4 1289.4 1294.1 14261.3 14331.7 14364.7 14378.6 14411.3 4928.2 5070.3 5080.4 5117.2 5184.6 11711.6 11784.5 11826.3 11841.4 11844.3 5803.8 5937.1 5950.8 5952.4 5952.9 4764.2 5203.0 5342.3 5359.8 5378.1 4403.3 4423.1 4486.2 4489.4 4538.8 1412.4 1428.9 1430.7 1467.6 1471.3 1030.4 1107.5 1111.5 1121.1 1142.3 6908.5 6956.3 6974.1 7006.8 7060.7 473.8 478.2 482.0 482.7 485.4 4833.7 4864.5 4868.1 4880.8 4909.0 11533.4 11912.2 12125.6 12538.3 12552.1 12265.1 12271.6 12357.3 12363.0 12383.9 8672.1 8720.7 8747.7 8776.2 8791.4 6822.8 7041.3 7117.9 7139.6 7158.2 11292.2 11401.2 11762.0 11776.1 11776.3 11622.9 11717.9 11859.9 11898.5 12038.0 8023.2 8483.1 8515.7 8692.5 8828.7 9782.2 9796.0 9871.9 9889.1 9929.6 8511.0 8535.1 8602.2 8718.4 8758.9 8302.1 8376.2 8478.6 8524.5 8575.9 7550.4 7576.0 7587.0 7620.9 7625.6 5837.4 6057.0 6086.6 6123.6 6196.5 6104.9 6135.4 6156.8 6192.8 6217.8 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - PROCESS | 4407 | [#4] prototype.html Cycles:180 Average:5023.20 Median:5775.89 stddev:1484.46 (25.7%) stddev-sans-first:1446.54 04:16:27 INFO - PROCESS | 4407 | Values: 347.4 350.7 351.9 355.5 356.9 5641.4 5689.5 5700.8 5701.9 5760.4 5645.9 5660.2 5679.2 5686.1 5688.4 3959.3 4348.7 4353.8 4367.3 4370.9 4330.8 4364.2 4366.9 4372.8 4376.8 4338.6 4349.5 4356.1 4367.0 4374.9 4280.8 4352.8 4362.4 4381.3 4389.9 3814.3 3822.3 3845.2 3846.8 3853.6 5457.3 5496.9 5521.4 5530.9 5563.1 4935.3 5022.5 5027.5 5045.8 5051.9 5828.9 5830.4 5904.9 5931.9 5934.5 4279.3 4289.7 4308.1 4325.0 4340.8 5945.5 6098.4 6103.2 6178.8 6206.2 4366.3 4374.8 4383.2 4402.9 4414.8 4430.6 4449.6 4490.1 4490.7 4501.5 4830.6 4987.3 5023.5 5037.6 5053.3 5842.0 5916.4 5916.7 5970.0 5985.7 1494.0 1527.9 1548.2 1554.9 1572.2 975.9 989.2 992.7 1037.3 1071.6 5771.1 5810.8 5846.8 5851.5 5865.3 6098.6 6141.1 6141.9 6145.6 6172.5 5634.0 5828.4 5842.5 5863.6 5895.6 3274.7 3283.2 3293.7 3295.2 3299.8 6127.7 6383.3 6391.6 6396.9 6456.3 6166.9 6175.6 6189.7 6194.9 6230.2 6239.5 6310.0 6388.6 6424.7 6434.9 6138.0 6164.4 6188.7 6192.4 6250.3 6031.6 6047.3 6047.3 6049.4 6088.4 6237.1 6315.5 6321.1 6325.1 6326.1 4368.2 4387.2 4395.9 4397.5 4398.6 5900.6 6066.9 6094.2 6109.2 6125.5 5928.2 5950.6 5960.6 5970.1 6017.6 5953.0 5962.3 5962.6 5963.3 5984.2 5728.9 5761.4 5898.9 5963.0 5966.6 6058.8 6078.7 6095.6 6103.0 6111.9 5780.7 5837.8 5959.9 5988.0 6003.7 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - PROCESS | 4407 | [#5] yui.html Cycles:180 Average:20824.96 Median:4759.23 stddev:30349.22 (637.7%) stddev-sans-first:30397.06 04:16:27 INFO - PROCESS | 4407 | Values: 786.1 791.4 865.9 881.3 931.2 15519.2 15944.4 15959.4 16588.0 16837.7 14537.3 15496.6 15875.7 15907.4 15957.6 861.1 872.9 885.0 887.7 896.3 874.9 878.3 878.5 884.7 888.4 926.1 926.4 927.6 927.8 929.5 913.5 915.1 915.8 918.7 919.7 672.4 673.9 674.4 675.6 677.0 15970.9 16108.4 16120.0 16161.3 16270.3 15332.3 15342.5 15366.5 15372.5 15590.4 12875.4 12890.9 12981.2 13074.7 13077.5 3645.5 3752.6 3757.2 3776.5 3876.4 74816.0 78075.6 78797.8 78885.6 80027.6 11765.2 11857.7 11958.3 11959.7 12041.9 22280.7 22316.7 22439.1 22516.3 22635.1 8466.0 8628.1 8661.2 8705.2 8929.0 4988.3 5052.9 5066.7 5067.6 5196.9 3492.9 3588.5 3617.7 3618.2 3620.1 633.3 647.0 647.4 648.6 648.8 635.6 672.9 690.7 709.8 737.5 9672.3 9833.7 9894.7 9976.8 10057.3 572.6 640.3 646.6 680.4 694.6 4567.1 4675.8 4730.9 4787.6 4869.1 117204.0 117334.4 118575.0 122824.0 123759.4 60535.2 61049.7 78577.0 102830.0 107993.0 90534.6 93831.5 93932.5 94224.5 94529.5 8819.1 8958.1 9059.1 9088.7 9146.5 52466.0 52504.0 53146.2 54950.7 55075.9 73446.6 79643.0 79755.6 80372.6 81130.0 10622.8 10748.5 10771.8 11055.0 11087.7 11873.4 11902.6 12346.6 12519.4 12584.1 10897.9 11211.8 11360.4 11369.8 11518.1 11697.0 11770.5 12144.8 13142.6 13179.9 12063.3 12307.5 12438.4 12558.2 12788.6 10592.4 10794.1 10819.5 10942.2 11501.3 10441.5 10764.1 11195.6 11199.0 11318.5 04:16:27 INFO - PROCESS | 4407 | -------- Summary: end -------- 04:16:27 INFO - PROCESS | 4407 | 04:16:27 INFO - TEST-INFO | 4407: exit 0 04:16:27 INFO - TEST-OK | dromaeo_css | took 1109804ms 04:16:27 INFO - TEST-START | kraken 04:16:27 INFO - operating with platform_type : linux_ 04:16:27 INFO - Initialising browser for kraken test... 04:16:27 INFO - TEST-INFO | started process 4649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU2RVix/profile http://localhost:59107/getInfo.html) 04:16:32 INFO - PROCESS | 4649 | __metrics Screen width/height:1600/1200 04:16:32 INFO - PROCESS | 4649 | colorDepth:24 04:16:32 INFO - PROCESS | 4649 | Browser inner width/height: 1024/697 04:16:32 INFO - PROCESS | 4649 | __metrics 04:16:33 ERROR - PROCESS | 4649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:16:33 INFO - TEST-INFO | 4649: exit 0 04:16:33 INFO - Browser initialized. 04:16:33 INFO - Running cycle 1/1 for kraken test... 04:16:33 INFO - TEST-INFO | started process 4778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU2RVix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:45 INFO - PROCESS | 4778 | RSS: Main: 155721728 04:16:45 INFO - PROCESS | 4778 | 04:16:48 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59107/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:49 INFO - PROCESS | 4778 | RSS: Main: 161009664 04:16:49 INFO - PROCESS | 4778 | 04:16:51 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59107/tests/kraken/driver.html?testName=audio-dft) 04:16:52 INFO - PROCESS | 4778 | RSS: Main: 160681984 04:16:52 INFO - PROCESS | 4778 | 04:16:55 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59107/tests/kraken/driver.html?testName=audio-fft) 04:16:55 INFO - PROCESS | 4778 | RSS: Main: 161300480 04:16:55 INFO - PROCESS | 4778 | 04:16:57 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59107/tests/kraken/driver.html?testName=audio-oscillator) 04:16:58 INFO - PROCESS | 4778 | RSS: Main: 160989184 04:16:58 INFO - PROCESS | 4778 | 04:17:00 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:17:01 INFO - PROCESS | 4778 | RSS: Main: 161210368 04:17:01 INFO - PROCESS | 4778 | 04:17:04 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59107/tests/kraken/driver.html?testName=imaging-darkroom) 04:17:05 INFO - PROCESS | 4778 | RSS: Main: 160534528 04:17:05 INFO - PROCESS | 4778 | 04:17:08 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59107/tests/kraken/driver.html?testName=imaging-desaturate) 04:17:09 INFO - PROCESS | 4778 | RSS: Main: 161632256 04:17:09 INFO - PROCESS | 4778 | 04:17:11 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59107/tests/kraken/driver.html?testName=json-parse-financial) 04:17:12 INFO - PROCESS | 4778 | RSS: Main: 161476608 04:17:12 INFO - PROCESS | 4778 | 04:17:13 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:17:14 INFO - PROCESS | 4778 | RSS: Main: 161304576 04:17:14 INFO - PROCESS | 4778 | 04:17:16 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59107/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:17:16 INFO - PROCESS | 4778 | RSS: Main: 160899072 04:17:16 INFO - PROCESS | 4778 | 04:17:19 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:17:19 INFO - PROCESS | 4778 | RSS: Main: 161337344 04:17:19 INFO - PROCESS | 4778 | 04:17:22 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:17:22 INFO - PROCESS | 4778 | RSS: Main: 161935360 04:17:22 INFO - PROCESS | 4778 | 04:17:25 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:17:26 INFO - PROCESS | 4778 | RSS: Main: 161374208 04:17:26 INFO - PROCESS | 4778 | 04:17:27 INFO - PROCESS | 4778 | Cycle 1(1): loaded http://localhost:59107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59107/tests/kraken/driver.html?testName=ai-astar) 04:17:28 INFO - PROCESS | 4778 | RSS: Main: 162435072 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | __start_tp_report 04:17:28 INFO - PROCESS | 4778 | _x_x_mozilla_page_load 04:17:28 INFO - PROCESS | 4778 | _x_x_mozilla_page_load_details 04:17:28 INFO - PROCESS | 4778 | |i|pagename|runs| 04:17:28 INFO - PROCESS | 4778 | |0;ai-astar;111;105;111;111;112;111;110;111;110;111 04:17:28 INFO - PROCESS | 4778 | |1;audio-beat-detection;153;127;154;180;136;157;149;127;186;124 04:17:28 INFO - PROCESS | 4778 | |2;audio-dft;162;163;161;163;162;162;161;161;162;162 04:17:28 INFO - PROCESS | 4778 | |3;audio-fft;76;76;76;175;75;75;75;76;162;75 04:17:28 INFO - PROCESS | 4778 | |4;audio-oscillator;84;85;138;86;84;85;136;85;83;146 04:17:28 INFO - PROCESS | 4778 | |5;imaging-gaussian-blur;120;118;118;118;119;117;117;117;118;117 04:17:28 INFO - PROCESS | 4778 | |6;imaging-darkroom;147;147;148;147;146;148;146;146;148;150 04:17:28 INFO - PROCESS | 4778 | |7;imaging-desaturate;96;95;97;95;96;96;95;96;95;97 04:17:28 INFO - PROCESS | 4778 | |8;json-parse-financial;53;61;53;51;54;53;53;54;51;55 04:17:28 INFO - PROCESS | 4778 | |9;json-stringify-tinderbox;61;59;60;60;60;59;60;59;60;59 04:17:28 INFO - PROCESS | 4778 | |10;stanford-crypto-aes;76;78;76;82;78;84;77;77;103;79 04:17:28 INFO - PROCESS | 4778 | |11;stanford-crypto-ccm;125;124;135;120;118;123;132;127;132;122 04:17:28 INFO - PROCESS | 4778 | |12;stanford-crypto-pbkdf2;158;154;154;155;154;155;153;159;155;154 04:17:28 INFO - PROCESS | 4778 | |13;stanford-crypto-sha256-iterative;65;63;65;63;63;61;61;62;62;61 04:17:28 INFO - PROCESS | 4778 | __end_tp_report 04:17:28 INFO - PROCESS | 4778 | __start_cc_report 04:17:28 INFO - PROCESS | 4778 | _x_x_mozilla_cycle_collect,873 04:17:28 INFO - PROCESS | 4778 | __end_cc_report 04:17:28 INFO - PROCESS | 4778 | __startTimestamp1468754248097__endTimestamp 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | ------- Summary: start ------- 04:17:28 INFO - PROCESS | 4778 | Number of tests: 14 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.95 (1.8%) stddev-sans-first:2.05 04:17:28 INFO - PROCESS | 4778 | Values: 111.0 105.0 111.0 111.0 112.0 111.0 110.0 111.0 110.0 111.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.50 stddev:21.59 (14.1%) stddev-sans-first:22.86 04:17:28 INFO - PROCESS | 4778 | Values: 153.0 127.0 154.0 180.0 136.0 157.0 149.0 127.0 186.0 124.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:17:28 INFO - PROCESS | 4778 | Values: 162.0 163.0 161.0 163.0 162.0 162.0 161.0 161.0 162.0 162.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.33 (52.1%) stddev-sans-first:41.17 04:17:28 INFO - PROCESS | 4778 | Values: 76.0 76.0 76.0 175.0 75.0 75.0 75.0 76.0 162.0 75.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:84.50 stddev:26.90 (31.8%) stddev-sans-first:27.80 04:17:28 INFO - PROCESS | 4778 | Values: 84.0 85.0 138.0 86.0 84.0 85.0 136.0 85.0 83.0 146.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:0.71 04:17:28 INFO - PROCESS | 4778 | Values: 120.0 118.0 118.0 118.0 119.0 117.0 117.0 117.0 118.0 117.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 04:17:28 INFO - PROCESS | 4778 | Values: 147.0 147.0 148.0 147.0 146.0 148.0 146.0 146.0 148.0 150.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 04:17:28 INFO - PROCESS | 4778 | Values: 96.0 95.0 97.0 95.0 96.0 96.0 95.0 96.0 95.0 97.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:2.82 (5.3%) stddev-sans-first:2.98 04:17:28 INFO - PROCESS | 4778 | Values: 53.0 61.0 53.0 51.0 54.0 53.0 53.0 54.0 51.0 55.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 04:17:28 INFO - PROCESS | 4778 | Values: 61.0 59.0 60.0 60.0 60.0 59.0 60.0 59.0 60.0 59.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:78.00 stddev:8.15 (10.5%) stddev-sans-first:8.44 04:17:28 INFO - PROCESS | 4778 | Values: 76.0 78.0 76.0 82.0 78.0 84.0 77.0 77.0 103.0 79.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:5.61 (4.5%) stddev-sans-first:5.95 04:17:28 INFO - PROCESS | 4778 | Values: 125.0 124.0 135.0 120.0 118.0 123.0 132.0 127.0 132.0 122.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.00 stddev:1.91 (1.2%) stddev-sans-first:1.72 04:17:28 INFO - PROCESS | 4778 | Values: 158.0 154.0 154.0 155.0 154.0 155.0 153.0 159.0 155.0 154.0 04:17:28 INFO - PROCESS | 4778 | 04:17:28 INFO - PROCESS | 4778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.32 04:17:28 INFO - PROCESS | 4778 | Values: 65.0 63.0 65.0 63.0 63.0 61.0 61.0 62.0 62.0 61.0 04:17:28 INFO - PROCESS | 4778 | -------- Summary: end -------- 04:17:28 INFO - PROCESS | 4778 | 04:17:29 INFO - TEST-INFO | 4778: exit 0 04:17:29 INFO - TEST-OK | kraken | took 61184ms 04:17:29 INFO - SUITE-END | took 1170s 04:17:29 INFO - Completed test suite (00:19:31) 04:17:29 INFO - javascript benchmark 04:17:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7643.504421430097, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3379.9493007604888, 3381.4758712399585, 3418.8803391881274, 3419.4699821527665, 3432.0733401981465, 5683.090705487112, 5736.971315143423, 5751.56863235257, 5763.250777398932, 5835.474807267345, 5780.393058728836, 5794.942050579493, 5819.592628516006, 5830.4461076197695, 5846.064629659255, 5156.716380599075, 5243.659162154467, 5254.0805359062015, 5309.33633295838, 5348.411674715798, 5120.769565369549, 5188.7146206958605, 5305.071612467822, 5305.920411193835, 5315.681059136445, 5250.212468129773, 5264.8157314494, 5270.420253772082, 5285.312909321783, 5324.733763311839, 5240.056789777838, 5245.816396426107, 5333.946660533384, 5339.599530035263, 5343.171808369709, 5202.791888324463, 5266.8683282917855, 5302.787888484456, 5306.602004849613, 5315.495027972336, 5505.064139096363, 5529.668219906778, 5596.468335508121, 5602.691851948141, 5639.15412688096, 6150.569460137792, 6180.3201647818705, 6189.783357582463, 6198.008318668992, 6201.565890387675, 6267.592606480564, 6286.214223222098, 6289.811305660837, 6292.1820163378925, 6293.087502312139, 5583.553315734732, 5677.545796336283, 5764.33710123337, 5765.4811067004175, 5790.913136302959, 6280.755122125837, 6310.148130002391, 6337.746490140435, 6344.619322840552, 6350.618962862243, 6010.068439391901, 6087.817365479043, 6114.205153330038, 6118.816435506942, 6120.234970628671, 6002.069679199731, 6103.206583144163, 6105.877882442326, 6144.016957286902, 6147.877042459215, 6130.478909292671, 6147.354527774519, 6151.538634602333, 6157.0, 6160.260768707783, 5971.343152253248, 6140.293866205354, 6150.969245153835, 6151.507879369729, 6166.691665416712, 4668.206404911173, 4675.555822196886, 4717.716936983723, 4746.7389293589185, 4752.833650822205, 4197.711515585878, 4223.282042052859, 4227.196832601796, 4268.445102136764, 4272.764997925144, 5768.653880767168, 5780.53755699543, 5920.052791553331, 5951.464368206882, 6003.0695242237525, 6000.789972350947, 6066.75732970685, 6110.285381942539, 6113.537117903944, 6243.843903902348, 5893.6463812171405, 5931.199288096138, 5945.762169513171, 5956.821295361146, 5976.5218782497295, 5093.719845408464, 5290.92063619046, 5302.2046692996355, 5310.044192045391, 5310.601704872072, 6464.030395440722, 6521.902171467432, 6551.148350714377, 6565.540412171103, 6565.80302590923, 6234.1583886174785, 6257.749690012349, 6271.184745982993, 6273.404026617464, 6314.4632706218645, 6234.470070044097, 6358.872822543616, 6576.210854697467, 6591.110200122922, 6601.042848786995, 6021.608595441282, 6150.384961503813, 6153.353897840662, 6154.938450615616, 6156.045812899008, 6177.444030037318, 6209.2548894133, 6230.221222347207, 6231.626102433868, 6252.968735156295, 5792.797252096157, 5959.433853783884, 6016.699165041818, 6093.329733729375, 6114.2357205349335, 6009.36901625323, 6079.118527813531, 6101.633901965719, 6102.938970610415, 6103.6032657877095, 5961.642301461926, 5979.043353063489, 5986.491148252448, 5992.13114098462, 6008.429199226067, 5837.182794408701, 5939.732712028055, 6035.969820150871, 6057.909576276313, 6086.786962456293, 5927.14056461802, 5976.372480889444, 5979.730912109053, 5981.0729336952845, 5991.131285963598], "value": 5704.220361436565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.7303986246052, 638.7828138432933, 655.3806652713188, 665.8235567574592, 684.2131548718976, 43119.35320970184, 48232.517674823284, 48245.51754482454, 48274.0, 48429.51570484298, 48214.0, 48515.51484485154, 48547.51452485474, 48707.51292487074, 48796.26805597919, 8962.641494340218, 9090.136437038504, 9144.359894807332, 9148.63405463784, 9167.633294668205, 8880.24517915978, 8981.056989016157, 8987.730368088967, 9016.594253258587, 9036.954815225914, 9101.0, 9123.04208058151, 9134.0, 9134.543272836365, 9136.954315228415, 9054.049324820899, 9113.179813816789, 9117.954410227972, 9125.771855703593, 9143.862842057375, 9017.323700722472, 9077.45535267886, 9106.134917182857, 9106.27149828012, 9150.450972941644, 44631.77684111591, 44977.77511112456, 45276.3208551872, 45366.77316613429, 45427.31859022117, 3788.0, 3840.9231815363537, 3916.921661566781, 3974.7813870237123, 4018.136100738326, 34800.82599587011, 35323.82338088319, 35788.46317305243, 35982.64017359819, 36064.819675901716, 4650.306870517529, 4727.716337019755, 4802.711837289774, 4804.23132298834, 4855.5387238212315, 381895.0, 382486.0, 383423.0, 383719.0, 386196.9999999972, 36135.27729445396, 37100.0, 67938.0, 68468.31531684619, 68473.65763171251, 39509.40735888964, 39652.80173599113, 39755.80122099371, 39823.2035359297, 39918.20163596712, 17578.12109394525, 17797.46607601774, 17981.730274045898, 17991.0, 18007.09964501796, 15058.849411505746, 15140.318685659171, 15155.0, 15174.089554626536, 15178.165200914056, 9240.907590924138, 9265.814683706423, 9298.209652179641, 9308.767280818034, 9320.347575669639, 3482.753623912562, 3519.2433626770367, 3559.18138828071, 3559.2189851591315, 3598.7997343838424, 1114.375949468284, 1132.8640563132312, 1142.4173671427632, 1204.349651188366, 1204.4459548607563, 34821.651783481844, 34926.82536587301, 35247.29505409877, 35276.0, 35507.0, 1225.1730082194483, 1227.9570215042431, 1247.1020864977384, 1258.3456602566614, 1261.9432125554372, 18386.908065459585, 18487.729207271, 18491.352802651843, 18511.35210267634, 18775.0, 546345.0, 574861.0, 579716.0, 580655.0, 853317.0, 62911.0, 63052.0, 63441.365586344466, 63477.04784428237, 63638.68180659067, 1505.2548988250885, 1525.862672359493, 1527.0532269992898, 1529.05962832857, 1541.175471122944, 34178.14554636154, 34360.48459273163, 34364.48453273153, 34846.825765871006, 34932.65067349294, 56561.0, 56912.43087569237, 56939.715301423224, 57044.0, 57172.42827571671, 396146.0, 398829.0, 399049.0, 402941.0, 404400.0, 30400.239994000327, 30408.847955760964, 30681.8465907669, 30744.84627576848, 30749.23126921845, 51502.74248628733, 51593.74203128961, 52931.0, 53085.46914530805, 54899.72550137224, 45943.0, 46607.766961164976, 46926.76536617295, 47485.76257118831, 48017.75991120162, 45197.54802451933, 45337.0, 45900.540994589624, 46615.766921165174, 46649.3002604968, 45020.54979450163, 45261.32108018317, 46162.769186153855, 46388.53611463977, 46717.0, 40245.39631905465, 40291.0, 40372.596274036885, 40520.189596208504, 40528.87209929744, 29132.708672913, 29310.560341594468, 29503.26241843971, 29598.55602165926, 29676.40647187001], "value": 20538.242420915645, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.3494713300119, 418.94763154605675, 419.1198483185313, 429.62193269922466, 446.59136889745884, 19191.904040479796, 20350.491237719063, 20998.160073597057, 21563.353099407042, 21608.675869861927, 18316.898151601494, 18367.724484132716, 18717.438476845717, 19114.522136946583, 20331.28840490583, 5645.8588535286635, 5989.161517387569, 5995.370486098962, 6002.8799424011495, 6026.427489388523, 5679.261695979517, 5735.827925162252, 5755.971220143893, 5759.078547432412, 5825.330087039981, 5766.0, 5770.076787713967, 5781.19063331134, 5793.536517078624, 5803.129530570427, 5612.130119831432, 5788.739506722208, 5799.884002319972, 5860.824175274749, 5869.50109240715, 5193.63644544882, 5208.791648334062, 5213.478652134794, 5217.50433708797, 5233.319668443116, 23900.52198956011, 24002.75997240023, 24440.755592444202, 24836.3790905227, 24856.627150592754, 2552.527782360269, 2617.0971014999795, 2622.659054322926, 2664.7601715845667, 2682.4769170011855, 14851.0, 15105.924470377688, 15608.141552214624, 15644.92177539105, 15944.0, 2005.5186755178797, 2053.3429302623167, 2081.5599326932534, 2089.8432617553594, 2105.505206276524, 85021.57489212576, 85094.57452712697, 85498.14501854964, 86180.0, 87612.0, 9458.243340532741, 10027.345487994546, 10030.799384012278, 10122.949385253027, 10621.468926553642, 12868.420921058574, 12935.353232338346, 12956.093073484766, 12980.286084265455, 13071.281079540526, 8368.497890126611, 8377.664893404317, 8396.0, 8443.57782110892, 8493.915060849436, 8793.912060879436, 8892.244159246407, 8926.73219803407, 8977.730668079968, 9071.410358326688, 3983.6695533112875, 3993.2412841560013, 4052.9594704052583, 4056.513218413809, 4084.346504559256, 1875.2499000399675, 1935.2936178295101, 1937.5543624966338, 1974.2004488182308, 2008.5079155606677, 1046.5970601318395, 1047.460557812727, 1050.2963014780116, 1088.086007753475, 1122.3490375582144, 19691.21235150578, 19832.90083549573, 20046.599068018848, 20197.49506262355, 20240.595188096155, 1046.5918291866178, 1056.3133962924007, 1064.5316060933164, 1092.1044743310567, 1111.3054341036852, 11236.719082023015, 11260.43697815106, 11457.968782809421, 11465.0, 11526.423678816192, 507407.0, 509028.0, 519163.0, 526210.0, 526464.0, 99869.0, 100118.4994075025, 100540.49729751305, 102639.48680256552, 103516.48241758742, 1081.70793885652, 1092.9125669946386, 1104.2711810205226, 1115.3865374044406, 1121.6915348279288, 17043.40348087811, 17928.820711792716, 18301.816981830012, 18435.446936591925, 18517.166727497566, 44388.55611443844, 44677.55322446864, 44788.552114478436, 45585.0, 46621.30068048914, 57262.7136864313, 59001.70499147477, 59468.405315946286, 59816.0, 67034.66482667555, 8943.731688049369, 8979.865302020606, 9065.954670226607, 9194.54027298619, 9236.399634023766, 13702.054058377496, 14062.929685351508, 14099.859001409855, 14208.857911420753, 14288.214148221947, 12045.457954392248, 12143.75712485763, 12191.695207619881, 12203.511859525519, 12395.876041239471, 11949.789288981567, 12100.334481603597, 12229.571964981184, 12276.81584776247, 12417.31704756247, 12274.509019639114, 12469.251844889335, 12499.500019999097, 12554.497820087094, 12601.936990314989, 8853.51305678194, 8960.775980600538, 9084.727458176265, 9105.590248438704, 9387.202087822337, 12148.514059437524, 12733.490660373482, 12746.362681865685, 12778.23330600167, 12928.806067909178], "value": 9649.403163562949, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.9851201487986, 1552.6894621075785, 1768.8496477799386, 1949.454152837206, 1956.256622483456, 8765.123487651232, 9513.619455221791, 9524.142827145555, 10173.186145108391, 10244.28290019698, 9559.808803823937, 9852.162566181883, 9923.156531694796, 9926.55330510127, 9965.853926798402, 2512.246326102171, 2536.6195070739445, 2538.9746102538925, 2544.8345857519294, 2546.6689330387026, 2479.442125521752, 2537.581299085649, 2538.7715105640486, 2545.0710490670863, 2546.961795573068, 2529.759672831078, 2531.974680253192, 2579.496998085365, 2589.469158822437, 2594.13096612635, 2466.260121963413, 2469.76537228963, 2487.0797804812155, 2497.7377375375504, 2515.207709571479, 2429.671994280767, 2456.6929133858266, 2482.2801387597574, 2489.0417189382038, 2529.544681957247, 9719.271054670928, 9766.414015159113, 9799.412035277906, 9803.705888823346, 9819.459929703864, 5792.971035144839, 5924.081767326072, 5934.406559344075, 5945.405459454063, 5947.137665038588, 3551.449525323579, 3591.6228795976567, 3651.1602331463914, 3749.268892565951, 3756.380197267448, 1197.7604479104214, 1275.7065874848745, 1288.3939914804519, 1289.4390939941156, 1294.139397300794, 14261.28693565328, 14331.713365732627, 14364.712705745827, 14378.640533986629, 14411.279436028157, 4928.211486162197, 5070.340855688737, 5080.390353157571, 5117.2068329409, 5184.585233181337, 11711.648650540497, 11784.528618855322, 11826.290422574673, 11841.407929603485, 11844.28934263947, 5803.767849286066, 5937.079752638348, 5950.761969521171, 5952.434518720715, 5952.940470595238, 4764.237721964469, 5202.97398513005, 5342.252084708144, 5359.785608575691, 5378.058839703036, 4403.3174857897075, 4423.093265880551, 4486.214912390318, 4489.393931819228, 4538.818447262072, 1412.3644360038024, 1428.8714015738633, 1430.6709456824988, 1467.5817392043216, 1471.2937789860928, 1030.3560274828233, 1107.5237647811518, 1111.4998250787178, 1121.1367247219596, 1142.2917790969486, 6908.516403851682, 6956.339147780953, 6974.0585021022525, 7006.754763583352, 7060.717571297193, 473.8388947757779, 478.18708196066825, 481.9734914579732, 482.7031375703987, 485.41265069265876, 4833.73414462208, 4864.464908860094, 4868.099401610713, 4880.804767809319, 4909.0, 11533.365664888512, 11912.2257053293, 12125.575604853788, 12538.310392928293, 12552.12135150549, 12265.141440099107, 12271.57049503263, 12357.32034738098, 12363.0, 12383.876161238453, 8672.089430609694, 8720.694775682947, 8747.737567872973, 8776.166264205018, 8791.384603077724, 6822.761203357859, 7041.295870412918, 7117.857642847218, 7139.607321597362, 7158.248383919614, 11292.153088518558, 11401.20191586581, 11762.0, 11776.057915366579, 11776.293422394683, 11622.88377116218, 11717.882821172021, 11859.940700296444, 11898.464569094238, 12038.0, 8023.237792409712, 8483.109273526437, 8515.659373624985, 8692.478451292942, 8828.690995815115, 9782.168515676247, 9796.0, 9871.901280987386, 9889.109980101824, 9929.553170107218, 8511.0, 8535.103814099679, 8602.18279263494, 8718.43330183536, 8758.868616970878, 8302.086770455124, 8376.204260595234, 8478.618462169341, 8524.488530688179, 8575.871361929701, 7550.433717471102, 7576.0, 7586.962065189638, 7620.885686714814, 7625.580593067212, 5837.416258374129, 6057.0, 6086.60437071589, 6123.571350005457, 6196.504279657706, 6104.9389506106145, 6135.355787642234, 6156.815295541141, 6192.752289908353, 6217.813465596039], "value": 5103.873310927472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3695243133712, 350.6756250468316, 351.89619062376596, 355.53069947669053, 356.9161247106931, 5641.351244606872, 5689.516391106756, 5700.800471983482, 5701.857453563663, 5760.36635970043, 5645.915311270334, 5660.150977353399, 5679.204911312419, 5686.09022556391, 5688.402717714632, 3959.3370784270674, 4348.673849461287, 4353.825846966118, 4367.2575662137515, 4370.934435983463, 4330.761808100553, 4364.192624364487, 4366.912661746763, 4372.825086996516, 4376.803043863034, 4338.587834155766, 4349.499422699164, 4356.106998065389, 4366.978165109186, 4374.868753937371, 4280.828766849322, 4352.7605981670995, 4362.432883725095, 4381.298992161239, 4389.868303950887, 3814.275287695357, 3822.2928758179823, 3845.1732877431486, 3846.807659617008, 3853.595372485877, 5457.263269458652, 5496.890062198733, 5521.4478552144865, 5530.944690553083, 5563.082091454905, 4935.259711043336, 5022.4726403727445, 5027.49725027498, 5045.763787871995, 5051.873703157414, 5828.9417105828825, 5830.3586605473365, 5904.911426328608, 5931.851703707399, 5934.495567876736, 4279.315309550489, 4289.742615443083, 4308.095299987007, 4324.978375108136, 4340.8480703175555, 5945.492159625798, 6098.420650038239, 6103.176071230371, 6178.783742569033, 6206.224221972254, 4366.279563871925, 4374.825006999748, 4383.189110014658, 4402.933955990663, 4414.757188354672, 4430.601245887886, 4449.555044495589, 4490.101979604092, 4490.663200259928, 4501.459824821042, 4830.589399900978, 4987.276844857475, 5023.472535383805, 5037.614655969564, 5053.343065401475, 5841.970790146022, 5916.408359164049, 5916.674582897982, 5969.9702101285775, 5985.730642121115, 1494.0, 1527.938882444712, 1548.1717281254475, 1554.9144797036272, 1572.2453222453057, 975.9219262458986, 989.1641562879355, 992.6797359511831, 1037.2790910317408, 1071.6088627650852, 5771.134329850556, 5810.750688601971, 5846.795362162304, 5851.502622277154, 5865.325487568899, 6098.573099883054, 6141.07883817431, 6141.907871381933, 6145.600535965148, 6172.506199504029, 5634.0, 5828.358880523139, 5842.503387212135, 5863.589548731633, 5895.616784908967, 3274.7052765250764, 3283.195617073832, 3293.670632936687, 3295.1597342677464, 3299.7955746152484, 6127.662978536134, 6383.265924418658, 6391.648459334689, 6396.872062558723, 6456.322086180978, 6166.876662466815, 6175.59858609189, 6189.721462534197, 6194.907076393858, 6230.190075290183, 6239.502519395403, 6310.013717421125, 6388.584741991755, 6424.74301027963, 6434.903476447857, 6138.048602466625, 6164.4143806338325, 6188.690565471798, 6192.380761923771, 6250.343713909974, 6031.577789554689, 6047.334793172659, 6047.334793172836, 6049.427148941219, 6088.4215999479975, 6237.126802247598, 6315.515853774267, 6321.115043893767, 6325.1144839721555, 6326.060793703872, 4368.2355587772645, 4387.232234359039, 4395.890102747457, 4397.516273209881, 4398.560143985704, 5900.5574581907385, 6066.939330606638, 6094.202210347869, 6109.205803245727, 6125.540584456095, 5928.199693041557, 5950.613210141327, 5960.582759206987, 5970.0746384310505, 6017.578769486094, 5952.987992041277, 5962.344142144448, 5962.628595422991, 5963.254593175853, 5984.162217289496, 5728.856778580569, 5761.39505351932, 5898.94101058984, 5963.0459126539545, 5966.612170208922, 6058.848528786815, 6078.72645730952, 6095.634261944298, 6102.969485152724, 6111.938880611137, 5780.653160810365, 5837.795677151279, 5959.91060134107, 5987.970060149672, 6003.669798160969], "value": 4549.457711875993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.0959896119465, 791.4064451661254, 865.8614621660533, 881.3037700216829, 931.1573026411098, 15519.224038798056, 15944.36222551098, 15959.441419550318, 16588.0, 16837.663246735057, 14537.273136343194, 15496.612584685388, 15875.682486350266, 15907.44323948662, 15957.601059973507, 861.1087524412235, 872.9083446238149, 884.995575022124, 887.7336798960318, 896.2650626486284, 874.899386570543, 878.2622597018503, 878.5387671472496, 884.6903583745669, 888.4269646078276, 926.073926073926, 926.4024704065873, 927.5594092805931, 927.8469052606312, 929.4841363043508, 913.5295322908707, 915.0803442540238, 915.7939463620665, 918.728974952384, 919.6505327975393, 672.4049216443434, 673.8955461903364, 674.4031532094083, 675.6216518749516, 677.0217036382429, 15970.920145399316, 16108.436204732778, 16120.0, 16161.272742726487, 16270.349186032545, 15332.310046047955, 15342.463013794464, 15366.539003829903, 15372.461963831323, 15590.376384944588, 12875.391588845298, 12890.87109128906, 12981.156224845448, 13074.673133171651, 13077.476900923952, 3645.5260816094005, 3752.587215406303, 3757.1922036761953, 3776.4712940188397, 3876.3604005339084, 74816.0, 78075.6096219521, 78797.84808607648, 78885.60557197235, 80027.59986200032, 11765.176437649283, 11857.703557410961, 11958.342291173894, 11959.701007474709, 12041.939790300992, 22280.66579001316, 22316.65675104123, 22439.10243590238, 22516.32451026472, 22635.094596216295, 8465.957670211732, 8628.094050124771, 8661.220490155916, 8705.216530512283, 8928.955355223312, 4988.27669987857, 5052.949470505321, 5066.670666406671, 5067.645264831426, 5196.948030519647, 3492.877749278763, 3588.5155504006625, 3617.7286703497343, 3618.222082252328, 3620.0768803955348, 633.2938773267773, 647.0165348669996, 647.4011539326104, 648.5946283572767, 648.7567162314132, 635.5709895820303, 672.9327067293232, 690.6650274616807, 709.8118998465411, 737.5242968285426, 9672.274579406572, 9833.704988850346, 9894.703158905244, 9976.750581235527, 10057.346272492265, 572.6420986883198, 640.3244576971247, 646.5797231799368, 680.3536640191837, 694.5763084518439, 4567.10941366437, 4675.7895894684825, 4730.881727956828, 4787.569118779326, 4869.074875773592, 117204.0, 117334.41332793453, 118575.0, 122824.0, 123759.3812030934, 60535.23710764578, 61049.69475152596, 78577.0, 102830.0, 107993.0, 90534.64198037035, 93831.53084234535, 93932.53033734788, 94224.52887735654, 94529.5273523628, 8819.11808819113, 8958.148975847284, 9059.139381758723, 9088.681896133869, 9146.49694266795, 52466.0, 52504.0, 53146.20280695715, 54950.72524637351, 55075.89848202933, 73446.63276683583, 79643.0, 79755.60122199352, 80372.59813700894, 81130.0, 10622.787544249226, 10748.462576870968, 10771.838422423827, 11055.0, 11087.72280692989, 11873.406329683654, 11902.642920712393, 12346.567870124503, 12519.436625351698, 12584.056195785535, 10897.891021089688, 11211.775764484828, 11360.431978401211, 11369.829452558384, 11518.07855371585, 11697.0, 11770.470328835394, 12144.817827732415, 13142.60572182836, 13179.868201317864, 12063.276203427471, 12307.507699691912, 12438.37808109609, 12558.246505209716, 12788.552400665933, 10592.390735768236, 10794.082502987334, 10819.513121909376, 10942.234043617189, 11501.309921404743, 10441.477926103817, 10764.138868890626, 11195.552177912792, 11199.0, 11318.547258109913], "value": 7596.201831615142, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 111.0, 112.0, 111.0, 110.0, 111.0, 110.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 154.0, 180.0, 136.0, 157.0, 149.0, 127.0, 186.0, 124.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 162.0, 162.0, 161.0, 161.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 175.0, 75.0, 75.0, 75.0, 76.0, 162.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 138.0, 86.0, 84.0, 85.0, 136.0, 85.0, 83.0, 146.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 146.0, 148.0, 146.0, 146.0, 148.0, 150.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 61.0, 53.0, 51.0, 54.0, 53.0, 53.0, 54.0, 51.0, 55.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 82.0, 78.0, 84.0, 77.0, 77.0, 103.0, 79.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 135.0, 120.0, 118.0, 123.0, 132.0, 127.0, 132.0, 122.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 154.0, 154.0, 155.0, 154.0, 155.0, 153.0, 159.0, 155.0, 154.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 63.0, 63.0, 61.0, 61.0, 62.0, 62.0, 61.0], "value": 62.6, "unit": "score"}]}]} 04:17:29 INFO - Return code: 0 04:17:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:17:29 ERROR - # TBPL SUCCESS # 04:17:29 INFO - Running post-action listener: _resource_record_post_action 04:17:29 INFO - ##### 04:17:29 INFO - ##### Finished run-tests step (success) 04:17:29 INFO - ##### 04:17:29 INFO - Running post-run listener: _resource_record_post_run 04:17:29 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505126912; Read time: 12; Write time: 478076 04:17:29 INFO - TinderboxPrint: CPU usage
13.3% 04:17:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:17:29 INFO - TinderboxPrint: I/O write bytes / time
505,126,912 / 478,076 04:17:29 INFO - TinderboxPrint: CPU idle
8,213.2 (86.7%) 04:17:29 INFO - TinderboxPrint: CPU user
1,209.5 (12.8%) 04:17:29 INFO - TinderboxPrint: Swap in / out
0 / 0 04:17:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252579840; Read time: 0; Write time: 301440 04:17:29 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252547072; Read time: 12; Write time: 176636 04:17:30 INFO - Running post-run listener: _upload_blobber_files 04:17:30 INFO - Blob upload gear active. 04:17:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:30 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 04:17:30 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'] 04:17:30 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 04:17:30 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:17:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:17:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:31 INFO - (blobuploader) - INFO - Done attempting. 04:17:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:17:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:51 INFO - (blobuploader) - INFO - Done attempting. 04:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:17:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:52 INFO - (blobuploader) - INFO - Done attempting. 04:17:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:52 INFO - Return code: 0 04:17:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f983b65b551ade8670cac62b5ff64e9fae151d21614b4b80536606a653362f3ad133454eab8c5ad3289a53f5366a84640ba2b36babe87c30a27b0f0116e8c854", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/412088bf6942756c164260b30e79a1c672118c8ed34b1c1c888765f7cfa1285910fade37298197d0936e7904108aae8e7380713fbecae165fd8ca35250d88400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b798c21899226842040bc8cdc662608452c36a2c348852273cf666fc907f8925603c0d8976dd58de9c84ad2be144c35b6ffcd664cbdc60333ccc27b6b68e1be"} 04:17:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:52 INFO - Contents: 04:17:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f983b65b551ade8670cac62b5ff64e9fae151d21614b4b80536606a653362f3ad133454eab8c5ad3289a53f5366a84640ba2b36babe87c30a27b0f0116e8c854", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/412088bf6942756c164260b30e79a1c672118c8ed34b1c1c888765f7cfa1285910fade37298197d0936e7904108aae8e7380713fbecae165fd8ca35250d88400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b798c21899226842040bc8cdc662608452c36a2c348852273cf666fc907f8925603c0d8976dd58de9c84ad2be144c35b6ffcd664cbdc60333ccc27b6b68e1be"} 04:17:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:52 INFO - Copying logs to upload dir... 04:17:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.940828 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-17 04:17:52.144828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 04:17:52.148780) ========= 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-1468752846.605155-1654954396 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/f983b65b551ade8670cac62b5ff64e9fae151d21614b4b80536606a653362f3ad133454eab8c5ad3289a53f5366a84640ba2b36babe87c30a27b0f0116e8c854", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/412088bf6942756c164260b30e79a1c672118c8ed34b1c1c888765f7cfa1285910fade37298197d0936e7904108aae8e7380713fbecae165fd8ca35250d88400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b798c21899226842040bc8cdc662608452c36a2c348852273cf666fc907f8925603c0d8976dd58de9c84ad2be144c35b6ffcd664cbdc60333ccc27b6b68e1be"} build_url:https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/IALm5pLnTO6kxtegWvLzLg/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/f983b65b551ade8670cac62b5ff64e9fae151d21614b4b80536606a653362f3ad133454eab8c5ad3289a53f5366a84640ba2b36babe87c30a27b0f0116e8c854", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/412088bf6942756c164260b30e79a1c672118c8ed34b1c1c888765f7cfa1285910fade37298197d0936e7904108aae8e7380713fbecae165fd8ca35250d88400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b798c21899226842040bc8cdc662608452c36a2c348852273cf666fc907f8925603c0d8976dd58de9c84ad2be144c35b6ffcd664cbdc60333ccc27b6b68e1be"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 04:17:52.177392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:17:52.177730) ========= 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-1468752846.605155-1654954396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:17:52.259242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 04:17:52.259611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 04:17:52.259916) ========= ========= Total master_lag: 0.20 =========