builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1468504542.53 results: success (0) buildid: 20160714033953 builduid: 3105cf7378654c57ae3a47189abad7a4 revision: 3ad93af112afba86d68faf787d984e10bb4d9971 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:42.530465) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:42.530946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:42.531234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:42.546833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:42.547237) ========= 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=df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 06:55:42-- 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% 227M=0s 2016-07-14 06:55:42 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079902 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:42.641125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:42.641444) ========= 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=df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017255 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:42.690347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:55:42.690730) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3ad93af112afba86d68faf787d984e10bb4d9971 --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 3ad93af112afba86d68faf787d984e10bb4d9971 --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=df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 06:55:42,804 truncating revision to first 12 chars 2016-07-14 06:55:42,804 Setting DEBUG logging. 2016-07-14 06:55:42,804 attempt 1/10 2016-07-14 06:55:42,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3ad93af112af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:55:44,222 unpacking tar archive at: mozilla-aurora-3ad93af112af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.758198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:55:44.464115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:44.464428) ========= script_repo_revision: 3ad93af112afba86d68faf787d984e10bb4d9971 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:44.464831) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:44.465101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:44.474771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-14 06:55:44.476068) ========= /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=df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:55:44 INFO - MultiFileLogger online at 20160714 06:55:44 in /builds/slave/test 06:55:44 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 06:55:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:55:44 INFO - {'append_to_log': False, 06:55:44 INFO - 'base_work_dir': '/builds/slave/test', 06:55:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:55:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:55:44 INFO - 'branch': 'Mozilla-Aurora', 06:55:44 INFO - 'buildbot_json_path': 'buildprops.json', 06:55:44 INFO - 'config_files': ('talos/linux_config.py',), 06:55:44 INFO - 'default_actions': ('clobber', 06:55:44 INFO - 'read-buildbot-config', 06:55:44 INFO - 'download-and-extract', 06:55:44 INFO - 'populate-webroot', 06:55:44 INFO - 'create-virtualenv', 06:55:44 INFO - 'install', 06:55:44 INFO - 'run-tests'), 06:55:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:55:44 INFO - 'download_minidump_stackwalk': True, 06:55:44 INFO - 'download_symbols': 'ondemand', 06:55:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:55:44 INFO - 'tooltool.py': '/tools/tooltool.py', 06:55:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:55:44 INFO - '/tools/misc-python/virtualenv.py')}, 06:55:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:55:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:55:44 INFO - 'installer_path': 'installer.exe', 06:55:44 INFO - 'log_level': 'info', 06:55:44 INFO - 'log_name': 'talos', 06:55:44 INFO - 'log_to_console': True, 06:55:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:55:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:55:44 INFO - 'opt_config_files': (), 06:55:44 INFO - 'pip_index': False, 06:55:44 INFO - 'sps_profile': False, 06:55:44 INFO - 'sps_profile_interval': 0, 06:55:44 INFO - 'suite': 'dromaeojs-e10s', 06:55:44 INFO - 'system_bits': '32', 06:55:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:55:44 INFO - 'title': 'talos-linux64-ix-021', 06:55:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:55:44 INFO - 'use_talos_json': True, 06:55:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:55:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:55:44 INFO - 'work_dir': 'build'} 06:55:44 INFO - ##### 06:55:44 INFO - ##### Running clobber step. 06:55:44 INFO - ##### 06:55:44 INFO - Running pre-action listener: _resource_record_pre_action 06:55:44 INFO - Running main action method: clobber 06:55:44 INFO - rmtree: /builds/slave/test/build 06:55:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:55:45 INFO - Running post-action listener: _resource_record_post_action 06:55:45 INFO - ##### 06:55:45 INFO - ##### Finished clobber step (success) 06:55:45 INFO - ##### 06:55:45 INFO - ##### 06:55:45 INFO - ##### Running read-buildbot-config step. 06:55:45 INFO - ##### 06:55:45 INFO - Running pre-action listener: _resource_record_pre_action 06:55:45 INFO - Running main action method: read_buildbot_config 06:55:45 INFO - Using buildbot properties: 06:55:45 INFO - { 06:55:45 INFO - "project": "", 06:55:45 INFO - "product": "firefox", 06:55:45 INFO - "script_repo_revision": "production", 06:55:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:55:45 INFO - "repository": "", 06:55:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:55:45 INFO - "buildid": "20160714033953", 06:55:45 INFO - "pgo_build": "True", 06:55:45 INFO - "basedir": "/builds/slave/test", 06:55:45 INFO - "buildnumber": 422, 06:55:45 INFO - "slavename": "talos-linux64-ix-021", 06:55:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:55:45 INFO - "platform": "ubuntu64_hw", 06:55:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:55:45 INFO - "branch": "mozilla-aurora", 06:55:45 INFO - "repo_path": "releases/mozilla-aurora", 06:55:45 INFO - "revision": "3ad93af112afba86d68faf787d984e10bb4d9971", 06:55:45 INFO - "stage_platform": "linux64-pgo", 06:55:45 INFO - "builduid": "3105cf7378654c57ae3a47189abad7a4", 06:55:45 INFO - "slavebuilddir": "test" 06:55:45 INFO - } 06:55:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:55:45 INFO - Running post-action listener: _resource_record_post_action 06:55:45 INFO - ##### 06:55:45 INFO - ##### Finished read-buildbot-config step (success) 06:55:45 INFO - ##### 06:55:45 INFO - ##### 06:55:45 INFO - ##### Running download-and-extract step. 06:55:45 INFO - ##### 06:55:45 INFO - Running pre-action listener: _resource_record_pre_action 06:55:45 INFO - Running main action method: download_and_extract 06:55:45 INFO - mkdir: /builds/slave/test/build/tests 06:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:45 INFO - https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:45 INFO - Downloaded 1361 bytes. 06:55:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:55:45 INFO - Using the following test package requirements: 06:55:45 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:55:45 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:55:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:55:45 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:55:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:55:45 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:55:45 INFO - u'jsshell-linux-x86_64.zip'], 06:55:45 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:55:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:55:45 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:55:45 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:55:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:55:45 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:55:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:55:45 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:55:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:55:45 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:55:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:55:45 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:45 INFO - https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:46 INFO - Downloaded 24490909 bytes. 06:55:46 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'] 06:55:46 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 06:55:48 INFO - Return code: 0 06:55:48 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 06:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:48 INFO - https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:49 INFO - Downloaded 24490909 bytes. 06:55:49 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'] 06:55:49 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 06:55:50 INFO - Return code: 0 06:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:50 INFO - https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:55:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:55:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:55:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:51 INFO - Downloaded 10833369 bytes. 06:55:51 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'] 06:55:51 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 06:55:51 INFO - Return code: 0 06:55:51 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')]} 06:55:51 INFO - https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:55:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:55:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:55:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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 06:55:53 INFO - Downloaded 63633130 bytes. 06:55:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:55:53 INFO - mkdir: /builds/slave/test/properties 06:55:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:55:53 INFO - Writing to file /builds/slave/test/properties/build_url 06:55:53 INFO - Contents: 06:55:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:55:54 INFO - Running post-action listener: _resource_record_post_action 06:55:54 INFO - Running post-action listener: set_extra_try_arguments 06:55:54 INFO - ##### 06:55:54 INFO - ##### Finished download-and-extract step (success) 06:55:54 INFO - ##### 06:55:54 INFO - ##### 06:55:54 INFO - ##### Running populate-webroot step. 06:55:54 INFO - ##### 06:55:54 INFO - Running pre-action listener: _resource_record_pre_action 06:55:54 INFO - Running main action method: populate_webroot 06:55:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:54 INFO - '--tppagecycles', 06:55:54 INFO - '7'], 06:55:54 INFO - 'tests': ['tsvgm']}}, 06:55:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:55:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:55:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:55:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:54 INFO - 'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:54 INFO - 'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['damp', 'tps']}, 06:55:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:54 INFO - 'tests': ['damp', 'tps']}, 06:55:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['dromaeo_dom']}, 06:55:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['a11yr', 06:55:54 INFO - 'ts_paint', 06:55:54 INFO - 'tpaint', 06:55:54 INFO - 'sessionrestore', 06:55:54 INFO - 'sessionrestore_no_auto_restore', 06:55:54 INFO - 'tabpaint']}, 06:55:54 INFO - 'other-e10s': {'tests': ['a11yr', 06:55:54 INFO - 'ts_paint', 06:55:54 INFO - 'tpaint', 06:55:54 INFO - 'sessionrestore', 06:55:54 INFO - 'sessionrestore_no_auto_restore', 06:55:54 INFO - 'tabpaint']}, 06:55:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:55:54 INFO - 'ts_paint', 06:55:54 INFO - 'tpaint', 06:55:54 INFO - 'sessionrestore', 06:55:54 INFO - 'sessionrestore_no_auto_restore', 06:55:54 INFO - 'tabpaint']}, 06:55:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:55:54 INFO - 'ts_paint', 06:55:54 INFO - 'tpaint', 06:55:54 INFO - 'sessionrestore', 06:55:54 INFO - 'sessionrestore_no_auto_restore', 06:55:54 INFO - 'tabpaint']}, 06:55:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['a11yr', 06:55:54 INFO - 'ts_paint', 06:55:54 INFO - 'tpaint', 06:55:54 INFO - 'sessionrestore', 06:55:54 INFO - 'sessionrestore_no_auto_restore', 06:55:54 INFO - 'tabpaint']}, 06:55:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['a11yr', 06:55:54 INFO - 'ts_paint', 06:55:54 INFO - 'tpaint', 06:55:54 INFO - 'sessionrestore', 06:55:54 INFO - 'sessionrestore_no_auto_restore', 06:55:54 INFO - 'tabpaint']}, 06:55:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['tsvgx', 06:55:54 INFO - 'tsvgr_opacity', 06:55:54 INFO - 'tart', 06:55:54 INFO - 'tscrollx', 06:55:54 INFO - 'cart']}, 06:55:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:55:54 INFO - 'tsvgr_opacity', 06:55:54 INFO - 'tart', 06:55:54 INFO - 'tscrollx', 06:55:54 INFO - 'cart']}, 06:55:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:54 INFO - 'talos_options': ['--disable-e10s'], 06:55:54 INFO - 'tests': ['tp5o']}, 06:55:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:54 INFO - 'tests': ['tp5o']}, 06:55:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:54 INFO - 'talos_options': ['--disable-e10s', 06:55:54 INFO - '--xperf_path', 06:55:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:54 INFO - 'tests': ['tp5n']}, 06:55:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:54 INFO - 'talos_options': ['--xperf_path', 06:55:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:54 INFO - 'tests': ['tp5n']}}, 06:55:54 INFO - 'talos.zip': {'path': '', 06:55:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:54 INFO - Running post-action listener: _resource_record_post_action 06:55:54 INFO - ##### 06:55:54 INFO - ##### Finished populate-webroot step (success) 06:55:54 INFO - ##### 06:55:54 INFO - ##### 06:55:54 INFO - ##### Running create-virtualenv step. 06:55:54 INFO - ##### 06:55:54 INFO - Running pre-action listener: _resource_record_pre_action 06:55:54 INFO - Running main action method: create_virtualenv 06:55:54 INFO - Creating virtualenv /builds/slave/test/build/venv 06:55:54 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 06:55:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:55:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:54 INFO - Using real prefix '/usr' 06:55:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:55:54 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:56 INFO - Installing pip.................done. 06:55:56 INFO - Return code: 0 06:55:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:56 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:55:56 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 06:55:56 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 06:55:56 INFO - Using env: {'DISPLAY': ':0', 06:55:56 INFO - 'HOME': '/home/cltbld', 06:55:56 INFO - 'LANG': 'en_US.UTF-8', 06:55:56 INFO - 'LANGUAGE': 'en_US:en', 06:55:56 INFO - 'LOGNAME': 'cltbld', 06:55:56 INFO - 'MAIL': '/var/mail/cltbld', 06:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:56 INFO - 'MOZ_NO_REMOTE': '1', 06:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:56 INFO - 'NO_EM_RESTART': '1', 06:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:56 INFO - 'PWD': '/builds/slave/test', 06:55:56 INFO - 'SHELL': '/bin/bash', 06:55:56 INFO - 'SHLVL': '1', 06:55:56 INFO - 'TERM': 'linux', 06:55:56 INFO - 'TMOUT': '86400', 06:55:56 INFO - 'USER': 'cltbld', 06:55:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:56 INFO - '_': '/tools/buildbot/bin/python'} 06:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:56 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 06:55:56 INFO - Cleaning up... 06:55:57 INFO - Return code: 0 06:55:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:55:57 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')]} 06:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:57 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')]} 06:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:57 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:55:57 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 06:55:57 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 06:55:57 INFO - Using env: {'DISPLAY': ':0', 06:55:57 INFO - 'HOME': '/home/cltbld', 06:55:57 INFO - 'LANG': 'en_US.UTF-8', 06:55:57 INFO - 'LANGUAGE': 'en_US:en', 06:55:57 INFO - 'LOGNAME': 'cltbld', 06:55:57 INFO - 'MAIL': '/var/mail/cltbld', 06:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:57 INFO - 'MOZ_NO_REMOTE': '1', 06:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:57 INFO - 'NO_EM_RESTART': '1', 06:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:57 INFO - 'PWD': '/builds/slave/test', 06:55:57 INFO - 'SHELL': '/bin/bash', 06:55:57 INFO - 'SHLVL': '1', 06:55:57 INFO - 'TERM': 'linux', 06:55:57 INFO - 'TMOUT': '86400', 06:55:57 INFO - 'USER': 'cltbld', 06:55:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:57 INFO - '_': '/tools/buildbot/bin/python'} 06:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:57 INFO - Downloading/unpacking psutil>=3.1.1 06:55:57 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 06:55:57 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 06:55:57 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 06:55:57 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 06:55:57 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 06:55:57 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 06:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:59 INFO - Installing collected packages: psutil 06:55:59 INFO - Running setup.py install for psutil 06:55:59 INFO - building 'psutil._psutil_linux' extension 06:55:59 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 06:55:59 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 06:55:59 INFO - building 'psutil._psutil_posix' extension 06:55:59 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 06:55:59 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 06:55:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:59 INFO - Successfully installed psutil 06:55:59 INFO - Cleaning up... 06:55:59 INFO - Return code: 0 06:55:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:59 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:55:59 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 06:55:59 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 06:55:59 INFO - Using env: {'DISPLAY': ':0', 06:55:59 INFO - 'HOME': '/home/cltbld', 06:55:59 INFO - 'LANG': 'en_US.UTF-8', 06:55:59 INFO - 'LANGUAGE': 'en_US:en', 06:55:59 INFO - 'LOGNAME': 'cltbld', 06:55:59 INFO - 'MAIL': '/var/mail/cltbld', 06:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:59 INFO - 'MOZ_NO_REMOTE': '1', 06:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:59 INFO - 'NO_EM_RESTART': '1', 06:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:59 INFO - 'PWD': '/builds/slave/test', 06:55:59 INFO - 'SHELL': '/bin/bash', 06:55:59 INFO - 'SHLVL': '1', 06:55:59 INFO - 'TERM': 'linux', 06:55:59 INFO - 'TMOUT': '86400', 06:55:59 INFO - 'USER': 'cltbld', 06:55:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:59 INFO - '_': '/tools/buildbot/bin/python'} 06:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:56:02 INFO - Installing collected packages: mozsystemmonitor 06:56:02 INFO - Running setup.py install for mozsystemmonitor 06:56:02 INFO - Successfully installed mozsystemmonitor 06:56:02 INFO - Cleaning up... 06:56:02 INFO - Return code: 0 06:56:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:56:02 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')]} 06:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:02 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')]} 06:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:02 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:56:02 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 06:56:02 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 06:56:02 INFO - Using env: {'DISPLAY': ':0', 06:56:02 INFO - 'HOME': '/home/cltbld', 06:56:02 INFO - 'LANG': 'en_US.UTF-8', 06:56:02 INFO - 'LANGUAGE': 'en_US:en', 06:56:02 INFO - 'LOGNAME': 'cltbld', 06:56:02 INFO - 'MAIL': '/var/mail/cltbld', 06:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:02 INFO - 'MOZ_NO_REMOTE': '1', 06:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:02 INFO - 'NO_EM_RESTART': '1', 06:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:02 INFO - 'PWD': '/builds/slave/test', 06:56:02 INFO - 'SHELL': '/bin/bash', 06:56:02 INFO - 'SHLVL': '1', 06:56:02 INFO - 'TERM': 'linux', 06:56:02 INFO - 'TMOUT': '86400', 06:56:02 INFO - 'USER': 'cltbld', 06:56:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:02 INFO - '_': '/tools/buildbot/bin/python'} 06:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:02 INFO - Downloading/unpacking jsonschema==2.5.1 06:56:02 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 06:56:02 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 06:56:02 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 06:56:02 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 06:56:02 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 06:56:02 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 06:56:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:56:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:04 INFO - Downloading functools32-3.2.3-2.tar.gz 06:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:56:04 INFO - warning: no files found matching '*.txt' 06:56:04 INFO - no previously-included directories found matching 'build' 06:56:04 INFO - no previously-included directories found matching 'dist' 06:56:04 INFO - no previously-included directories found matching '.git*' 06:56:04 INFO - Installing collected packages: jsonschema, functools32 06:56:04 INFO - Running setup.py install for functools32 06:56:04 INFO - warning: no files found matching '*.txt' 06:56:04 INFO - no previously-included directories found matching 'build' 06:56:04 INFO - no previously-included directories found matching 'dist' 06:56:04 INFO - no previously-included directories found matching '.git*' 06:56:04 INFO - Successfully installed jsonschema functools32 06:56:04 INFO - Cleaning up... 06:56:04 INFO - Return code: 0 06:56:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:56:04 INFO - Using env: {'DISPLAY': ':0', 06:56:04 INFO - 'HOME': '/home/cltbld', 06:56:04 INFO - 'LANG': 'en_US.UTF-8', 06:56:04 INFO - 'LANGUAGE': 'en_US:en', 06:56:04 INFO - 'LOGNAME': 'cltbld', 06:56:04 INFO - 'MAIL': '/var/mail/cltbld', 06:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:04 INFO - 'MOZ_NO_REMOTE': '1', 06:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:04 INFO - 'NO_EM_RESTART': '1', 06:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:04 INFO - 'PWD': '/builds/slave/test', 06:56:04 INFO - 'SHELL': '/bin/bash', 06:56:04 INFO - 'SHLVL': '1', 06:56:04 INFO - 'TERM': 'linux', 06:56:04 INFO - 'TMOUT': '86400', 06:56:04 INFO - 'USER': 'cltbld', 06:56:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:04 INFO - '_': '/tools/buildbot/bin/python'} 06:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:05 INFO - Downloading/unpacking blobuploader==1.2.4 06:56:05 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 06:56:05 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 06:56:05 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 06:56:05 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 06:56:05 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 06:56:05 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 06:56:06 INFO - Downloading blobuploader-1.2.4.tar.gz 06:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:56:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:56:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:07 INFO - Downloading docopt-0.6.1.tar.gz 06:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:56:07 INFO - Installing collected packages: blobuploader, requests, docopt 06:56:07 INFO - Running setup.py install for blobuploader 06:56:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:56:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:56:07 INFO - Running setup.py install for requests 06:56:08 INFO - Running setup.py install for docopt 06:56:08 INFO - Successfully installed blobuploader requests docopt 06:56:08 INFO - Cleaning up... 06:56:08 INFO - Return code: 0 06:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:08 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:56:08 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 06:56:08 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 06:56:08 INFO - Using env: {'DISPLAY': ':0', 06:56:08 INFO - 'HOME': '/home/cltbld', 06:56:08 INFO - 'LANG': 'en_US.UTF-8', 06:56:08 INFO - 'LANGUAGE': 'en_US:en', 06:56:08 INFO - 'LOGNAME': 'cltbld', 06:56:08 INFO - 'MAIL': '/var/mail/cltbld', 06:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:08 INFO - 'MOZ_NO_REMOTE': '1', 06:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:08 INFO - 'NO_EM_RESTART': '1', 06:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:08 INFO - 'PWD': '/builds/slave/test', 06:56:08 INFO - 'SHELL': '/bin/bash', 06:56:08 INFO - 'SHLVL': '1', 06:56:08 INFO - 'TERM': 'linux', 06:56:08 INFO - 'TMOUT': '86400', 06:56:08 INFO - 'USER': 'cltbld', 06:56:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:08 INFO - '_': '/tools/buildbot/bin/python'} 06:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:56:08 INFO - Running setup.py (path:/tmp/pip-Px_PS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:56:08 INFO - Running setup.py (path:/tmp/pip-jr7AL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:56:08 INFO - Running setup.py (path:/tmp/pip-qd4duW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:56:08 INFO - Running setup.py (path:/tmp/pip-rK4BJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:56:08 INFO - Running setup.py (path:/tmp/pip-i1y6KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:56:08 INFO - Running setup.py (path:/tmp/pip-YnMdWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:56:09 INFO - Running setup.py (path:/tmp/pip-C0obK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:56:09 INFO - Running setup.py (path:/tmp/pip-482oaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:56:09 INFO - Running setup.py (path:/tmp/pip-NW40vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:56:09 INFO - Running setup.py (path:/tmp/pip-F0Cl4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:56:09 INFO - Running setup.py (path:/tmp/pip-R5R1PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:56:09 INFO - Running setup.py (path:/tmp/pip-VyZ_xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:56:09 INFO - Running setup.py (path:/tmp/pip-j7B3xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:56:09 INFO - Running setup.py (path:/tmp/pip-VDcVjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:09 INFO - Running setup.py (path:/tmp/pip-Xkn7Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:56:09 INFO - Running setup.py (path:/tmp/pip-F4qcbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:56:09 INFO - Running setup.py (path:/tmp/pip-rW_jQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:56:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:56:09 INFO - Running setup.py install for manifestparser 06:56:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:56:09 INFO - Running setup.py install for mozcrash 06:56:10 INFO - Running setup.py install for mozdebug 06:56:10 INFO - Running setup.py install for mozdevice 06:56:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Running setup.py install for mozfile 06:56:10 INFO - Running setup.py install for mozhttpd 06:56:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Running setup.py install for mozinfo 06:56:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Running setup.py install for mozInstall 06:56:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Running setup.py install for mozleak 06:56:10 INFO - Running setup.py install for mozlog 06:56:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Running setup.py install for moznetwork 06:56:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:56:10 INFO - Running setup.py install for mozprocess 06:56:11 INFO - Running setup.py install for mozprofile 06:56:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:56:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:56:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:56:11 INFO - Running setup.py install for mozrunner 06:56:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:56:11 INFO - Running setup.py install for mozscreenshot 06:56:11 INFO - Running setup.py install for moztest 06:56:11 INFO - Running setup.py install for mozversion 06:56:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:56:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:56:11 INFO - Cleaning up... 06:56:11 INFO - Return code: 0 06:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:11 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:56:11 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 06:56:11 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 06:56:11 INFO - Using env: {'DISPLAY': ':0', 06:56:11 INFO - 'HOME': '/home/cltbld', 06:56:11 INFO - 'LANG': 'en_US.UTF-8', 06:56:11 INFO - 'LANGUAGE': 'en_US:en', 06:56:11 INFO - 'LOGNAME': 'cltbld', 06:56:11 INFO - 'MAIL': '/var/mail/cltbld', 06:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:11 INFO - 'MOZ_NO_REMOTE': '1', 06:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:11 INFO - 'NO_EM_RESTART': '1', 06:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:11 INFO - 'PWD': '/builds/slave/test', 06:56:11 INFO - 'SHELL': '/bin/bash', 06:56:11 INFO - 'SHLVL': '1', 06:56:11 INFO - 'TERM': 'linux', 06:56:11 INFO - 'TMOUT': '86400', 06:56:11 INFO - 'USER': 'cltbld', 06:56:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:11 INFO - '_': '/tools/buildbot/bin/python'} 06:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:56:11 INFO - Running setup.py (path:/tmp/pip-5jZAR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:56:11 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)) 06:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:56:11 INFO - Running setup.py (path:/tmp/pip-9hlmci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:56:11 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)) 06:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:56:11 INFO - Running setup.py (path:/tmp/pip-h7CVyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:56:12 INFO - Running setup.py (path:/tmp/pip-viVscw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:56:12 INFO - Running setup.py (path:/tmp/pip-HVGMbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:56:12 INFO - Running setup.py (path:/tmp/pip-yhKFvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:56:12 INFO - Running setup.py (path:/tmp/pip-ujGYe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:56:12 INFO - Running setup.py (path:/tmp/pip-PpgW_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:56:12 INFO - Running setup.py (path:/tmp/pip-WvWfvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:56:12 INFO - Running setup.py (path:/tmp/pip-DVDx0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:56:12 INFO - Running setup.py (path:/tmp/pip-wvx7G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:56:12 INFO - Running setup.py (path:/tmp/pip-WV4erk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:56:12 INFO - Running setup.py (path:/tmp/pip-4dsMNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:56:12 INFO - Running setup.py (path:/tmp/pip-TKugoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:12 INFO - Running setup.py (path:/tmp/pip-rYcviK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:56:12 INFO - Running setup.py (path:/tmp/pip-Wn35Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:56:12 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)) 06:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:56:12 INFO - Running setup.py (path:/tmp/pip-nanvTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:56:13 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)) 06:56:13 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)) 06:56:13 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)) 06:56:13 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)) 06:56:13 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)) 06:56:13 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)) 06:56:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:14 INFO - Downloading blessings-1.6.tar.gz 06:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:56:15 INFO - Installing collected packages: blessings 06:56:15 INFO - Running setup.py install for blessings 06:56:15 INFO - Successfully installed blessings 06:56:15 INFO - Cleaning up... 06:56:15 INFO - Return code: 0 06:56:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:56:15 INFO - Reading from file tmpfile_stdout 06:56:15 INFO - Current package versions: 06:56:15 INFO - argparse == 1.2.1 06:56:15 INFO - blessings == 1.6 06:56:15 INFO - blobuploader == 1.2.4 06:56:15 INFO - docopt == 0.6.1 06:56:15 INFO - functools32 == 3.2.3-2 06:56:15 INFO - jsonschema == 2.5.1 06:56:15 INFO - manifestparser == 1.1 06:56:15 INFO - mozInstall == 1.12 06:56:15 INFO - mozcrash == 0.17 06:56:15 INFO - mozdebug == 0.1 06:56:15 INFO - mozdevice == 0.48 06:56:15 INFO - mozfile == 1.2 06:56:15 INFO - mozhttpd == 0.7 06:56:15 INFO - mozinfo == 0.9 06:56:15 INFO - mozleak == 0.1 06:56:15 INFO - mozlog == 3.2 06:56:15 INFO - moznetwork == 0.27 06:56:15 INFO - mozprocess == 0.23 06:56:15 INFO - mozprofile == 0.28 06:56:15 INFO - mozrunner == 6.12 06:56:15 INFO - mozscreenshot == 0.1 06:56:15 INFO - mozsystemmonitor == 0.3 06:56:15 INFO - moztest == 0.7 06:56:15 INFO - mozversion == 1.4 06:56:15 INFO - psutil == 3.1.1 06:56:15 INFO - requests == 1.2.3 06:56:15 INFO - wsgiref == 0.1.2 06:56:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:15 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:56:15 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 06:56:15 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 06:56:15 INFO - Using env: {'DISPLAY': ':0', 06:56:15 INFO - 'HOME': '/home/cltbld', 06:56:15 INFO - 'LANG': 'en_US.UTF-8', 06:56:15 INFO - 'LANGUAGE': 'en_US:en', 06:56:15 INFO - 'LOGNAME': 'cltbld', 06:56:15 INFO - 'MAIL': '/var/mail/cltbld', 06:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:15 INFO - 'MOZ_NO_REMOTE': '1', 06:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:15 INFO - 'NO_EM_RESTART': '1', 06:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:15 INFO - 'PWD': '/builds/slave/test', 06:56:15 INFO - 'SHELL': '/bin/bash', 06:56:15 INFO - 'SHLVL': '1', 06:56:15 INFO - 'TERM': 'linux', 06:56:15 INFO - 'TMOUT': '86400', 06:56:15 INFO - 'USER': 'cltbld', 06:56:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:15 INFO - '_': '/tools/buildbot/bin/python'} 06:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 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)) 06:56:15 INFO - Cleaning up... 06:56:15 INFO - Return code: 0 06:56:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:15 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:56:15 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 06:56:15 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 06:56:15 INFO - Using env: {'DISPLAY': ':0', 06:56:15 INFO - 'HOME': '/home/cltbld', 06:56:15 INFO - 'LANG': 'en_US.UTF-8', 06:56:15 INFO - 'LANGUAGE': 'en_US:en', 06:56:15 INFO - 'LOGNAME': 'cltbld', 06:56:15 INFO - 'MAIL': '/var/mail/cltbld', 06:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:15 INFO - 'MOZ_NO_REMOTE': '1', 06:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:15 INFO - 'NO_EM_RESTART': '1', 06:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:15 INFO - 'PWD': '/builds/slave/test', 06:56:15 INFO - 'SHELL': '/bin/bash', 06:56:15 INFO - 'SHLVL': '1', 06:56:15 INFO - 'TERM': 'linux', 06:56:15 INFO - 'TMOUT': '86400', 06:56:15 INFO - 'USER': 'cltbld', 06:56:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:15 INFO - '_': '/tools/buildbot/bin/python'} 06:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:56:15 INFO - Cleaning up... 06:56:15 INFO - Return code: 0 06:56:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:15 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 0x7fd77d535f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, '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': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', '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 06:56:15 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 06:56:15 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 06:56:15 INFO - Using env: {'DISPLAY': ':0', 06:56:15 INFO - 'HOME': '/home/cltbld', 06:56:15 INFO - 'LANG': 'en_US.UTF-8', 06:56:15 INFO - 'LANGUAGE': 'en_US:en', 06:56:15 INFO - 'LOGNAME': 'cltbld', 06:56:15 INFO - 'MAIL': '/var/mail/cltbld', 06:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:15 INFO - 'MOZ_NO_REMOTE': '1', 06:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:15 INFO - 'NO_EM_RESTART': '1', 06:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:15 INFO - 'PWD': '/builds/slave/test', 06:56:15 INFO - 'SHELL': '/bin/bash', 06:56:15 INFO - 'SHLVL': '1', 06:56:15 INFO - 'TERM': 'linux', 06:56:15 INFO - 'TMOUT': '86400', 06:56:15 INFO - 'USER': 'cltbld', 06:56:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:15 INFO - '_': '/tools/buildbot/bin/python'} 06:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:16 INFO - Downloading/unpacking flake8 06:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:56:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:56:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 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 06:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:56:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:56:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:56:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:56:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:56:18 INFO - no previously-included directories found matching 'docs/_build' 06:56:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:56:18 INFO - Running setup.py install for pep8 06:56:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:56:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:56:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:56:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:56:18 INFO - no previously-included directories found matching 'docs/_build' 06:56:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:56:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:56:19 INFO - Cleaning up... 06:56:19 INFO - Return code: 0 06:56:19 INFO - Running post-action listener: _resource_record_post_action 06:56:19 INFO - Running post-action listener: _start_resource_monitoring 06:56:19 INFO - Starting resource monitoring. 06:56:19 INFO - ##### 06:56:19 INFO - ##### Finished create-virtualenv step (success) 06:56:19 INFO - ##### 06:56:19 INFO - ##### 06:56:19 INFO - ##### Running install step. 06:56:19 INFO - ##### 06:56:19 INFO - Running pre-action listener: _resource_record_pre_action 06:56:19 INFO - Running main action method: install 06:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:56:19 INFO - Reading from file tmpfile_stdout 06:56:19 INFO - Detecting whether we're running mozinstall >=1.0... 06:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:56:19 INFO - Reading from file tmpfile_stdout 06:56:19 INFO - Output received: 06:56:19 INFO - Usage: mozinstall [options] installer 06:56:19 INFO - Options: 06:56:19 INFO - -h, --help show this help message and exit 06:56:19 INFO - -d DEST, --destination=DEST 06:56:19 INFO - Directory to install application into. [default: 06:56:19 INFO - "/builds/slave/test"] 06:56:19 INFO - --app=APP Application being installed. [default: firefox] 06:56:19 INFO - mkdir: /builds/slave/test/build/application 06:56:19 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'] 06:56:19 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 06:56:36 INFO - Reading from file tmpfile_stdout 06:56:36 INFO - Output received: 06:56:36 INFO - /builds/slave/test/build/application/firefox/firefox 06:56:36 INFO - Running post-action listener: _resource_record_post_action 06:56:36 INFO - ##### 06:56:36 INFO - ##### Finished install step (success) 06:56:36 INFO - ##### 06:56:36 INFO - ##### 06:56:36 INFO - ##### Running run-tests step. 06:56:36 INFO - ##### 06:56:36 INFO - Running pre-action listener: _resource_record_pre_action 06:56:36 INFO - Running main action method: run_tests 06:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:56:36 INFO - Python 2.7.3 06:56:36 INFO - Return code: 0 06:56:36 INFO - grabbing minidump binary from tooltool 06:56:36 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')]} 06:56:36 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 0x1ee81c0>, '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 0x1ee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:56:36 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 06:56:36 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 06:56:36 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 06:56:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:36 INFO - Return code: 0 06:56:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:56:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:56:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:56:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:56:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:56:37 INFO - Return code: 0 06:56:37 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/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:56:37 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/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 06:56:37 INFO - Using env: {'DISPLAY': ':0', 06:56:37 INFO - 'HOME': '/home/cltbld', 06:56:37 INFO - 'LANG': 'en_US.UTF-8', 06:56:37 INFO - 'LANGUAGE': 'en_US:en', 06:56:37 INFO - 'LOGNAME': 'cltbld', 06:56:37 INFO - 'MAIL': '/var/mail/cltbld', 06:56:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:56:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:37 INFO - 'MOZ_NO_REMOTE': '1', 06:56:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:37 INFO - 'NO_EM_RESTART': '1', 06:56:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:37 INFO - 'PWD': '/builds/slave/test', 06:56:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:56:37 INFO - 'SHELL': '/bin/bash', 06:56:37 INFO - 'SHLVL': '1', 06:56:37 INFO - 'TERM': 'linux', 06:56:37 INFO - 'TMOUT': '86400', 06:56:37 INFO - 'USER': 'cltbld', 06:56:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179', 06:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:37 INFO - '_': '/tools/buildbot/bin/python'} 06:56:37 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/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:56:37 INFO - mozversion application_buildid: 20160714033953 06:56:37 INFO - mozversion application_changeset: 3ad93af112afba86d68faf787d984e10bb4d9971 06:56:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:56:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:37 INFO - mozversion application_name: Firefox 06:56:37 INFO - mozversion application_remotingname: firefox-dev 06:56:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:56:37 INFO - mozversion application_vendor: Mozilla 06:56:37 INFO - mozversion application_version: 49.0a2 06:56:37 INFO - mozversion platform_buildid: 20160714033953 06:56:37 INFO - mozversion platform_changeset: 3ad93af112afba86d68faf787d984e10bb4d9971 06:56:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:56:37 INFO - mozversion platform_version: 49.0a2 06:56:37 INFO - using testdate: 1468504597 06:56:37 INFO - actual date: 1468504597 06:56:37 INFO - starting webserver on 'localhost:38935' 06:56:37 INFO - SUITE-START | Running 2 tests 06:56:37 INFO - TEST-START | dromaeo_css 06:56:37 INFO - operating with platform_type : linux_ 06:56:37 INFO - Initialising browser for dromaeo_css test... 06:56:37 INFO - TEST-INFO | started process 16435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61SfSU/profile http://localhost:38935/getInfo.html) 06:56:43 INFO - PROCESS | 16435 | __metrics Screen width/height:1600/1200 06:56:43 INFO - PROCESS | 16435 | colorDepth:24 06:56:43 INFO - PROCESS | 16435 | Browser inner width/height: 1024/697 06:56:43 INFO - PROCESS | 16435 | __metrics 06:56:44 ERROR - PROCESS | 16435 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:56:45 INFO - TEST-INFO | 16435: exit 0 06:56:45 INFO - Browser initialized. 06:56:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:56:45 INFO - TEST-INFO | started process 16567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61SfSU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:57 INFO - PROCESS | 16567 | RSS: Main: 155664384 06:56:57 INFO - PROCESS | 16567 | 06:57:46 INFO - PROCESS | 16567 | 1468504666898 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] 06:59:55 INFO - PROCESS | 16567 | Cycle 1(1): loaded http://localhost:38935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38935/tests/dromaeo/cssquery-ext.html) 06:59:56 INFO - PROCESS | 16567 | RSS: Main: 160059392 06:59:56 INFO - PROCESS | 16567 | 07:02:58 INFO - PROCESS | 16567 | Cycle 1(1): loaded http://localhost:38935/tests/dromaeo/cssquery-ext.html (next: http://localhost:38935/tests/dromaeo/cssquery-jquery.html) 07:02:58 INFO - PROCESS | 16567 | RSS: Main: 157396992 07:02:58 INFO - PROCESS | 16567 | 07:06:00 INFO - PROCESS | 16567 | Cycle 1(1): loaded http://localhost:38935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38935/tests/dromaeo/cssquery-mootools.html) 07:06:01 INFO - PROCESS | 16567 | RSS: Main: 157175808 07:06:01 INFO - PROCESS | 16567 | 07:09:02 INFO - PROCESS | 16567 | Cycle 1(1): loaded http://localhost:38935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38935/tests/dromaeo/cssquery-prototype.html) 07:09:03 INFO - PROCESS | 16567 | RSS: Main: 155717632 07:09:03 INFO - PROCESS | 16567 | 07:12:06 INFO - PROCESS | 16567 | Cycle 1(1): loaded http://localhost:38935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38935/tests/dromaeo/cssquery-yui.html) 07:12:06 INFO - PROCESS | 16567 | RSS: Main: 157409280 07:12:06 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | Cycle 1(1): loaded http://localhost:38935/tests/dromaeo/cssquery-yui.html (next: http://localhost:38935/tests/dromaeo/cssquery-dojo.html) 07:15:09 INFO - PROCESS | 16567 | RSS: Main: 158638080 07:15:09 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | __start_tp_report 07:15:09 INFO - PROCESS | 16567 | _x_x_mozilla_page_load 07:15:09 INFO - PROCESS | 16567 | _x_x_mozilla_page_load_details 07:15:09 INFO - PROCESS | 16567 | |i|pagename|runs| 07:15:09 INFO - PROCESS | 16567 | |0;dojo.html;3346.682065203805;3393.2874096439746;3398.405279076161;3403.8808641697547;3419.059758566394;5633.690147041911;5670.376258611549;5686;5694.060480020791;5701.6864072476;5689.374168841424;5733.885322293551;5751;5751.712414379285;5761.251037365137;5007.799688012484;5121.615878809085;5166.095933211673;5173.198154286091;5207.583393328544;5064;5073.264376665381;5210.140326846066;5228.895422091556;5236.502532259448;5125.538701516863;5159.432462429129;5160.14857548504;5212.322398088243;5312.2828418163435;5193.740312984354;5208.791648334062;5209.192575150858;5216.58267338612;5221.6083793715625;4933.506649335073;5020.0963826511215;5120.974395128038;5140.922886156711;5182.844514664566;5425.104857698475;5487.533559647435;5503.147012213113;5546.77812887484;5561.110222364402;5965.433283838029;5984.73068711909;6015.398460153993;6048.576599638027;6050.939490605082;5948.672822994734;6056.848578785565;6068.453839154453;6096.908546371808;6101.694915254264;5597.608167428281;5610.635308704921;5612.971935140339;5621.269234999424;5627.943720562783;6176.35148309421;6188.226471691039;6189.35011823761;6193.102000210034;6205.968970155211;5948.672822994777;5949.672767997802;5953.821385358447;6008.21893153896;6036.034234522455;6040.728167232485;6117.296510901303;6124.755009799558;6128.264608247039;6153.907691384543;5882.705864706748;6064.4541991221;6079.057746049281;6082.452579267887;6082.847928801727;5931.881362372728;5971.104334349882;6047.15339852421;6069.696515174223;6071.423214794588;4658.324542941255;4675.251959686434;4677.579017888406;4686.601638860667;4714.717116972993;4075.5313138988804;4123.670106391482;4184.351425528987;4186.434831297796;4216.789160542022;5661.34894487131;5685;5697.971510142423;5753.510951569164;5803.361630220672;6067.029275315928;6120.112583675342;6132.877342453126;6136.417040381157;6143.662098584621;5654.773809047592;5725.198472213893;5851.034579294454;5858.707064646751;5858.8242352729485;5166.173412254021;5190.351206099238;5222.268882356473;5240.633155679066;5257.316548848626;6275.246970363585;6327.050942358683;6328.525360597973;6335.303116657164;6350.142730731292;5953.255843019622;5971.641701497924;6044.455998960115;6049.697515124139;6077.088436734437;6317.399847014526;6334.556581039283;6336.556441049082;6349.142865713255;6367.586106903036;5966.880662386815;5975.43233392827;5976.073708575178;5984.281886173513;5991.400859913973;5947.375525569752;5976.8804623908145;6001.729922153426;6040.395960403925;6076.605020673642;5885.47030767233;5928;5936.050231962865;5943.58394912352;5955.731992060454;5823.94176058234;5923.614965027259;5934.7922822701;5951.375105614022;5952.0476723724;5657.2079908811975;5728.856778580569;5738.598298119092;5779.537636988946;5822.243108395882;5902.61632993854;5919.289685237799;5943.108533719977;5948.583599148018;5953.613015154001;5717.142428635571;5806.796762113306;5829.417058294137;5833.883322333614;5838.065909454637 07:15:09 INFO - PROCESS | 16567 | |1;ext.html;603.954703397245;655.3675702946656;662.4170729757813;665.0556210181545;672.3175976383972;47603;49290;49404;49549.50450495494;52606;49306.75346623271;49381;49638.75180624101;49642.75178624102;49711.50288497114;9038.683646072388;9186.219171370409;9188.540572971324;9192.632294708237;9195.172434480895;8849.778755531099;8890.155435233642;8940.508272045035;8998.235150012224;9009.909900901006;8996.370254082216;9017.143371379709;9025.277977761796;9039.728808135766;9053.185213330798;8967.237784788302;9003.14470125337;9004.819903601956;9039.096090390909;9042.593083311267;9020.729378118602;9056.909430905673;9072.27421806254;9096.954515227448;9122.680706175319;44659.33011004805;44664.55335446636;45015.54984450179;45018.32472512915;45082.54917450816;3733;3884.261990221849;4043;4277.486701595828;4308.159908817782;35143.64856351455;35405.29189416223;35513.28973420543;35693.64306356929;35857.641423585694;4640.721556706575;4738.265568836836;4741.9288710669025;4763.666543341968;4870.805167793319;372697;373608;373772;374581;374720.126399369;65836;65917.34082659207;65984.67007664932;65985;66043;40109.19781604352;40948.590514094474;41208.587914121075;42992;43064.78467607642;18046.2781488739;18185.45443636693;18305.542361441072;18321.7251741224;18386.724199137025;13655.590332290047;13789.724205516035;13814.723705525834;13851.653708657162;13853.376598053112;21515;21535.784642153692;21748.45628859291;21816;21880.23419180321;7498.925010749823;7728.22717728234;7753.147153813189;7930.5638189898955;7938.880916786253;1110.9222354435274;1156.531604700081;1201.9399030048462;1206.90344772418;1217.652968903876;33708.49437258443;33924.32151357008;34064;34889.12777180591;35087.29825403477;1177.581958404771;1184.3190165654783;1202.0056664558772;1219.2501611508858;1361.1968938326436;18102.728459073125;18252.087395630166;18323.35868244605;18343.63312733738;18452.630947381247;611519;626045;662978;664883;994005;55722.16416753752;60969;61076;61130.38869611336;61156.082658760155;1491.8881083918532;1510.9697806044037;1511.7203317386318;1514.3109885002298;1519.323900864127;32105;32756.83621581877;32878.506822397205;32937.17657058497;33612.831935840164;52320;53009.469905301994;53071;53322;53446.46553534415;392552;398519;400351;400901;402971;30143.698563014088;30243.546346805255;30475.695243048172;30516.542251865794;30847.2288192797;48770.26844597263;48777.2683409742;48988.2651760231;49157.2626410597;49574.50425495699;41131.38302925519;41176;41190.1761964765;42659.360109599;43002.569974299855;40234.79882600568;40780.71802460699;41061.58938410578;42535;42710.93222669334;40998.79500602478;41802;42001.159976800904;42678;42747.57252427436;32814.34371312608;33241.501377478875;33594;33832.323353533284;34185;28500.144995650164;28733;28845.56731648985;29175.562366564944;29423.85288073546 07:15:09 INFO - PROCESS | 16567 | |2;jquery.html;430.2706911784525;436.22654172033157;437.78548511229496;439.78670344882744;443.7670223132853;19132.521686957814;20188.495287617818;20702.89648551757;21235;21359.893200533974;17707.822921770778;17734.46796596101;18593.628127437478;18655.906720466413;18708.345207917726;5691.686957217341;5880.059190529516;5882.4705776480105;5911;5924.2298501195;4782.995570930108;5865.384134665863;5931.110333449996;6277.309495955441;6287.591306565058;5505.807296744615;6261.561690681654;6296.212973378328;6335.619862808247;6343.904841427359;5753.683547404891;5856.15085812559;5874.73563689635;5876.4123587641325;5886.941130588703;5727.627704199213;5905.704714764288;5923.229980102602;5943.4056594340655;5949.226600541945;13625.931870340584;14062.507812226522;14072.22602756848;14121.435142594284;14345.856541434556;2371.22935046109;2415.758424157588;2489.576771948773;2501.3246423465744;2696.5550684137093;10612.151027917747;10683.14534837211;10708.839367409417;10868.782624347548;10924.28992115518;2006.5786184901187;2028.6855537391727;2085.7392825896763;2141.753698324697;2157.8921053947397;82406.58796706038;85451.57274213589;89208;89885.55057224672;90097.54951225268;11006.284591501526;11243;11318.60384886525;11529.942350288362;11604.76790464186;16512.66974660524;16596.668066638842;16615.584610384838;16651.50045498637;16658.91670541664;8109.75670729879;8178;8236.629351679188;8321.04308004575;8334.6666133354;7452.180260171377;7586.734464293833;7602.46782725215;7655.846883062419;7747.147813740484;4839.225723884161;4928.975355123202;5000.64995450315;5065.088284108822;5100.795968161232;2069.795667613986;2084.9061792219386;2128.8829114398545;2133.14674130346;2172.7175467189163;1013.7110923386799;1144.959926402572;1177.7644471105814;1188.7147084699782;1191.124523475245;19586;19878.204871805254;20241.898790505955;20325.491862703257;20494.487637809176;1105.2539535813294;1113.7104352868312;1115.570505355444;1124.7131981344705;1141.8173092305192;11159.497822598003;11367.829482557769;11373.31760094397;11390.829137562943;11504.25222360544;533738;534885;541389;544017;548387;59277.703611481666;83712;89492.5525372382;99636.50181749045;107401;937.2033771294346;951.7144856543009;970.4516947924541;974.8635191073255;988.4909271725068;18452.538686532946;18545.629087418445;18546.16542255629;18546.721799172752;18649.160787764853;42729.359059614755;42799;43175;43710.34434483549;45071.77464112658;56629;58231.70884145552;58525.70737146287;60944;61234.38765612465;5737.282839645044;7703.537787732754;8035.839283214186;8907.287417006753;8940;13308.733825323632;13499.460021599027;13508.797368039684;13587.883113278664;14255.786163207767;12511.499540018298;12657.746845063231;12703.301318427575;12822.807657885325;12917.160384574972;11959.521619135137;12191.329476878502;12468.750624987631;12651.240925544496;12941.935290323489;12721.236725796482;13016.934915325362;13078;13127.277999710108;13164.736705266032;8110.756677299691;8126.106128325761;8225.506469611842;8238.83522329562;8571.22858942698;9385.671501497414;12542.372881355714;12848.935755321163;12962.092653514164;12985.675358116123 07:15:09 INFO - PROCESS | 16567 | |3;mootools.html;1569.2702893154685;1578.9131597762123;1776.5203395083329;1876.8123187681242;1889.5559543507272;7929.76210713678;8806.20744133028;8849.29205663547;9310.86033709494;9430.528473576329;8761.342899282563;9122.680706175284;9123.498207598595;9132.132447417502;9159.42782314896;2294.9311520654323;2347.307544274443;2366.4438856868624;2369.8222633302485;2375.6080246759266;2389.880505974703;2405.891734871935;2425.8180636452335;2429.8177636677233;2443.6456713776493;2396.8561886286793;2423.164008417102;2428.7571242875747;2440.6583078369044;2448.2655203438985;2365.2549446924163;2367.6803631509697;2378.6432035194684;2381.1189859752003;2382.5711371953043;2347.2371479269136;2368.976310236893;2384.320468666439;2413.191580820427;2415.5651982643117;9091.454512729257;9200.079992000814;9203.723888283363;9209.079092090804;9217.124373184537;5200.245964335188;5311.601629877736;5336.43967383423;5341.065313570149;5341.973290133564;3550.3076900004507;3553.218291975761;3606.6213047629885;3611.494390785292;3624.1845584743487;1198.8561372635252;1212.8423304970297;1223.1988047828686;1235.0366713963033;1274.356449992757;12653;12782.233066015975;12804.295763732991;12812.61562153137;12823.679408014781;4659.068186362673;4750.809967601257;4803.375561177095;4823.348847905558;4857.489963553847;10779;10813.134949204044;10815.67552973412;10819.404932728617;10831.620893268699;5321.760520776575;5360.70516121617;5395.244665746799;5413.296271484682;5425.728713564306;4358.302671572533;4558.954410455919;4636.8145274188655;4678.883027924329;5005.74971251436;4091.9590804091577;4119.397064656847;4126.071633882352;4160.438340824011;4170.311898536707;1282.653683505467;1340.718449125675;1349.9055066145277;1351.513455156143;1359.0282947692447;996.7956568903357;1006.4967516241879;1020.6733845169474;1030.5105075089273;1031.9742006449899;6024.819255422344;6092.786752463642;6136.079588061826;6144.201253836973;6149.3235744068115;458.7820785127038;459.68052203718764;472.1713392995271;476.95707386335397;492.18051943514365;4394.1651086293505;4425.690201685851;4434.33484977256;4438.312061630452;4438.933415998763;10623.734406639742;10987.175961802737;10992.17558683102;11024.393658348707;11073.224874258725;10705.090067344363;10861.619843305447;10998.230123891411;11179.385133817555;11212.943935280435;8448.873266901;8573.09982451846;8611.48331100136;8614.569271536398;8662.6101825418;6340.556161068866;6443.806685799434;6511.186101737283;6549.803505894831;6566.146400967844;9812.26408019387;10565.9471702641;10582.417967011888;10653.467326633792;10710;10377.740556485845;10571.841422378824;10576.259661823906;10616.309939853885;10674.199435042248;7158.248383919822;7720.575368354795;7962.124166341813;8125.146859579895;8174.713885013996;8972.775680608038;9000.144986226298;9042.18620324174;9043.366964312698;9087;7892.565908875067;8057;8136.389770767334;8234.547099909563;8238.629261683118;7676.309132178131;7879.960600196962;8009.799755006172;8082.474639148437;8109.75670729879;7487.513311634726;7495.250474952461;7529.774106776806;7613.581253031137;7625.123110842324;5240.187770895517;5446.836594902159;5525.060739674345;5591.552675785846;5678.3186017678145;5470.9179362308805;5477.780888764405;5531.363893152339;5589.80435684749;5694.17434471991 07:15:09 INFO - PROCESS | 16567 | |4;prototype.html;339.41450997030125;341.50652307415766;343.7318891264814;344.1001780344399;346.1398424914088;5741.966446039712;5804.361520232771;5831.300243970724;5855.23881895353;5872.265966754156;5671.886562268752;5686.753732275749;5734.369219385864;5742.454466825655;5746.511546518541;4223.64099051581;4303.225419424502;4450.577195166454;4470.75410852403;4477.350784136314;4400.317950717628;4403.471583409979;4454.995252136535;4455.175792478386;4476.149531589004;4404.97797511012;4407.647388208936;4426.911461770763;4437.3597709362875;4442.155990361821;4355.738655680653;4403.075354175595;4430.158269928703;4464.352668862996;4488.124815660964;3924.4113382992496;3938.2911076006308;3948.7433316834313;3953.920921581581;3960.1683646434285;5489.286392768954;5539.667619942817;5541.556675465953;5551.3893471718075;5609.0184217762135;4829.396325459317;5034.446210916796;5056.772445239973;5086.821961231339;5246.554042906358;5945.791897283574;5962.135490353874;6039.184710064129;6061.636301821861;6124.173236613089;4333.891652708676;4342.2401079811225;4366.934495982563;4368.563143685637;4374.671899607542;6031.849203769897;6112.786052488142;6212.974859148235;6258.405451482147;6276.403741644582;4425.601695847389;4428.31361139024;4429.269170586882;4434.2484718536;4445.155420470101;4436.911261774746;4442.577955094261;4442.8222871085445;4443.222436073739;4455.153520831096;4814.916643755197;5037.4458809530925;5050.368703912011;5069.214271787879;5098.719570423662;5954.404559544011;6034.426729460694;6085.756569737249;6095.939040609625;6136.386361363917;1503.9774403383958;1530.5178868656337;1537.5617948884737;1541.514422956765;1550.2713724549444;965.9855102173473;986.2208855004466;1006.00405598457;1030.6083688198437;1031.7575369788094;5825.446582574734;5872.5628864020955;5889.293284805765;5889.617174883619;5901.852453688606;6123.958926982424;6139.618585818155;6184.350643182491;6201.224846894138;6256.874862502725;5705.66067912154;5887.11693246008;5895.793647222326;5903.3801450847905;5909.674967876808;3274.4433446314183;3294.6705329466863;3305.685959833812;3312.9834350828573;3323.6177839548277;6211.254649442096;6377.692573022519;6422.2293324800385;6476.579022363531;6556.967215163989;6346.809595712136;6380.266269378988;6382.36176382358;6384.872302553923;6390.45681117101;6295.685215739195;6465.353464653497;6478.157839480931;6581.630612979324;6583.637899915455;6240.157578726814;6262.463702200616;6280.466160376236;6282.465990390868;6344.714487847966;6164.3356293799525;6167.599106058092;6208.50331973432;6215.471684906653;6229.50163986889;6221.9377806221355;6495.123158373559;6512.674366281762;6518.902216466851;6537.673116344259;4389.956100438954;4411.757353345597;4427.756473393994;4435.645148388056;4458.866234012985;6062.575619706578;6235.438810507076;6244.6261822399;6252.562320637694;6270.341614130451;5949.345571986992;5961.7615295387695;6043.7884674036195;6056.636601803906;6064.48451881595;5974.522038236843;6022.759089636365;6029.60807547508;6058.848528786815;6106.084087386927;5859.677717725566;5981.252343457068;6000.969995149996;6015.187949626919;6031.69841507914;6086.543509236736;6129.264488261437;6138.324784273816;6155.645757933247;6164.630122192682;5907.611711247768;5963.701814909324;5973.49225315853;6028.969855150872;6040.546958978182 07:15:09 INFO - PROCESS | 16567 | |5;yui.html;812.3866480806989;814.4665244265009;838.1576515601821;856.7044369692458;936.5083331251093;15323.616909577253;15565.844341556582;15753.054816710992;15832.208389580519;17586.120693965313;16031;16102.275397607107;16245.350185992576;16246.43137490188;16247.106409147493;847.9364047696416;868.5092922498784;877.7015814623027;884.2483888694622;892.192565728014;888.4314039015003;890.9465432074096;895.2882458445519;898.6989358564889;898.9910100899006;930.3255140023463;935.7567032571512;935.7941252924346;938.3947353956694;939.4973689076346;928.0951072704094;931.3992474853716;932.7341707613298;934.5093825741473;934.621478301289;682.8019874236516;683.4156795939499;684.736376495048;687.5530904911798;687.556526040701;16532.338706451726;16808.411705590246;16835.989840609604;16851.915740421344;16876.662466750597;15300.311485983157;15375.769363459445;15798.763018554731;16009.199540022952;16226.188690565425;12228.938855305756;13050.347482625926;13398.330083495885;13409.262490563015;13657.112287701368;3735.589085200626;3770.981145094257;3794.962050379516;3820.121372084436;3868.941965870514;75783.86324205197;78833.60583197104;80028;80195;80339;12466.189697669623;12627.936860315824;12660.683482913;12861.871381286255;13241.205527668371;22901.88549057244;22940.885295573415;22960.425989350068;23149.76850231476;23229.070837166324;9231.584578693975;9327.766805829908;9333.486658233727;9352.111549402796;9418.858717119248;5237.6857388556045;5273.947260527422;5356;5469.890602187934;5544.722763861791;3854.5374555053572;3977.085270387769;4009.8195581198916;4010.1378203685763;4020.2160578686876;724.3625609463744;727.8762610356252;729.6885210193828;735.9521631094069;736.3704033051771;777.4052849570083;819.1521774963004;825.8348330333957;828.2338836576143;855.9358048146414;11466.140039497071;11556.711082222844;11631.941840290745;11833.940830295793;11886.34625095628;704.3942209699654;765.9582967164652;805.5569436809849;828.45736042892;848.4951453884929;5436.238926550286;5441.483059109379;5523.7238138092935;5584.916226256528;5587.636803607753;72934.27065729274;75438.24561754313;92678.53660731787;105935.47032264789;107093;66200.33799662038;86349.13650863536;95955;98637;100191;84042.57978710068;90564.5471772637;91731.08268917359;92734;92853;10346.637867674595;10555.500544608438;10702.197335199735;10781;10787.08309793645;53795.19307210317;53836.46163538471;53961.73019134879;54095;55843;66883.66558167178;77370;77757;79578.6021069891;82038.58980705058;14140.363683634056;14344.198941862029;14511.927440362731;14580.125192488485;14779.209382105251;15632.531024068841;16286;16403.58991025234;16774.832251677326;16890.74663880018;15403.152826594196;15507.689846203239;15562.455314063953;16493.505194844172;16653.66692666164;14306.499272525412;15297.311620977305;15563.922180389025;15698.843011570196;15751.842481575037;15165.848341516443;15216.923915380352;15525.76711349308;16116.113613750887;16311.510654680378;11637.592684256011;11994.820077698667;12020.278783272683;12297.56958506448;12594.018713963751;12738.490460381481;13234.602961911158;13384;13396.799048014092;13419.127756695783 07:15:09 INFO - PROCESS | 16567 | __end_tp_report 07:15:09 INFO - PROCESS | 16567 | __start_cc_report 07:15:09 INFO - PROCESS | 16567 | _x_x_mozilla_cycle_collect,324 07:15:09 INFO - PROCESS | 16567 | __end_cc_report 07:15:09 INFO - PROCESS | 16567 | __startTimestamp1468505709345__endTimestamp 07:15:09 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | ------- Summary: start ------- 07:15:09 INFO - PROCESS | 16567 | Number of tests: 6 07:15:09 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | [#0] dojo.html Cycles:165 Average:5630.33 Median:5838.07 stddev:624.19 (10.7%) stddev-sans-first:599.84 07:15:09 INFO - PROCESS | 16567 | Values: 3346.7 3393.3 3398.4 3403.9 3419.1 5633.7 5670.4 5686.0 5694.1 5701.7 5689.4 5733.9 5751.0 5751.7 5761.3 5007.8 5121.6 5166.1 5173.2 5207.6 5064.0 5073.3 5210.1 5228.9 5236.5 5125.5 5159.4 5160.1 5212.3 5312.3 5193.7 5208.8 5209.2 5216.6 5221.6 4933.5 5020.1 5121.0 5140.9 5182.8 5425.1 5487.5 5503.1 5546.8 5561.1 5965.4 5984.7 6015.4 6048.6 6050.9 5948.7 6056.8 6068.5 6096.9 6101.7 5597.6 5610.6 5613.0 5621.3 5627.9 6176.4 6188.2 6189.4 6193.1 6206.0 5948.7 5949.7 5953.8 6008.2 6036.0 6040.7 6117.3 6124.8 6128.3 6153.9 5882.7 6064.5 6079.1 6082.5 6082.8 5931.9 5971.1 6047.2 6069.7 6071.4 4658.3 4675.3 4677.6 4686.6 4714.7 4075.5 4123.7 4184.4 4186.4 4216.8 5661.3 5685.0 5698.0 5753.5 5803.4 6067.0 6120.1 6132.9 6136.4 6143.7 5654.8 5725.2 5851.0 5858.7 5858.8 5166.2 5190.4 5222.3 5240.6 5257.3 6275.2 6327.1 6328.5 6335.3 6350.1 5953.3 5971.6 6044.5 6049.7 6077.1 6317.4 6334.6 6336.6 6349.1 6367.6 5966.9 5975.4 5976.1 5984.3 5991.4 5947.4 5976.9 6001.7 6040.4 6076.6 5885.5 5928.0 5936.1 5943.6 5955.7 5823.9 5923.6 5934.8 5951.4 5952.0 5657.2 5728.9 5738.6 5779.5 5822.2 5902.6 5919.3 5943.1 5948.6 5953.6 5717.1 5806.8 5829.4 5833.9 5838.1 07:15:09 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | [#1] ext.html Cycles:180 Average:65500.22 Median:42597.18 stddev:140534.41 (329.9%) stddev-sans-first:140844.18 07:15:09 INFO - PROCESS | 16567 | Values: 604.0 655.4 662.4 665.1 672.3 47603.0 49290.0 49404.0 49549.5 52606.0 49306.8 49381.0 49638.8 49642.8 49711.5 9038.7 9186.2 9188.5 9192.6 9195.2 8849.8 8890.2 8940.5 8998.2 9009.9 8996.4 9017.1 9025.3 9039.7 9053.2 8967.2 9003.1 9004.8 9039.1 9042.6 9020.7 9056.9 9072.3 9097.0 9122.7 44659.3 44664.6 45015.5 45018.3 45082.5 3733.0 3884.3 4043.0 4277.5 4308.2 35143.6 35405.3 35513.3 35693.6 35857.6 4640.7 4738.3 4741.9 4763.7 4870.8 372697.0 373608.0 373772.0 374581.0 374720.1 65836.0 65917.3 65984.7 65985.0 66043.0 40109.2 40948.6 41208.6 42992.0 43064.8 18046.3 18185.5 18305.5 18321.7 18386.7 13655.6 13789.7 13814.7 13851.7 13853.4 21515.0 21535.8 21748.5 21816.0 21880.2 7498.9 7728.2 7753.1 7930.6 7938.9 1110.9 1156.5 1201.9 1206.9 1217.7 33708.5 33924.3 34064.0 34889.1 35087.3 1177.6 1184.3 1202.0 1219.3 1361.2 18102.7 18252.1 18323.4 18343.6 18452.6 611519.0 626045.0 662978.0 664883.0 994005.0 55722.2 60969.0 61076.0 61130.4 61156.1 1491.9 1511.0 1511.7 1514.3 1519.3 32105.0 32756.8 32878.5 32937.2 33612.8 52320.0 53009.5 53071.0 53322.0 53446.5 392552.0 398519.0 400351.0 400901.0 402971.0 30143.7 30243.5 30475.7 30516.5 30847.2 48770.3 48777.3 48988.3 49157.3 49574.5 41131.4 41176.0 41190.2 42659.4 43002.6 40234.8 40780.7 41061.6 42535.0 42710.9 40998.8 41802.0 42001.2 42678.0 42747.6 32814.3 33241.5 33594.0 33832.3 34185.0 28500.1 28733.0 28845.6 29175.6 29423.9 07:15:09 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | [#2] jquery.html Cycles:180 Average:30578.56 Median:2393.49 stddev:88938.23 (3715.8%) stddev-sans-first:89158.92 07:15:09 INFO - PROCESS | 16567 | Values: 430.3 436.2 437.8 439.8 443.8 19132.5 20188.5 20702.9 21235.0 21359.9 17707.8 17734.5 18593.6 18655.9 18708.3 5691.7 5880.1 5882.5 5911.0 5924.2 4783.0 5865.4 5931.1 6277.3 6287.6 5505.8 6261.6 6296.2 6335.6 6343.9 5753.7 5856.2 5874.7 5876.4 5886.9 5727.6 5905.7 5923.2 5943.4 5949.2 13625.9 14062.5 14072.2 14121.4 14345.9 2371.2 2415.8 2489.6 2501.3 2696.6 10612.2 10683.1 10708.8 10868.8 10924.3 2006.6 2028.7 2085.7 2141.8 2157.9 82406.6 85451.6 89208.0 89885.6 90097.5 11006.3 11243.0 11318.6 11529.9 11604.8 16512.7 16596.7 16615.6 16651.5 16658.9 8109.8 8178.0 8236.6 8321.0 8334.7 7452.2 7586.7 7602.5 7655.8 7747.1 4839.2 4929.0 5000.6 5065.1 5100.8 2069.8 2084.9 2128.9 2133.1 2172.7 1013.7 1145.0 1177.8 1188.7 1191.1 19586.0 19878.2 20241.9 20325.5 20494.5 1105.3 1113.7 1115.6 1124.7 1141.8 11159.5 11367.8 11373.3 11390.8 11504.3 533738.0 534885.0 541389.0 544017.0 548387.0 59277.7 83712.0 89492.6 99636.5 107401.0 937.2 951.7 970.5 974.9 988.5 18452.5 18545.6 18546.2 18546.7 18649.2 42729.4 42799.0 43175.0 43710.3 45071.8 56629.0 58231.7 58525.7 60944.0 61234.4 5737.3 7703.5 8035.8 8907.3 8940.0 13308.7 13499.5 13508.8 13587.9 14255.8 12511.5 12657.7 12703.3 12822.8 12917.2 11959.5 12191.3 12468.8 12651.2 12941.9 12721.2 13016.9 13078.0 13127.3 13164.7 8110.8 8126.1 8225.5 8238.8 8571.2 9385.7 12542.4 12848.9 12962.1 12985.7 07:15:09 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | [#3] mootools.html Cycles:180 Average:6010.19 Median:459.23 stddev:3414.20 (743.5%) stddev-sans-first:3407.46 07:15:09 INFO - PROCESS | 16567 | Values: 1569.3 1578.9 1776.5 1876.8 1889.6 7929.8 8806.2 8849.3 9310.9 9430.5 8761.3 9122.7 9123.5 9132.1 9159.4 2294.9 2347.3 2366.4 2369.8 2375.6 2389.9 2405.9 2425.8 2429.8 2443.6 2396.9 2423.2 2428.8 2440.7 2448.3 2365.3 2367.7 2378.6 2381.1 2382.6 2347.2 2369.0 2384.3 2413.2 2415.6 9091.5 9200.1 9203.7 9209.1 9217.1 5200.2 5311.6 5336.4 5341.1 5342.0 3550.3 3553.2 3606.6 3611.5 3624.2 1198.9 1212.8 1223.2 1235.0 1274.4 12653.0 12782.2 12804.3 12812.6 12823.7 4659.1 4750.8 4803.4 4823.3 4857.5 10779.0 10813.1 10815.7 10819.4 10831.6 5321.8 5360.7 5395.2 5413.3 5425.7 4358.3 4559.0 4636.8 4678.9 5005.7 4092.0 4119.4 4126.1 4160.4 4170.3 1282.7 1340.7 1349.9 1351.5 1359.0 996.8 1006.5 1020.7 1030.5 1032.0 6024.8 6092.8 6136.1 6144.2 6149.3 458.8 459.7 472.2 477.0 492.2 4394.2 4425.7 4434.3 4438.3 4438.9 10623.7 10987.2 10992.2 11024.4 11073.2 10705.1 10861.6 10998.2 11179.4 11212.9 8448.9 8573.1 8611.5 8614.6 8662.6 6340.6 6443.8 6511.2 6549.8 6566.1 9812.3 10565.9 10582.4 10653.5 10710.0 10377.7 10571.8 10576.3 10616.3 10674.2 7158.2 7720.6 7962.1 8125.1 8174.7 8972.8 9000.1 9042.2 9043.4 9087.0 7892.6 8057.0 8136.4 8234.5 8238.6 7676.3 7880.0 8009.8 8082.5 8109.8 7487.5 7495.3 7529.8 7613.6 7625.1 5240.2 5446.8 5525.1 5591.6 5678.3 5470.9 5477.8 5531.4 5589.8 5694.2 07:15:09 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | [#4] prototype.html Cycles:180 Average:5093.30 Median:5872.41 stddev:1515.68 (25.8%) stddev-sans-first:1477.34 07:15:09 INFO - PROCESS | 16567 | Values: 339.4 341.5 343.7 344.1 346.1 5742.0 5804.4 5831.3 5855.2 5872.3 5671.9 5686.8 5734.4 5742.5 5746.5 4223.6 4303.2 4450.6 4470.8 4477.4 4400.3 4403.5 4455.0 4455.2 4476.1 4405.0 4407.6 4426.9 4437.4 4442.2 4355.7 4403.1 4430.2 4464.4 4488.1 3924.4 3938.3 3948.7 3953.9 3960.2 5489.3 5539.7 5541.6 5551.4 5609.0 4829.4 5034.4 5056.8 5086.8 5246.6 5945.8 5962.1 6039.2 6061.6 6124.2 4333.9 4342.2 4366.9 4368.6 4374.7 6031.8 6112.8 6213.0 6258.4 6276.4 4425.6 4428.3 4429.3 4434.2 4445.2 4436.9 4442.6 4442.8 4443.2 4455.2 4814.9 5037.4 5050.4 5069.2 5098.7 5954.4 6034.4 6085.8 6095.9 6136.4 1504.0 1530.5 1537.6 1541.5 1550.3 966.0 986.2 1006.0 1030.6 1031.8 5825.4 5872.6 5889.3 5889.6 5901.9 6124.0 6139.6 6184.4 6201.2 6256.9 5705.7 5887.1 5895.8 5903.4 5909.7 3274.4 3294.7 3305.7 3313.0 3323.6 6211.3 6377.7 6422.2 6476.6 6557.0 6346.8 6380.3 6382.4 6384.9 6390.5 6295.7 6465.4 6478.2 6581.6 6583.6 6240.2 6262.5 6280.5 6282.5 6344.7 6164.3 6167.6 6208.5 6215.5 6229.5 6221.9 6495.1 6512.7 6518.9 6537.7 4390.0 4411.8 4427.8 4435.6 4458.9 6062.6 6235.4 6244.6 6252.6 6270.3 5949.3 5961.8 6043.8 6056.6 6064.5 5974.5 6022.8 6029.6 6058.8 6106.1 5859.7 5981.3 6001.0 6015.2 6031.7 6086.5 6129.3 6138.3 6155.6 6164.6 5907.6 5963.7 5973.5 6029.0 6040.5 07:15:09 INFO - PROCESS | 16567 | 07:15:09 INFO - PROCESS | 16567 | [#5] yui.html Cycles:180 Average:20981.98 Median:4009.98 stddev:27940.61 (696.8%) stddev-sans-first:27977.94 07:15:09 INFO - PROCESS | 16567 | Values: 812.4 814.5 838.2 856.7 936.5 15323.6 15565.8 15753.1 15832.2 17586.1 16031.0 16102.3 16245.4 16246.4 16247.1 847.9 868.5 877.7 884.2 892.2 888.4 890.9 895.3 898.7 899.0 930.3 935.8 935.8 938.4 939.5 928.1 931.4 932.7 934.5 934.6 682.8 683.4 684.7 687.6 687.6 16532.3 16808.4 16836.0 16851.9 16876.7 15300.3 15375.8 15798.8 16009.2 16226.2 12228.9 13050.3 13398.3 13409.3 13657.1 3735.6 3771.0 3795.0 3820.1 3868.9 75783.9 78833.6 80028.0 80195.0 80339.0 12466.2 12627.9 12660.7 12861.9 13241.2 22901.9 22940.9 22960.4 23149.8 23229.1 9231.6 9327.8 9333.5 9352.1 9418.9 5237.7 5273.9 5356.0 5469.9 5544.7 3854.5 3977.1 4009.8 4010.1 4020.2 724.4 727.9 729.7 736.0 736.4 777.4 819.2 825.8 828.2 855.9 11466.1 11556.7 11631.9 11833.9 11886.3 704.4 766.0 805.6 828.5 848.5 5436.2 5441.5 5523.7 5584.9 5587.6 72934.3 75438.2 92678.5 105935.5 107093.0 66200.3 86349.1 95955.0 98637.0 100191.0 84042.6 90564.5 91731.1 92734.0 92853.0 10346.6 10555.5 10702.2 10781.0 10787.1 53795.2 53836.5 53961.7 54095.0 55843.0 66883.7 77370.0 77757.0 79578.6 82038.6 14140.4 14344.2 14511.9 14580.1 14779.2 15632.5 16286.0 16403.6 16774.8 16890.7 15403.2 15507.7 15562.5 16493.5 16653.7 14306.5 15297.3 15563.9 15698.8 15751.8 15165.8 15216.9 15525.8 16116.1 16311.5 11637.6 11994.8 12020.3 12297.6 12594.0 12738.5 13234.6 13384.0 13396.8 13419.1 07:15:09 INFO - PROCESS | 16567 | -------- Summary: end -------- 07:15:09 INFO - PROCESS | 16567 | 07:15:10 INFO - TEST-INFO | 16567: exit 0 07:15:10 INFO - TEST-OK | dromaeo_css | took 1112418ms 07:15:10 INFO - TEST-START | kraken 07:15:10 INFO - operating with platform_type : linux_ 07:15:10 INFO - Initialising browser for kraken test... 07:15:10 INFO - TEST-INFO | started process 16810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6uXmdt/profile http://localhost:38935/getInfo.html) 07:15:15 INFO - PROCESS | 16810 | __metrics Screen width/height:1600/1200 07:15:15 INFO - PROCESS | 16810 | colorDepth:24 07:15:15 INFO - PROCESS | 16810 | Browser inner width/height: 1024/697 07:15:15 INFO - PROCESS | 16810 | __metrics 07:15:16 ERROR - PROCESS | 16810 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:15:17 INFO - TEST-INFO | 16810: exit 0 07:15:17 INFO - Browser initialized. 07:15:17 INFO - Running cycle 1/1 for kraken test... 07:15:17 INFO - TEST-INFO | started process 16940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6uXmdt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:29 INFO - PROCESS | 16940 | RSS: Main: 156286976 07:15:29 INFO - PROCESS | 16940 | 07:15:31 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38935/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:32 INFO - PROCESS | 16940 | RSS: Main: 161288192 07:15:32 INFO - PROCESS | 16940 | 07:15:35 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38935/tests/kraken/driver.html?testName=audio-dft) 07:15:35 INFO - PROCESS | 16940 | RSS: Main: 160784384 07:15:35 INFO - PROCESS | 16940 | 07:15:38 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38935/tests/kraken/driver.html?testName=audio-fft) 07:15:39 INFO - PROCESS | 16940 | RSS: Main: 161484800 07:15:39 INFO - PROCESS | 16940 | 07:15:41 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38935/tests/kraken/driver.html?testName=audio-oscillator) 07:15:42 INFO - PROCESS | 16940 | RSS: Main: 160915456 07:15:42 INFO - PROCESS | 16940 | 07:15:44 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:44 INFO - PROCESS | 16940 | RSS: Main: 160677888 07:15:44 INFO - PROCESS | 16940 | 07:15:47 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38935/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:48 INFO - PROCESS | 16940 | RSS: Main: 160395264 07:15:48 INFO - PROCESS | 16940 | 07:15:51 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38935/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:52 INFO - PROCESS | 16940 | RSS: Main: 161120256 07:15:52 INFO - PROCESS | 16940 | 07:15:55 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38935/tests/kraken/driver.html?testName=json-parse-financial) 07:15:56 INFO - PROCESS | 16940 | RSS: Main: 160735232 07:15:56 INFO - PROCESS | 16940 | 07:15:57 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:58 INFO - PROCESS | 16940 | RSS: Main: 160739328 07:15:58 INFO - PROCESS | 16940 | 07:15:59 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38935/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:16:00 INFO - PROCESS | 16940 | RSS: Main: 161153024 07:16:00 INFO - PROCESS | 16940 | 07:16:02 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:16:03 INFO - PROCESS | 16940 | RSS: Main: 161218560 07:16:03 INFO - PROCESS | 16940 | 07:16:05 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:16:06 INFO - PROCESS | 16940 | RSS: Main: 161603584 07:16:06 INFO - PROCESS | 16940 | 07:16:09 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:16:09 INFO - PROCESS | 16940 | RSS: Main: 161112064 07:16:09 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | Cycle 1(1): loaded http://localhost:38935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38935/tests/kraken/driver.html?testName=ai-astar) 07:16:11 INFO - PROCESS | 16940 | RSS: Main: 161845248 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | __start_tp_report 07:16:11 INFO - PROCESS | 16940 | _x_x_mozilla_page_load 07:16:11 INFO - PROCESS | 16940 | _x_x_mozilla_page_load_details 07:16:11 INFO - PROCESS | 16940 | |i|pagename|runs| 07:16:11 INFO - PROCESS | 16940 | |0;ai-astar;114;104;114;111;111;113;112;111;112;109 07:16:11 INFO - PROCESS | 16940 | |1;audio-beat-detection;163;131;151;179;125;153;153;126;204;126 07:16:11 INFO - PROCESS | 16940 | |2;audio-dft;162;163;162;164;161;163;163;162;162;162 07:16:11 INFO - PROCESS | 16940 | |3;audio-fft;75;76;75;172;83;76;79;75;167;75 07:16:11 INFO - PROCESS | 16940 | |4;audio-oscillator;83;85;151;84;85;86;137;86;84;142 07:16:11 INFO - PROCESS | 16940 | |5;imaging-gaussian-blur;117;117;117;119;117;118;118;118;118;117 07:16:11 INFO - PROCESS | 16940 | |6;imaging-darkroom;149;147;148;146;147;148;146;147;148;146 07:16:11 INFO - PROCESS | 16940 | |7;imaging-desaturate;96;95;97;95;95;95;95;95;96;97 07:16:11 INFO - PROCESS | 16940 | |8;json-parse-financial;51;51;54;54;53;53;58;52;52;53 07:16:11 INFO - PROCESS | 16940 | |9;json-stringify-tinderbox;61;60;61;61;61;61;61;60;61;60 07:16:11 INFO - PROCESS | 16940 | |10;stanford-crypto-aes;76;82;78;78;79;77;78;78;107;78 07:16:11 INFO - PROCESS | 16940 | |11;stanford-crypto-ccm;123;116;124;116;117;125;123;121;135;126 07:16:11 INFO - PROCESS | 16940 | |12;stanford-crypto-pbkdf2;154;150;154;157;157;153;152;152;155;161 07:16:11 INFO - PROCESS | 16940 | |13;stanford-crypto-sha256-iterative;64;62;64;61;61;63;61;61;60;61 07:16:11 INFO - PROCESS | 16940 | __end_tp_report 07:16:11 INFO - PROCESS | 16940 | __start_cc_report 07:16:11 INFO - PROCESS | 16940 | _x_x_mozilla_cycle_collect,862 07:16:11 INFO - PROCESS | 16940 | __end_cc_report 07:16:11 INFO - PROCESS | 16940 | __startTimestamp1468505771562__endTimestamp 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | ------- Summary: start ------- 07:16:11 INFO - PROCESS | 16940 | Number of tests: 14 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.92 (2.6%) stddev-sans-first:2.91 07:16:11 INFO - PROCESS | 16940 | Values: 114.0 104.0 114.0 111.0 111.0 113.0 112.0 111.0 112.0 109.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:153.00 stddev:25.97 (17.0%) stddev-sans-first:27.19 07:16:11 INFO - PROCESS | 16940 | Values: 163.0 131.0 151.0 179.0 125.0 153.0 153.0 126.0 204.0 126.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 07:16:11 INFO - PROCESS | 16940 | Values: 162.0 163.0 162.0 164.0 161.0 163.0 163.0 162.0 162.0 162.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:39.21 (51.9%) stddev-sans-first:40.89 07:16:11 INFO - PROCESS | 16940 | Values: 75.0 76.0 75.0 172.0 83.0 76.0 79.0 75.0 167.0 75.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.50 stddev:28.53 (33.8%) stddev-sans-first:29.39 07:16:11 INFO - PROCESS | 16940 | Values: 83.0 85.0 151.0 84.0 85.0 86.0 137.0 86.0 84.0 142.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 07:16:11 INFO - PROCESS | 16940 | Values: 117.0 117.0 117.0 119.0 117.0 118.0 118.0 118.0 118.0 117.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:1.03 (0.7%) stddev-sans-first:0.87 07:16:11 INFO - PROCESS | 16940 | Values: 149.0 147.0 148.0 146.0 147.0 148.0 146.0 147.0 148.0 146.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 07:16:11 INFO - PROCESS | 16940 | Values: 96.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 97.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:2.02 (3.8%) stddev-sans-first:2.00 07:16:11 INFO - PROCESS | 16940 | Values: 51.0 51.0 54.0 54.0 53.0 53.0 58.0 52.0 52.0 53.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:16:11 INFO - PROCESS | 16940 | Values: 61.0 60.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 60.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:78.00 stddev:9.23 (11.8%) stddev-sans-first:9.60 07:16:11 INFO - PROCESS | 16940 | Values: 76.0 82.0 78.0 78.0 79.0 77.0 78.0 78.0 107.0 78.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.50 stddev:5.72 (4.6%) stddev-sans-first:6.06 07:16:11 INFO - PROCESS | 16940 | Values: 123.0 116.0 124.0 116.0 117.0 125.0 123.0 121.0 135.0 126.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:154.50 stddev:3.17 (2.1%) stddev-sans-first:3.36 07:16:11 INFO - PROCESS | 16940 | Values: 154.0 150.0 154.0 157.0 157.0 153.0 152.0 152.0 155.0 161.0 07:16:11 INFO - PROCESS | 16940 | 07:16:11 INFO - PROCESS | 16940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:61.50 stddev:1.40 (2.3%) stddev-sans-first:1.24 07:16:11 INFO - PROCESS | 16940 | Values: 64.0 62.0 64.0 61.0 61.0 63.0 61.0 61.0 60.0 61.0 07:16:11 INFO - PROCESS | 16940 | -------- Summary: end -------- 07:16:11 INFO - PROCESS | 16940 | 07:16:12 INFO - TEST-INFO | 16940: exit 0 07:16:12 INFO - TEST-OK | kraken | took 62473ms 07:16:12 INFO - SUITE-END | took 1174s 07:16:12 INFO - Completed test suite (00:19:35) 07:16:12 INFO - javascript benchmark 07:16:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7659.428497653006, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.682065203805, 3393.2874096439746, 3398.405279076161, 3403.8808641697547, 3419.059758566394, 5633.690147041911, 5670.376258611549, 5686.0, 5694.060480020791, 5701.6864072476, 5689.374168841424, 5733.885322293551, 5751.0, 5751.712414379285, 5761.251037365137, 5007.799688012484, 5121.615878809085, 5166.095933211673, 5173.198154286091, 5207.583393328544, 5064.0, 5073.264376665381, 5210.140326846066, 5228.895422091556, 5236.502532259448, 5125.538701516863, 5159.432462429129, 5160.14857548504, 5212.322398088243, 5312.2828418163435, 5193.740312984354, 5208.791648334062, 5209.192575150858, 5216.58267338612, 5221.6083793715625, 4933.506649335073, 5020.0963826511215, 5120.974395128038, 5140.922886156711, 5182.844514664566, 5425.104857698475, 5487.533559647435, 5503.147012213113, 5546.77812887484, 5561.110222364402, 5965.433283838029, 5984.73068711909, 6015.398460153993, 6048.576599638027, 6050.939490605082, 5948.672822994734, 6056.848578785565, 6068.453839154453, 6096.908546371808, 6101.694915254264, 5597.608167428281, 5610.635308704921, 5612.971935140339, 5621.269234999424, 5627.943720562783, 6176.35148309421, 6188.226471691039, 6189.35011823761, 6193.102000210034, 6205.968970155211, 5948.672822994777, 5949.672767997802, 5953.821385358447, 6008.21893153896, 6036.034234522455, 6040.728167232485, 6117.296510901303, 6124.755009799558, 6128.264608247039, 6153.907691384543, 5882.705864706748, 6064.4541991221, 6079.057746049281, 6082.452579267887, 6082.847928801727, 5931.881362372728, 5971.104334349882, 6047.15339852421, 6069.696515174223, 6071.423214794588, 4658.324542941255, 4675.251959686434, 4677.579017888406, 4686.601638860667, 4714.717116972993, 4075.5313138988804, 4123.670106391482, 4184.351425528987, 4186.434831297796, 4216.789160542022, 5661.34894487131, 5685.0, 5697.971510142423, 5753.510951569164, 5803.361630220672, 6067.029275315928, 6120.112583675342, 6132.877342453126, 6136.417040381157, 6143.662098584621, 5654.773809047592, 5725.198472213893, 5851.034579294454, 5858.707064646751, 5858.8242352729485, 5166.173412254021, 5190.351206099238, 5222.268882356473, 5240.633155679066, 5257.316548848626, 6275.246970363585, 6327.050942358683, 6328.525360597973, 6335.303116657164, 6350.142730731292, 5953.255843019622, 5971.641701497924, 6044.455998960115, 6049.697515124139, 6077.088436734437, 6317.399847014526, 6334.556581039283, 6336.556441049082, 6349.142865713255, 6367.586106903036, 5966.880662386815, 5975.43233392827, 5976.073708575178, 5984.281886173513, 5991.400859913973, 5947.375525569752, 5976.8804623908145, 6001.729922153426, 6040.395960403925, 6076.605020673642, 5885.47030767233, 5928.0, 5936.050231962865, 5943.58394912352, 5955.731992060454, 5823.94176058234, 5923.614965027259, 5934.7922822701, 5951.375105614022, 5952.0476723724, 5657.2079908811975, 5728.856778580569, 5738.598298119092, 5779.537636988946, 5822.243108395882, 5902.61632993854, 5919.289685237799, 5943.108533719977, 5948.583599148018, 5953.613015154001, 5717.142428635571, 5806.796762113306, 5829.417058294137, 5833.883322333614, 5838.065909454637], "value": 5589.838044381568, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.954703397245, 655.3675702946656, 662.4170729757813, 665.0556210181545, 672.3175976383972, 47603.0, 49290.0, 49404.0, 49549.50450495494, 52606.0, 49306.75346623271, 49381.0, 49638.75180624101, 49642.75178624102, 49711.50288497114, 9038.683646072388, 9186.219171370409, 9188.540572971324, 9192.632294708237, 9195.172434480895, 8849.778755531099, 8890.155435233642, 8940.508272045035, 8998.235150012224, 9009.909900901006, 8996.370254082216, 9017.143371379709, 9025.277977761796, 9039.728808135766, 9053.185213330798, 8967.237784788302, 9003.14470125337, 9004.819903601956, 9039.096090390909, 9042.593083311267, 9020.729378118602, 9056.909430905673, 9072.27421806254, 9096.954515227448, 9122.680706175319, 44659.33011004805, 44664.55335446636, 45015.54984450179, 45018.32472512915, 45082.54917450816, 3733.0, 3884.261990221849, 4043.0, 4277.486701595828, 4308.159908817782, 35143.64856351455, 35405.29189416223, 35513.28973420543, 35693.64306356929, 35857.641423585694, 4640.721556706575, 4738.265568836836, 4741.9288710669025, 4763.666543341968, 4870.805167793319, 372697.0, 373608.0, 373772.0, 374581.0, 374720.126399369, 65836.0, 65917.34082659207, 65984.67007664932, 65985.0, 66043.0, 40109.19781604352, 40948.590514094474, 41208.587914121075, 42992.0, 43064.78467607642, 18046.2781488739, 18185.45443636693, 18305.542361441072, 18321.7251741224, 18386.724199137025, 13655.590332290047, 13789.724205516035, 13814.723705525834, 13851.653708657162, 13853.376598053112, 21515.0, 21535.784642153692, 21748.45628859291, 21816.0, 21880.23419180321, 7498.925010749823, 7728.22717728234, 7753.147153813189, 7930.5638189898955, 7938.880916786253, 1110.9222354435274, 1156.531604700081, 1201.9399030048462, 1206.90344772418, 1217.652968903876, 33708.49437258443, 33924.32151357008, 34064.0, 34889.12777180591, 35087.29825403477, 1177.581958404771, 1184.3190165654783, 1202.0056664558772, 1219.2501611508858, 1361.1968938326436, 18102.728459073125, 18252.087395630166, 18323.35868244605, 18343.63312733738, 18452.630947381247, 611519.0, 626045.0, 662978.0, 664883.0, 994005.0, 55722.16416753752, 60969.0, 61076.0, 61130.38869611336, 61156.082658760155, 1491.8881083918532, 1510.9697806044037, 1511.7203317386318, 1514.3109885002298, 1519.323900864127, 32105.0, 32756.83621581877, 32878.506822397205, 32937.17657058497, 33612.831935840164, 52320.0, 53009.469905301994, 53071.0, 53322.0, 53446.46553534415, 392552.0, 398519.0, 400351.0, 400901.0, 402971.0, 30143.698563014088, 30243.546346805255, 30475.695243048172, 30516.542251865794, 30847.2288192797, 48770.26844597263, 48777.2683409742, 48988.2651760231, 49157.2626410597, 49574.50425495699, 41131.38302925519, 41176.0, 41190.1761964765, 42659.360109599, 43002.569974299855, 40234.79882600568, 40780.71802460699, 41061.58938410578, 42535.0, 42710.93222669334, 40998.79500602478, 41802.0, 42001.159976800904, 42678.0, 42747.57252427436, 32814.34371312608, 33241.501377478875, 33594.0, 33832.323353533284, 34185.0, 28500.144995650164, 28733.0, 28845.56731648985, 29175.562366564944, 29423.85288073546], "value": 21201.660260691933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.2706911784525, 436.22654172033157, 437.78548511229496, 439.78670344882744, 443.7670223132853, 19132.521686957814, 20188.495287617818, 20702.89648551757, 21235.0, 21359.893200533974, 17707.822921770778, 17734.46796596101, 18593.628127437478, 18655.906720466413, 18708.345207917726, 5691.686957217341, 5880.059190529516, 5882.4705776480105, 5911.0, 5924.2298501195, 4782.995570930108, 5865.384134665863, 5931.110333449996, 6277.309495955441, 6287.591306565058, 5505.807296744615, 6261.561690681654, 6296.212973378328, 6335.619862808247, 6343.904841427359, 5753.683547404891, 5856.15085812559, 5874.73563689635, 5876.4123587641325, 5886.941130588703, 5727.627704199213, 5905.704714764288, 5923.229980102602, 5943.4056594340655, 5949.226600541945, 13625.931870340584, 14062.507812226522, 14072.22602756848, 14121.435142594284, 14345.856541434556, 2371.22935046109, 2415.758424157588, 2489.576771948773, 2501.3246423465744, 2696.5550684137093, 10612.151027917747, 10683.14534837211, 10708.839367409417, 10868.782624347548, 10924.28992115518, 2006.5786184901187, 2028.6855537391727, 2085.7392825896763, 2141.753698324697, 2157.8921053947397, 82406.58796706038, 85451.57274213589, 89208.0, 89885.55057224672, 90097.54951225268, 11006.284591501526, 11243.0, 11318.60384886525, 11529.942350288362, 11604.76790464186, 16512.66974660524, 16596.668066638842, 16615.584610384838, 16651.50045498637, 16658.91670541664, 8109.75670729879, 8178.0, 8236.629351679188, 8321.04308004575, 8334.6666133354, 7452.180260171377, 7586.734464293833, 7602.46782725215, 7655.846883062419, 7747.147813740484, 4839.225723884161, 4928.975355123202, 5000.64995450315, 5065.088284108822, 5100.795968161232, 2069.795667613986, 2084.9061792219386, 2128.8829114398545, 2133.14674130346, 2172.7175467189163, 1013.7110923386799, 1144.959926402572, 1177.7644471105814, 1188.7147084699782, 1191.124523475245, 19586.0, 19878.204871805254, 20241.898790505955, 20325.491862703257, 20494.487637809176, 1105.2539535813294, 1113.7104352868312, 1115.570505355444, 1124.7131981344705, 1141.8173092305192, 11159.497822598003, 11367.829482557769, 11373.31760094397, 11390.829137562943, 11504.25222360544, 533738.0, 534885.0, 541389.0, 544017.0, 548387.0, 59277.703611481666, 83712.0, 89492.5525372382, 99636.50181749045, 107401.0, 937.2033771294346, 951.7144856543009, 970.4516947924541, 974.8635191073255, 988.4909271725068, 18452.538686532946, 18545.629087418445, 18546.16542255629, 18546.721799172752, 18649.160787764853, 42729.359059614755, 42799.0, 43175.0, 43710.34434483549, 45071.77464112658, 56629.0, 58231.70884145552, 58525.70737146287, 60944.0, 61234.38765612465, 5737.282839645044, 7703.537787732754, 8035.839283214186, 8907.287417006753, 8940.0, 13308.733825323632, 13499.460021599027, 13508.797368039684, 13587.883113278664, 14255.786163207767, 12511.499540018298, 12657.746845063231, 12703.301318427575, 12822.807657885325, 12917.160384574972, 11959.521619135137, 12191.329476878502, 12468.750624987631, 12651.240925544496, 12941.935290323489, 12721.236725796482, 13016.934915325362, 13078.0, 13127.277999710108, 13164.736705266032, 8110.756677299691, 8126.106128325761, 8225.506469611842, 8238.83522329562, 8571.22858942698, 9385.671501497414, 12542.372881355714, 12848.935755321163, 12962.092653514164, 12985.675358116123], "value": 9477.269347778321, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.2702893154685, 1578.9131597762123, 1776.5203395083329, 1876.8123187681242, 1889.5559543507272, 7929.76210713678, 8806.20744133028, 8849.29205663547, 9310.86033709494, 9430.528473576329, 8761.342899282563, 9122.680706175284, 9123.498207598595, 9132.132447417502, 9159.42782314896, 2294.9311520654323, 2347.307544274443, 2366.4438856868624, 2369.8222633302485, 2375.6080246759266, 2389.880505974703, 2405.891734871935, 2425.8180636452335, 2429.8177636677233, 2443.6456713776493, 2396.8561886286793, 2423.164008417102, 2428.7571242875747, 2440.6583078369044, 2448.2655203438985, 2365.2549446924163, 2367.6803631509697, 2378.6432035194684, 2381.1189859752003, 2382.5711371953043, 2347.2371479269136, 2368.976310236893, 2384.320468666439, 2413.191580820427, 2415.5651982643117, 9091.454512729257, 9200.079992000814, 9203.723888283363, 9209.079092090804, 9217.124373184537, 5200.245964335188, 5311.601629877736, 5336.43967383423, 5341.065313570149, 5341.973290133564, 3550.3076900004507, 3553.218291975761, 3606.6213047629885, 3611.494390785292, 3624.1845584743487, 1198.8561372635252, 1212.8423304970297, 1223.1988047828686, 1235.0366713963033, 1274.356449992757, 12653.0, 12782.233066015975, 12804.295763732991, 12812.61562153137, 12823.679408014781, 4659.068186362673, 4750.809967601257, 4803.375561177095, 4823.348847905558, 4857.489963553847, 10779.0, 10813.134949204044, 10815.67552973412, 10819.404932728617, 10831.620893268699, 5321.760520776575, 5360.70516121617, 5395.244665746799, 5413.296271484682, 5425.728713564306, 4358.302671572533, 4558.954410455919, 4636.8145274188655, 4678.883027924329, 5005.74971251436, 4091.9590804091577, 4119.397064656847, 4126.071633882352, 4160.438340824011, 4170.311898536707, 1282.653683505467, 1340.718449125675, 1349.9055066145277, 1351.513455156143, 1359.0282947692447, 996.7956568903357, 1006.4967516241879, 1020.6733845169474, 1030.5105075089273, 1031.9742006449899, 6024.819255422344, 6092.786752463642, 6136.079588061826, 6144.201253836973, 6149.3235744068115, 458.7820785127038, 459.68052203718764, 472.1713392995271, 476.95707386335397, 492.18051943514365, 4394.1651086293505, 4425.690201685851, 4434.33484977256, 4438.312061630452, 4438.933415998763, 10623.734406639742, 10987.175961802737, 10992.17558683102, 11024.393658348707, 11073.224874258725, 10705.090067344363, 10861.619843305447, 10998.230123891411, 11179.385133817555, 11212.943935280435, 8448.873266901, 8573.09982451846, 8611.48331100136, 8614.569271536398, 8662.6101825418, 6340.556161068866, 6443.806685799434, 6511.186101737283, 6549.803505894831, 6566.146400967844, 9812.26408019387, 10565.9471702641, 10582.417967011888, 10653.467326633792, 10710.0, 10377.740556485845, 10571.841422378824, 10576.259661823906, 10616.309939853885, 10674.199435042248, 7158.248383919822, 7720.575368354795, 7962.124166341813, 8125.146859579895, 8174.713885013996, 8972.775680608038, 9000.144986226298, 9042.18620324174, 9043.366964312698, 9087.0, 7892.565908875067, 8057.0, 8136.389770767334, 8234.547099909563, 8238.629261683118, 7676.309132178131, 7879.960600196962, 8009.799755006172, 8082.474639148437, 8109.75670729879, 7487.513311634726, 7495.250474952461, 7529.774106776806, 7613.581253031137, 7625.123110842324, 5240.187770895517, 5446.836594902159, 5525.060739674345, 5591.552675785846, 5678.3186017678145, 5470.9179362308805, 5477.780888764405, 5531.363893152339, 5589.80435684749, 5694.17434471991], "value": 4742.467233113997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.41450997030125, 341.50652307415766, 343.7318891264814, 344.1001780344399, 346.1398424914088, 5741.966446039712, 5804.361520232771, 5831.300243970724, 5855.23881895353, 5872.265966754156, 5671.886562268752, 5686.753732275749, 5734.369219385864, 5742.454466825655, 5746.511546518541, 4223.64099051581, 4303.225419424502, 4450.577195166454, 4470.75410852403, 4477.350784136314, 4400.317950717628, 4403.471583409979, 4454.995252136535, 4455.175792478386, 4476.149531589004, 4404.97797511012, 4407.647388208936, 4426.911461770763, 4437.3597709362875, 4442.155990361821, 4355.738655680653, 4403.075354175595, 4430.158269928703, 4464.352668862996, 4488.124815660964, 3924.4113382992496, 3938.2911076006308, 3948.7433316834313, 3953.920921581581, 3960.1683646434285, 5489.286392768954, 5539.667619942817, 5541.556675465953, 5551.3893471718075, 5609.0184217762135, 4829.396325459317, 5034.446210916796, 5056.772445239973, 5086.821961231339, 5246.554042906358, 5945.791897283574, 5962.135490353874, 6039.184710064129, 6061.636301821861, 6124.173236613089, 4333.891652708676, 4342.2401079811225, 4366.934495982563, 4368.563143685637, 4374.671899607542, 6031.849203769897, 6112.786052488142, 6212.974859148235, 6258.405451482147, 6276.403741644582, 4425.601695847389, 4428.31361139024, 4429.269170586882, 4434.2484718536, 4445.155420470101, 4436.911261774746, 4442.577955094261, 4442.8222871085445, 4443.222436073739, 4455.153520831096, 4814.916643755197, 5037.4458809530925, 5050.368703912011, 5069.214271787879, 5098.719570423662, 5954.404559544011, 6034.426729460694, 6085.756569737249, 6095.939040609625, 6136.386361363917, 1503.9774403383958, 1530.5178868656337, 1537.5617948884737, 1541.514422956765, 1550.2713724549444, 965.9855102173473, 986.2208855004466, 1006.00405598457, 1030.6083688198437, 1031.7575369788094, 5825.446582574734, 5872.5628864020955, 5889.293284805765, 5889.617174883619, 5901.852453688606, 6123.958926982424, 6139.618585818155, 6184.350643182491, 6201.224846894138, 6256.874862502725, 5705.66067912154, 5887.11693246008, 5895.793647222326, 5903.3801450847905, 5909.674967876808, 3274.4433446314183, 3294.6705329466863, 3305.685959833812, 3312.9834350828573, 3323.6177839548277, 6211.254649442096, 6377.692573022519, 6422.2293324800385, 6476.579022363531, 6556.967215163989, 6346.809595712136, 6380.266269378988, 6382.36176382358, 6384.872302553923, 6390.45681117101, 6295.685215739195, 6465.353464653497, 6478.157839480931, 6581.630612979324, 6583.637899915455, 6240.157578726814, 6262.463702200616, 6280.466160376236, 6282.465990390868, 6344.714487847966, 6164.3356293799525, 6167.599106058092, 6208.50331973432, 6215.471684906653, 6229.50163986889, 6221.9377806221355, 6495.123158373559, 6512.674366281762, 6518.902216466851, 6537.673116344259, 4389.956100438954, 4411.757353345597, 4427.756473393994, 4435.645148388056, 4458.866234012985, 6062.575619706578, 6235.438810507076, 6244.6261822399, 6252.562320637694, 6270.341614130451, 5949.345571986992, 5961.7615295387695, 6043.7884674036195, 6056.636601803906, 6064.48451881595, 5974.522038236843, 6022.759089636365, 6029.60807547508, 6058.848528786815, 6106.084087386927, 5859.677717725566, 5981.252343457068, 6000.969995149996, 6015.187949626919, 6031.69841507914, 6086.543509236736, 6129.264488261437, 6138.324784273816, 6155.645757933247, 6164.630122192682, 5907.611711247768, 5963.701814909324, 5973.49225315853, 6028.969855150872, 6040.546958978182], "value": 4602.798698278773, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.3866480806989, 814.4665244265009, 838.1576515601821, 856.7044369692458, 936.5083331251093, 15323.616909577253, 15565.844341556582, 15753.054816710992, 15832.208389580519, 17586.120693965313, 16031.0, 16102.275397607107, 16245.350185992576, 16246.43137490188, 16247.106409147493, 847.9364047696416, 868.5092922498784, 877.7015814623027, 884.2483888694622, 892.192565728014, 888.4314039015003, 890.9465432074096, 895.2882458445519, 898.6989358564889, 898.9910100899006, 930.3255140023463, 935.7567032571512, 935.7941252924346, 938.3947353956694, 939.4973689076346, 928.0951072704094, 931.3992474853716, 932.7341707613298, 934.5093825741473, 934.621478301289, 682.8019874236516, 683.4156795939499, 684.736376495048, 687.5530904911798, 687.556526040701, 16532.338706451726, 16808.411705590246, 16835.989840609604, 16851.915740421344, 16876.662466750597, 15300.311485983157, 15375.769363459445, 15798.763018554731, 16009.199540022952, 16226.188690565425, 12228.938855305756, 13050.347482625926, 13398.330083495885, 13409.262490563015, 13657.112287701368, 3735.589085200626, 3770.981145094257, 3794.962050379516, 3820.121372084436, 3868.941965870514, 75783.86324205197, 78833.60583197104, 80028.0, 80195.0, 80339.0, 12466.189697669623, 12627.936860315824, 12660.683482913, 12861.871381286255, 13241.205527668371, 22901.88549057244, 22940.885295573415, 22960.425989350068, 23149.76850231476, 23229.070837166324, 9231.584578693975, 9327.766805829908, 9333.486658233727, 9352.111549402796, 9418.858717119248, 5237.6857388556045, 5273.947260527422, 5356.0, 5469.890602187934, 5544.722763861791, 3854.5374555053572, 3977.085270387769, 4009.8195581198916, 4010.1378203685763, 4020.2160578686876, 724.3625609463744, 727.8762610356252, 729.6885210193828, 735.9521631094069, 736.3704033051771, 777.4052849570083, 819.1521774963004, 825.8348330333957, 828.2338836576143, 855.9358048146414, 11466.140039497071, 11556.711082222844, 11631.941840290745, 11833.940830295793, 11886.34625095628, 704.3942209699654, 765.9582967164652, 805.5569436809849, 828.45736042892, 848.4951453884929, 5436.238926550286, 5441.483059109379, 5523.7238138092935, 5584.916226256528, 5587.636803607753, 72934.27065729274, 75438.24561754313, 92678.53660731787, 105935.47032264789, 107093.0, 66200.33799662038, 86349.13650863536, 95955.0, 98637.0, 100191.0, 84042.57978710068, 90564.5471772637, 91731.08268917359, 92734.0, 92853.0, 10346.637867674595, 10555.500544608438, 10702.197335199735, 10781.0, 10787.08309793645, 53795.19307210317, 53836.46163538471, 53961.73019134879, 54095.0, 55843.0, 66883.66558167178, 77370.0, 77757.0, 79578.6021069891, 82038.58980705058, 14140.363683634056, 14344.198941862029, 14511.927440362731, 14580.125192488485, 14779.209382105251, 15632.531024068841, 16286.0, 16403.58991025234, 16774.832251677326, 16890.74663880018, 15403.152826594196, 15507.689846203239, 15562.455314063953, 16493.505194844172, 16653.66692666164, 14306.499272525412, 15297.311620977305, 15563.922180389025, 15698.843011570196, 15751.842481575037, 15165.848341516443, 15216.923915380352, 15525.76711349308, 16116.113613750887, 16311.510654680378, 11637.592684256011, 11994.820077698667, 12020.278783272683, 12297.56958506448, 12594.018713963751, 12738.490460381481, 13234.602961911158, 13384.0, 13396.799048014092, 13419.127756695783], "value": 8234.876703662934, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 104.0, 114.0, 111.0, 111.0, 113.0, 112.0, 111.0, 112.0, 109.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 151.0, 179.0, 125.0, 153.0, 153.0, 126.0, 204.0, 126.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 164.0, 161.0, 163.0, 163.0, 162.0, 162.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 172.0, 83.0, 76.0, 79.0, 75.0, 167.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 151.0, 84.0, 85.0, 86.0, 137.0, 86.0, 84.0, 142.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 146.0, 147.0, 148.0, 146.0, 147.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 54.0, 54.0, 53.0, 53.0, 58.0, 52.0, 52.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 78.0, 78.0, 79.0, 77.0, 78.0, 78.0, 107.0, 78.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 116.0, 124.0, 116.0, 117.0, 125.0, 123.0, 121.0, 135.0, 126.0], "value": 122.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 154.0, 157.0, 157.0, 153.0, 152.0, 152.0, 155.0, 161.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 61.0, 61.0, 63.0, 61.0, 61.0, 60.0, 61.0], "value": 61.8, "unit": "score"}]}]} 07:16:12 INFO - Return code: 0 07:16:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:16:12 ERROR - # TBPL SUCCESS # 07:16:12 INFO - Running post-action listener: _resource_record_post_action 07:16:12 INFO - ##### 07:16:12 INFO - ##### Finished run-tests step (success) 07:16:12 INFO - ##### 07:16:12 INFO - Running post-run listener: _resource_record_post_run 07:16:12 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505442304; Read time: 20; Write time: 1641632 07:16:12 INFO - TinderboxPrint: CPU usage
13.4% 07:16:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 07:16:12 INFO - TinderboxPrint: I/O write bytes / time
505,442,304 / 1,641,632 07:16:12 INFO - TinderboxPrint: CPU idle
8,239.3 (86.6%) 07:16:12 INFO - TinderboxPrint: CPU user
1,211.5 (12.7%) 07:16:12 INFO - TinderboxPrint: Swap in / out
0 / 0 07:16:12 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 252874752; Read time: 0; Write time: 1283716 07:16:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251191296; Read time: 20; Write time: 357804 07:16:13 INFO - Running post-run listener: _upload_blobber_files 07:16:13 INFO - Blob upload gear active. 07:16:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:16:13 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 07:16:13 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'] 07:16:13 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 07:16:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:17 INFO - (blobuploader) - INFO - Done attempting. 07:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:18 INFO - (blobuploader) - INFO - Done attempting. 07:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:19 INFO - (blobuploader) - INFO - Done attempting. 07:16:19 INFO - (blobuploader) - INFO - Iteration through files over. 07:16:19 INFO - Return code: 0 07:16:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:16:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:16:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c06fd77fb073e93136487448211665b951bea9d56a6deb980cc641b323a7776e0e6cf0fa276e117ed850cceffa43fecf0d2661372c75921fb4293a2e0d1aa0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cdbb10f5a07c126dd2e441621638fa5b07ea745a0ce924fe31d70c7335c0fba9d2118058bd8960dcd791e02fd042aec3f9a6300848262b73b91066a68fc2cab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d29d05b39a1a50a45d635792ec3177f1b115122443ecd8a62226f647db4cbf41edecbb3498c386aa0b250dd6b39eb065d4c771d73cbdabe0086db04b53beadab"} 07:16:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:16:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:16:19 INFO - Contents: 07:16:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c06fd77fb073e93136487448211665b951bea9d56a6deb980cc641b323a7776e0e6cf0fa276e117ed850cceffa43fecf0d2661372c75921fb4293a2e0d1aa0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cdbb10f5a07c126dd2e441621638fa5b07ea745a0ce924fe31d70c7335c0fba9d2118058bd8960dcd791e02fd042aec3f9a6300848262b73b91066a68fc2cab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d29d05b39a1a50a45d635792ec3177f1b115122443ecd8a62226f647db4cbf41edecbb3498c386aa0b250dd6b39eb065d4c771d73cbdabe0086db04b53beadab"} 07:16:19 INFO - Running post-run listener: copy_logs_to_upload_dir 07:16:19 INFO - Copying logs to upload dir... 07:16:19 INFO - mkdir: /builds/slave/test/build/upload/logs 07:16:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.550916 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-14 07:16:19.042944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:19.046098) ========= 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=df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179 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/4c06fd77fb073e93136487448211665b951bea9d56a6deb980cc641b323a7776e0e6cf0fa276e117ed850cceffa43fecf0d2661372c75921fb4293a2e0d1aa0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cdbb10f5a07c126dd2e441621638fa5b07ea745a0ce924fe31d70c7335c0fba9d2118058bd8960dcd791e02fd042aec3f9a6300848262b73b91066a68fc2cab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d29d05b39a1a50a45d635792ec3177f1b115122443ecd8a62226f647db4cbf41edecbb3498c386aa0b250dd6b39eb065d4c771d73cbdabe0086db04b53beadab"} build_url:https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011045 build_url: 'https://queue.taskcluster.net/v1/task/Ejy1w4DbQR6q4iS2vkVw4g/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/4c06fd77fb073e93136487448211665b951bea9d56a6deb980cc641b323a7776e0e6cf0fa276e117ed850cceffa43fecf0d2661372c75921fb4293a2e0d1aa0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cdbb10f5a07c126dd2e441621638fa5b07ea745a0ce924fe31d70c7335c0fba9d2118058bd8960dcd791e02fd042aec3f9a6300848262b73b91066a68fc2cab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d29d05b39a1a50a45d635792ec3177f1b115122443ecd8a62226f647db4cbf41edecbb3498c386aa0b250dd6b39eb065d4c771d73cbdabe0086db04b53beadab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:19.071627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:19.072031) ========= 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=df17445c3590ff7897617a0e00000225-1468504529.72269-1239828179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:19.157609) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:16:19.157924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:16:19.158286) ========= ========= Total master_lag: 0.17 =========