builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0146 starttime: 1463512283.5 results: success (0) buildid: 20160517092038 builduid: 1a7c353b68f5472f81b5321e3f9bb813 revision: c331e892afc78f9fa1556d6e00fc23ecf4b223e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:23.501706) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:23.502109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:23.502385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:23.542493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:23.542758) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.biZBO483Qa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-17 12:11:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 163M=0s 2016-05-17 12:11:24 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.521245 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:24.090082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:24.090359) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.biZBO483Qa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027903 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:24.138324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 12:11:24.138619) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c331e892afc78f9fa1556d6e00fc23ecf4b223e4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c331e892afc78f9fa1556d6e00fc23ecf4b223e4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.biZBO483Qa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-17 12:11:24,231 truncating revision to first 12 chars 2016-05-17 12:11:24,231 Setting DEBUG logging. 2016-05-17 12:11:24,231 attempt 1/10 2016-05-17 12:11:24,231 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c331e892afc7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 12:11:25,332 unpacking tar archive at: fx-team-c331e892afc7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355434 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 12:11:25.666278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:25.666609) ========= script_repo_revision: c331e892afc78f9fa1556d6e00fc23ecf4b223e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:25.666998) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:25.667279) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 12:11:25.681640) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-05-17 12:11:25.681987) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.biZBO483Qa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:11:25 INFO - MultiFileLogger online at 20160517 12:11:25 in /builds/slave/test 12:11:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:11:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:11:25 INFO - {'append_to_log': False, 12:11:25 INFO - 'base_work_dir': '/builds/slave/test', 12:11:25 INFO - 'blob_upload_branch': 'Fx-Team', 12:11:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:11:25 INFO - 'branch': 'Fx-Team', 12:11:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:11:25 INFO - 'config_files': ('talos/mac_config.py',), 12:11:25 INFO - 'default_actions': ('clobber', 12:11:25 INFO - 'read-buildbot-config', 12:11:25 INFO - 'download-and-extract', 12:11:25 INFO - 'populate-webroot', 12:11:25 INFO - 'create-virtualenv', 12:11:25 INFO - 'install', 12:11:25 INFO - 'run-tests'), 12:11:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:11:25 INFO - 'download_minidump_stackwalk': True, 12:11:25 INFO - 'download_symbols': 'ondemand', 12:11:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:11:25 INFO - 'tooltool.py': '/tools/tooltool.py', 12:11:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:11:25 INFO - '/tools/misc-python/virtualenv.py')}, 12:11:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:11:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:11:25 INFO - 'installer_path': 'installer.exe', 12:11:25 INFO - 'log_level': 'info', 12:11:25 INFO - 'log_name': 'talos', 12:11:25 INFO - 'log_to_console': True, 12:11:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:11:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:11:25 INFO - 'opt_config_files': (), 12:11:25 INFO - 'pip_index': False, 12:11:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:11:25 INFO - 'cmd': ('bash', 12:11:25 INFO - '-c', 12:11:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:11:25 INFO - 'enabled': True, 12:11:25 INFO - 'halt_on_failure': False, 12:11:25 INFO - 'name': 'check_screen_resolution'},), 12:11:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:11:25 INFO - 'cmd': ('bash', 12:11:25 INFO - '-c', 12:11:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:11:25 INFO - 'enabled': True, 12:11:25 INFO - 'halt_on_failure': False, 12:11:25 INFO - 'name': 'check_screen_resolution'},), 12:11:25 INFO - 'run_cmd_checks_enabled': True, 12:11:25 INFO - 'sps_profile': False, 12:11:25 INFO - 'sps_profile_interval': 0, 12:11:25 INFO - 'suite': 'dromaeojs-e10s', 12:11:25 INFO - 'system_bits': '32', 12:11:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:11:25 INFO - 'title': 't-yosemite-r7-0146', 12:11:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:11:25 INFO - 'use_talos_json': True, 12:11:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:11:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:11:25 INFO - 'work_dir': 'build'} 12:11:25 INFO - ##### 12:11:25 INFO - ##### Running clobber step. 12:11:25 INFO - ##### 12:11:25 INFO - Running pre-action listener: _resource_record_pre_action 12:11:25 INFO - Running main action method: clobber 12:11:25 INFO - rmtree: /builds/slave/test/build 12:11:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:11:28 INFO - Running post-action listener: _resource_record_post_action 12:11:28 INFO - ##### 12:11:28 INFO - ##### Finished clobber step (success) 12:11:28 INFO - ##### 12:11:28 INFO - ##### 12:11:28 INFO - ##### Running read-buildbot-config step. 12:11:28 INFO - ##### 12:11:28 INFO - Running pre-action listener: _resource_record_pre_action 12:11:28 INFO - Running main action method: read_buildbot_config 12:11:28 INFO - Using buildbot properties: 12:11:28 INFO - { 12:11:28 INFO - "project": "", 12:11:28 INFO - "product": "firefox", 12:11:28 INFO - "script_repo_revision": "production", 12:11:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:11:28 INFO - "repository": "", 12:11:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:11:28 INFO - "buildid": "20160517092038", 12:11:28 INFO - "pgo_build": "False", 12:11:28 INFO - "basedir": "/builds/slave/test", 12:11:28 INFO - "buildnumber": 8, 12:11:28 INFO - "slavename": "t-yosemite-r7-0146", 12:11:28 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 12:11:28 INFO - "platform": "yosemite_r7", 12:11:28 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:11:28 INFO - "branch": "fx-team", 12:11:28 INFO - "repo_path": "integration/fx-team", 12:11:28 INFO - "revision": "c331e892afc78f9fa1556d6e00fc23ecf4b223e4", 12:11:28 INFO - "stage_platform": "macosx64", 12:11:28 INFO - "builduid": "1a7c353b68f5472f81b5321e3f9bb813", 12:11:28 INFO - "slavebuilddir": "test" 12:11:28 INFO - } 12:11:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 12:11:28 INFO - Running post-action listener: _resource_record_post_action 12:11:28 INFO - ##### 12:11:28 INFO - ##### Finished read-buildbot-config step (success) 12:11:28 INFO - ##### 12:11:28 INFO - ##### 12:11:28 INFO - ##### Running download-and-extract step. 12:11:28 INFO - ##### 12:11:28 INFO - Running pre-action listener: _resource_record_pre_action 12:11:28 INFO - Running main action method: download_and_extract 12:11:28 INFO - mkdir: /builds/slave/test/build/tests 12:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:28 INFO - https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 12:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 12:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 12:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 12:11:58 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 12:11:58 INFO - retry: attempt #1 caught exception: timed out 12:11:58 INFO - retry: Failed, sleeping 30 seconds before retrying 12:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #2 12:12:30 INFO - Downloaded 1199 bytes. 12:12:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 12:12:30 INFO - Using the following test package requirements: 12:12:30 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 12:12:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:12:30 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 12:12:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:12:30 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 12:12:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:12:30 INFO - u'jsshell-mac.zip'], 12:12:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:12:30 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 12:12:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 12:12:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:12:30 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 12:12:30 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:12:30 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 12:12:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:12:30 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 12:12:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:12:30 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 12:12:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:30 INFO - https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:12:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:12:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:12:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:12:33 INFO - Downloaded 18267714 bytes. 12:12:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:12:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:12:36 INFO - Return code: 0 12:12:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:12: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')]} 12:12:36 INFO - https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:12:37 INFO - Downloaded 18267714 bytes. 12:12:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:12:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:12:41 INFO - Return code: 0 12:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:41 INFO - https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:12:42 INFO - Downloaded 10840194 bytes. 12:12:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:12:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:12:42 INFO - Return code: 0 12:12:42 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')]} 12:12:42 INFO - https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 12:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 12:12:45 INFO - Downloaded 109963999 bytes. 12:12:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:12:45 INFO - mkdir: /builds/slave/test/properties 12:12:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:12:45 INFO - Writing to file /builds/slave/test/properties/build_url 12:12:45 INFO - Contents: 12:12:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:12:46 INFO - Running post-action listener: _resource_record_post_action 12:12:46 INFO - Running post-action listener: set_extra_try_arguments 12:12:46 INFO - ##### 12:12:46 INFO - ##### Finished download-and-extract step (success) 12:12:46 INFO - ##### 12:12:46 INFO - ##### 12:12:46 INFO - ##### Running populate-webroot step. 12:12:46 INFO - ##### 12:12:46 INFO - Running pre-action listener: _resource_record_pre_action 12:12:46 INFO - Running main action method: populate_webroot 12:12:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:12:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:12:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:12:46 INFO - '--tppagecycles', 12:12:46 INFO - '7'], 12:12:46 INFO - 'tests': ['tsvgm']}}, 12:12:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:12:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:12:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:12:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:12:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:46 INFO - 'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:46 INFO - 'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['damp', 'tps']}, 12:12:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:46 INFO - 'tests': ['damp', 'tps']}, 12:12:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['dromaeo_dom']}, 12:12:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:12:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['a11yr', 12:12:46 INFO - 'ts_paint', 12:12:46 INFO - 'tpaint', 12:12:46 INFO - 'sessionrestore', 12:12:46 INFO - 'sessionrestore_no_auto_restore', 12:12:46 INFO - 'tabpaint']}, 12:12:46 INFO - 'other-e10s': {'tests': ['a11yr', 12:12:46 INFO - 'ts_paint', 12:12:46 INFO - 'tpaint', 12:12:46 INFO - 'sessionrestore', 12:12:46 INFO - 'sessionrestore_no_auto_restore', 12:12:46 INFO - 'tabpaint']}, 12:12:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:12:46 INFO - 'ts_paint', 12:12:46 INFO - 'tpaint', 12:12:46 INFO - 'sessionrestore', 12:12:46 INFO - 'sessionrestore_no_auto_restore', 12:12:46 INFO - 'tabpaint']}, 12:12:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:12:46 INFO - 'ts_paint', 12:12:46 INFO - 'tpaint', 12:12:46 INFO - 'sessionrestore', 12:12:46 INFO - 'sessionrestore_no_auto_restore', 12:12:46 INFO - 'tabpaint']}, 12:12:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['a11yr', 12:12:46 INFO - 'ts_paint', 12:12:46 INFO - 'tpaint', 12:12:46 INFO - 'sessionrestore', 12:12:46 INFO - 'sessionrestore_no_auto_restore', 12:12:46 INFO - 'tabpaint']}, 12:12:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['a11yr', 12:12:46 INFO - 'ts_paint', 12:12:46 INFO - 'tpaint', 12:12:46 INFO - 'sessionrestore', 12:12:46 INFO - 'sessionrestore_no_auto_restore', 12:12:46 INFO - 'tabpaint']}, 12:12:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['tsvgx', 12:12:46 INFO - 'tsvgr_opacity', 12:12:46 INFO - 'tart', 12:12:46 INFO - 'tscrollx', 12:12:46 INFO - 'cart']}, 12:12:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:12:46 INFO - 'tsvgr_opacity', 12:12:46 INFO - 'tart', 12:12:46 INFO - 'tscrollx', 12:12:46 INFO - 'cart']}, 12:12:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:46 INFO - 'talos_options': ['--disable-e10s'], 12:12:46 INFO - 'tests': ['tp5o']}, 12:12:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:46 INFO - 'tests': ['tp5o']}, 12:12:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:46 INFO - 'talos_options': ['--disable-e10s', 12:12:46 INFO - '--xperf_path', 12:12:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:46 INFO - 'tests': ['tp5n']}, 12:12:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:46 INFO - 'talos_options': ['--xperf_path', 12:12:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:46 INFO - 'tests': ['tp5n']}}, 12:12:46 INFO - 'talos.zip': {'path': '', 12:12:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:12:46 INFO - Running post-action listener: _resource_record_post_action 12:12:46 INFO - ##### 12:12:46 INFO - ##### Finished populate-webroot step (success) 12:12:46 INFO - ##### 12:12:46 INFO - ##### 12:12:46 INFO - ##### Running create-virtualenv step. 12:12:46 INFO - ##### 12:12:46 INFO - Running pre-action listener: _resource_record_pre_action 12:12:46 INFO - Running main action method: create_virtualenv 12:12:46 INFO - Creating virtualenv /builds/slave/test/build/venv 12:12:46 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 12:12:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:12:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:12:46 INFO - Using real prefix '/tools/python27' 12:12:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:12:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:12:50 INFO - Installing pip.................done. 12:12:50 INFO - Return code: 0 12:12:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:12: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')]} 12:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12: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')]} 12:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:50 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 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:12:50 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 12:12:50 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 12:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:50 INFO - 'HOME': '/Users/cltbld', 12:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:50 INFO - 'LOGNAME': 'cltbld', 12:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:50 INFO - 'MOZ_NO_REMOTE': '1', 12:12:50 INFO - 'NO_EM_RESTART': '1', 12:12:50 INFO - 'PAGER': '/bin/cat', 12:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:50 INFO - 'PWD': '/builds/slave/test', 12:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:50 INFO - 'SHELL': '/bin/bash', 12:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:12:50 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:50 INFO - 'USER': 'cltbld', 12:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:50 INFO - 'XPC_FLAGS': '0x0', 12:12:50 INFO - 'XPC_SERVICE_NAME': '0', 12:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:51 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 12:12:51 INFO - Cleaning up... 12:12:51 INFO - Return code: 0 12:12:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:12: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')]} 12:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12: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')]} 12:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:51 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 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:12:51 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 12:12:51 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 12:12:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:12:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:51 INFO - 'HOME': '/Users/cltbld', 12:12:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:51 INFO - 'LOGNAME': 'cltbld', 12:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:51 INFO - 'MOZ_NO_REMOTE': '1', 12:12:51 INFO - 'NO_EM_RESTART': '1', 12:12:51 INFO - 'PAGER': '/bin/cat', 12:12:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:51 INFO - 'PWD': '/builds/slave/test', 12:12:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:51 INFO - 'SHELL': '/bin/bash', 12:12:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:12:51 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:12:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:51 INFO - 'USER': 'cltbld', 12:12:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:51 INFO - 'XPC_FLAGS': '0x0', 12:12:51 INFO - 'XPC_SERVICE_NAME': '0', 12:12:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:51 INFO - Downloading/unpacking psutil>=3.1.1 12:12:51 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 12:12:51 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 12:12:51 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 12:12:51 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 12:12:51 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 12:12:51 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 12:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:12:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:12:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:12:54 INFO - Installing collected packages: psutil 12:12:54 INFO - Running setup.py install for psutil 12:12:54 INFO - building 'psutil._psutil_osx' extension 12:12:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:12:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:12:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:12:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:12:55 INFO - building 'psutil._psutil_posix' extension 12:12:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:12:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:12:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:12:55 INFO - ^ 12:12:55 INFO - 1 warning generated. 12:12:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:12:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:12:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:12:55 INFO - Successfully installed psutil 12:12:55 INFO - Cleaning up... 12:12:55 INFO - Return code: 0 12:12:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:12:55 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')]} 12:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:55 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')]} 12:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:55 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 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:12:55 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 12:12:55 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 12:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:55 INFO - 'HOME': '/Users/cltbld', 12:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:55 INFO - 'LOGNAME': 'cltbld', 12:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:55 INFO - 'MOZ_NO_REMOTE': '1', 12:12:55 INFO - 'NO_EM_RESTART': '1', 12:12:55 INFO - 'PAGER': '/bin/cat', 12:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:55 INFO - 'PWD': '/builds/slave/test', 12:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:55 INFO - 'SHELL': '/bin/bash', 12:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:12:55 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:55 INFO - 'USER': 'cltbld', 12:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:55 INFO - 'XPC_FLAGS': '0x0', 12:12:55 INFO - 'XPC_SERVICE_NAME': '0', 12:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:12:56 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 12:12:56 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 12:12:56 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 12:12:56 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 12:12:56 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 12:12:56 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 12:12:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:12:58 INFO - Installing collected packages: mozsystemmonitor 12:12:58 INFO - Running setup.py install for mozsystemmonitor 12:12:58 INFO - Successfully installed mozsystemmonitor 12:12:58 INFO - Cleaning up... 12:12:58 INFO - Return code: 0 12:12:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:58 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 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:12:58 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 12:12:58 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 12:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:58 INFO - 'HOME': '/Users/cltbld', 12:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:58 INFO - 'LOGNAME': 'cltbld', 12:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:58 INFO - 'MOZ_NO_REMOTE': '1', 12:12:58 INFO - 'NO_EM_RESTART': '1', 12:12:58 INFO - 'PAGER': '/bin/cat', 12:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:58 INFO - 'PWD': '/builds/slave/test', 12:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:58 INFO - 'SHELL': '/bin/bash', 12:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:12:58 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:58 INFO - 'USER': 'cltbld', 12:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:58 INFO - 'XPC_FLAGS': '0x0', 12:12:58 INFO - 'XPC_SERVICE_NAME': '0', 12:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:59 INFO - Downloading/unpacking blobuploader==1.2.4 12:12:59 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 12:12:59 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 12:12:59 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 12:12:59 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 12:12:59 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 12:12:59 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 12:13:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:13:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:13:01 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 12:13:01 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 12:13:01 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 12:13:01 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 12:13:01 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 12:13:01 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 12:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:13:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:02 INFO - Downloading docopt-0.6.1.tar.gz 12:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:13:03 INFO - Installing collected packages: blobuploader, requests, docopt 12:13:03 INFO - Running setup.py install for blobuploader 12:13:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:13:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:13:03 INFO - Running setup.py install for requests 12:13:03 INFO - Running setup.py install for docopt 12:13:03 INFO - Successfully installed blobuploader requests docopt 12:13:03 INFO - Cleaning up... 12:13:03 INFO - Return code: 0 12:13:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:03 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 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:13:03 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 12:13:03 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 12:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:03 INFO - 'HOME': '/Users/cltbld', 12:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:03 INFO - 'LOGNAME': 'cltbld', 12:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:03 INFO - 'MOZ_NO_REMOTE': '1', 12:13:03 INFO - 'NO_EM_RESTART': '1', 12:13:03 INFO - 'PAGER': '/bin/cat', 12:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:03 INFO - 'PWD': '/builds/slave/test', 12:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:03 INFO - 'SHELL': '/bin/bash', 12:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:13:03 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:03 INFO - 'USER': 'cltbld', 12:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:03 INFO - 'XPC_FLAGS': '0x0', 12:13:03 INFO - 'XPC_SERVICE_NAME': '0', 12:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NSzEGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-gBgXvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-SbvwqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-KS3o_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-x8A1ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-SSNjGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-JPrGmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-b8VxR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:04 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-zLSf69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-4XxgiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-WZ1wby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-oNkVvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-gnqTsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-oyjhUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-vemhaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-6V4KCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:05 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ZiYZk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:13:05 INFO - Running setup.py install for manifestparser 12:13:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Running setup.py install for mozcrash 12:13:06 INFO - Running setup.py install for mozdebug 12:13:06 INFO - Running setup.py install for mozdevice 12:13:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Running setup.py install for mozfile 12:13:06 INFO - Running setup.py install for mozhttpd 12:13:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Running setup.py install for mozinfo 12:13:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:13:06 INFO - Running setup.py install for mozInstall 12:13:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Running setup.py install for mozleak 12:13:07 INFO - Running setup.py install for mozlog 12:13:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Running setup.py install for moznetwork 12:13:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Running setup.py install for mozprocess 12:13:07 INFO - Running setup.py install for mozprofile 12:13:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:13:07 INFO - Running setup.py install for mozrunner 12:13:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:13:08 INFO - Running setup.py install for mozscreenshot 12:13:08 INFO - Running setup.py install for moztest 12:13:08 INFO - Running setup.py install for mozversion 12:13:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:13:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:13:08 INFO - Cleaning up... 12:13:08 INFO - Return code: 0 12:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:08 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 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:13:08 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 12:13:08 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 12:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:08 INFO - 'HOME': '/Users/cltbld', 12:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:08 INFO - 'LOGNAME': 'cltbld', 12:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:08 INFO - 'MOZ_NO_REMOTE': '1', 12:13:08 INFO - 'NO_EM_RESTART': '1', 12:13:08 INFO - 'PAGER': '/bin/cat', 12:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:08 INFO - 'PWD': '/builds/slave/test', 12:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:08 INFO - 'SHELL': '/bin/bash', 12:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:13:08 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:08 INFO - 'USER': 'cltbld', 12:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:08 INFO - 'XPC_FLAGS': '0x0', 12:13:08 INFO - 'XPC_SERVICE_NAME': '0', 12:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:08 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-PNu90m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:08 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-rFqmoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:08 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)) 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:08 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-W2oglp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-JgATxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-soW5th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-BGSGDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-wfIgzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-y10Q4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-3dJW8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-BJaMi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-9DK5yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:09 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)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-YJFj3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:09 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-9i17y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:10 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)) 12:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-2cEsjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-_UNnFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:10 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)) 12:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-PfmbN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:10 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)) 12:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:10 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-XqHt9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:10 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)) 12:13:10 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)) 12:13:10 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)) 12:13:10 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)) 12:13:10 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)) 12:13:10 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)) 12:13:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:13:10 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 12:13:10 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 12:13:10 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 12:13:10 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 12:13:10 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 12:13:10 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 12:13:12 INFO - Downloading blessings-1.6.tar.gz 12:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:13:13 INFO - Installing collected packages: blessings 12:13:13 INFO - Running setup.py install for blessings 12:13:13 INFO - Successfully installed blessings 12:13:13 INFO - Cleaning up... 12:13:13 INFO - Return code: 0 12:13:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:13:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:13 INFO - Reading from file tmpfile_stdout 12:13:13 INFO - Current package versions: 12:13:13 INFO - blessings == 1.6 12:13:13 INFO - blobuploader == 1.2.4 12:13:13 INFO - docopt == 0.6.1 12:13:13 INFO - manifestparser == 1.1 12:13:13 INFO - mozInstall == 1.12 12:13:13 INFO - mozcrash == 0.17 12:13:13 INFO - mozdebug == 0.1 12:13:13 INFO - mozdevice == 0.48 12:13:13 INFO - mozfile == 1.2 12:13:13 INFO - mozhttpd == 0.7 12:13:13 INFO - mozinfo == 0.9 12:13:13 INFO - mozleak == 0.1 12:13:13 INFO - mozlog == 3.2 12:13:13 INFO - moznetwork == 0.27 12:13:13 INFO - mozprocess == 0.22 12:13:13 INFO - mozprofile == 0.28 12:13:13 INFO - mozrunner == 6.11 12:13:13 INFO - mozscreenshot == 0.1 12:13:13 INFO - mozsystemmonitor == 0.3 12:13:13 INFO - moztest == 0.7 12:13:13 INFO - mozversion == 1.4 12:13:13 INFO - psutil == 3.1.1 12:13:13 INFO - requests == 1.2.3 12:13:13 INFO - wsgiref == 0.1.2 12:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:13 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 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:13:13 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 12:13:13 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 12:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:13 INFO - 'HOME': '/Users/cltbld', 12:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:13 INFO - 'LOGNAME': 'cltbld', 12:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:13 INFO - 'MOZ_NO_REMOTE': '1', 12:13:13 INFO - 'NO_EM_RESTART': '1', 12:13:13 INFO - 'PAGER': '/bin/cat', 12:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:13 INFO - 'PWD': '/builds/slave/test', 12:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:13 INFO - 'SHELL': '/bin/bash', 12:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:13:13 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:13 INFO - 'USER': 'cltbld', 12:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:13 INFO - 'XPC_FLAGS': '0x0', 12:13:13 INFO - 'XPC_SERVICE_NAME': '0', 12:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 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)) 12:13:13 INFO - Cleaning up... 12:13:13 INFO - Return code: 0 12:13:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:13 INFO - 'HOME': '/Users/cltbld', 12:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:13 INFO - 'LOGNAME': 'cltbld', 12:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:13 INFO - 'MOZ_NO_REMOTE': '1', 12:13:13 INFO - 'NO_EM_RESTART': '1', 12:13:13 INFO - 'PAGER': '/bin/cat', 12:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:13 INFO - 'PWD': '/builds/slave/test', 12:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:13 INFO - 'SHELL': '/bin/bash', 12:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:13:13 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:13 INFO - 'USER': 'cltbld', 12:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:13 INFO - 'XPC_FLAGS': '0x0', 12:13:13 INFO - 'XPC_SERVICE_NAME': '0', 12:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:14 INFO - Downloading/unpacking jsonschema 12:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:13:16 INFO - Downloading/unpacking functools32 (from jsonschema) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:16 INFO - Downloading functools32-3.2.3-2.tar.gz 12:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:13:16 INFO - warning: no files found matching '*.txt' 12:13:16 INFO - no previously-included directories found matching 'build' 12:13:16 INFO - no previously-included directories found matching 'dist' 12:13:16 INFO - no previously-included directories found matching '.git*' 12:13:16 INFO - Installing collected packages: jsonschema, functools32 12:13:17 INFO - Running setup.py install for functools32 12:13:17 INFO - warning: no files found matching '*.txt' 12:13:17 INFO - no previously-included directories found matching 'build' 12:13:17 INFO - no previously-included directories found matching 'dist' 12:13:17 INFO - no previously-included directories found matching '.git*' 12:13:17 INFO - Successfully installed jsonschema functools32 12:13:17 INFO - Cleaning up... 12:13:17 INFO - Return code: 0 12:13:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:17 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 0x10d9f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff361498cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:13:17 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 12:13:17 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 12:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:17 INFO - 'HOME': '/Users/cltbld', 12:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:17 INFO - 'LOGNAME': 'cltbld', 12:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:17 INFO - 'MOZ_NO_REMOTE': '1', 12:13:17 INFO - 'NO_EM_RESTART': '1', 12:13:17 INFO - 'PAGER': '/bin/cat', 12:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:17 INFO - 'PWD': '/builds/slave/test', 12:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:17 INFO - 'SHELL': '/bin/bash', 12:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:13:17 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:17 INFO - 'USER': 'cltbld', 12:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:17 INFO - 'XPC_FLAGS': '0x0', 12:13:17 INFO - 'XPC_SERVICE_NAME': '0', 12:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:17 INFO - Downloading/unpacking flake8 12:13:17 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 12:13:17 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 12:13:17 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 12:13:17 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 12:13:17 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 12:13:17 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 12:13:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:13:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:13:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:13:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:13:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:13:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:13:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:13:21 INFO - no previously-included directories found matching 'docs/_build' 12:13:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:13:21 INFO - Running setup.py install for pep8 12:13:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:13:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:13:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:13:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:13:21 INFO - no previously-included directories found matching 'docs/_build' 12:13:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:13:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:13:21 INFO - Cleaning up... 12:13:21 INFO - Return code: 0 12:13:21 INFO - Running post-action listener: _resource_record_post_action 12:13:21 INFO - Running post-action listener: _start_resource_monitoring 12:13:21 INFO - Starting resource monitoring. 12:13:21 INFO - ##### 12:13:21 INFO - ##### Finished create-virtualenv step (success) 12:13:21 INFO - ##### 12:13:21 INFO - ##### 12:13:21 INFO - ##### Running install step. 12:13:21 INFO - ##### 12:13:21 INFO - Running pre-action listener: _resource_record_pre_action 12:13:21 INFO - Running main action method: install 12:13:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:21 INFO - Reading from file tmpfile_stdout 12:13:21 INFO - Detecting whether we're running mozinstall >=1.0... 12:13:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:13:21 INFO - Reading from file tmpfile_stdout 12:13:21 INFO - Output received: 12:13:21 INFO - Usage: mozinstall [options] installer 12:13:21 INFO - Options: 12:13:21 INFO - -h, --help show this help message and exit 12:13:21 INFO - -d DEST, --destination=DEST 12:13:21 INFO - Directory to install application into. [default: 12:13:21 INFO - "/builds/slave/test"] 12:13:21 INFO - --app=APP Application being installed. [default: firefox] 12:13:21 INFO - mkdir: /builds/slave/test/build/application 12:13:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:13:56 INFO - Reading from file tmpfile_stdout 12:13:56 INFO - Output received: 12:13:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:13:56 INFO - Running post-action listener: _resource_record_post_action 12:13:56 INFO - ##### 12:13:56 INFO - ##### Finished install step (success) 12:13:56 INFO - ##### 12:13:56 INFO - ##### 12:13:56 INFO - ##### Running run-tests step. 12:13:56 INFO - ##### 12:13:56 INFO - Running pre-action listener: _resource_record_pre_action 12:13:56 INFO - Running main action method: run_tests 12:13:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:13:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:13:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:13:56 INFO - 2016-05-17 12:13:56.334 screenresolution[1644:7876] starting screenresolution argv=screenresolution get 12:13:56 INFO - 2016-05-17 12:13:56.337 screenresolution[1644:7876] Display 0: 1600x1200x32@60 12:13:56 INFO - 2016-05-17 12:13:56.343 screenresolution[1645:7878] starting screenresolution argv=screenresolution list 12:13:56 INFO - Available Modes on Display 0 12:13:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:13:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:13:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:13:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:13:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:13:56 INFO - Intel Iris: 12:13:56 INFO - Chipset Model: Intel Iris 12:13:56 INFO - Type: GPU 12:13:56 INFO - Bus: Built-In 12:13:56 INFO - VRAM (Dynamic, Max): 1536 MB 12:13:56 INFO - Vendor: Intel (0x8086) 12:13:56 INFO - Device ID: 0x0a2e 12:13:56 INFO - Revision ID: 0x0009 12:13:56 INFO - Displays: 12:13:56 INFO - Display: 12:13:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:13:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:13:56 INFO - Display Serial Number: 1600x1200 60 12:13:56 INFO - Main Display: Yes 12:13:56 INFO - Mirror: Off 12:13:56 INFO - Online: Yes 12:13:56 INFO - Rotation: Supported 12:13:56 INFO - Return code: 0 12:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:13:56 INFO - Python 2.7.3 12:13:56 INFO - Return code: 0 12:13:56 INFO - grabbing minidump binary from tooltool 12:13: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')]} 12:13:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/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 0x10d898d30>, '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 0x10d6bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d88fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:13:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:13:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:13:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:13:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:13:56 INFO - Return code: 0 12:13:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:13:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:13:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:13:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:13:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:13:57 INFO - Return code: 0 12:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 12:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --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 12:13:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.biZBO483Qa/Render', 12:13:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:57 INFO - 'HOME': '/Users/cltbld', 12:13:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:57 INFO - 'LOGNAME': 'cltbld', 12:13:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:13:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:57 INFO - 'MOZ_NO_REMOTE': '1', 12:13:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:13:57 INFO - 'NO_EM_RESTART': '1', 12:13:57 INFO - 'PAGER': '/bin/cat', 12:13:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:57 INFO - 'PWD': '/builds/slave/test', 12:13:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:13:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:57 INFO - 'SHELL': '/bin/bash', 12:13:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners', 12:13:57 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 12:13:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:57 INFO - 'USER': 'cltbld', 12:13:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:57 INFO - 'XPC_FLAGS': '0x0', 12:13:57 INFO - 'XPC_SERVICE_NAME': '0', 12:13:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 12:13:58 INFO - mozversion application_buildid: 20160517092038 12:13:58 INFO - mozversion application_changeset: c331e892afc78f9fa1556d6e00fc23ecf4b223e4 12:13:58 INFO - mozversion application_display_name: Nightly 12:13:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:13:58 INFO - mozversion application_name: Firefox 12:13:58 INFO - mozversion application_remotingname: firefox 12:13:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:13:58 INFO - mozversion application_vendor: Mozilla 12:13:58 INFO - mozversion application_version: 49.0a1 12:13:58 INFO - mozversion platform_buildid: 20160517092038 12:13:58 INFO - mozversion platform_changeset: c331e892afc78f9fa1556d6e00fc23ecf4b223e4 12:13:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:13:58 INFO - mozversion platform_version: 49.0a1 12:13:58 INFO - using testdate: 1463512438 12:13:58 INFO - actual date: 1463512438 12:13:58 INFO - starting webserver on 'localhost:49279' 12:13:58 INFO - SUITE-START | Running 2 tests 12:13:58 INFO - TEST-START | dromaeo_css 12:13:58 INFO - operating with platform_type : mac_ 12:13:58 INFO - Initialising browser for dromaeo_css test... 12:13:58 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmp0ULi36/profile http://localhost:49279/getInfo.html) 12:14:01 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 12:14:01 INFO - PROCESS | 1663 | colorDepth:24 12:14:01 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 12:14:01 INFO - PROCESS | 1663 | __metrics 12:14:01 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 12:14:01 INFO - TEST-INFO | 1663: exit 0 12:14:01 INFO - Browser initialized. 12:14:01 INFO - Running cycle 1/1 for dromaeo_css test... 12:14:01 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmp0ULi36/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:13 INFO - PROCESS | 1667 | RSS: Main: 249929728 12:14:13 INFO - PROCESS | 1667 | 12:15:03 INFO - PROCESS | 1667 | 1463512503584 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] 12:17:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 12:17:15 INFO - PROCESS | 1667 | RSS: Main: 262062080 12:17:15 INFO - PROCESS | 1667 | 12:20:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 12:20:18 INFO - PROCESS | 1667 | RSS: Main: 273580032 12:20:18 INFO - PROCESS | 1667 | 12:23:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 12:23:21 INFO - PROCESS | 1667 | RSS: Main: 275611648 12:23:21 INFO - PROCESS | 1667 | 12:26:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 12:26:23 INFO - PROCESS | 1667 | RSS: Main: 277176320 12:26:23 INFO - PROCESS | 1667 | 12:29:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 12:29:27 INFO - PROCESS | 1667 | RSS: Main: 280076288 12:29:27 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 12:32:29 INFO - PROCESS | 1667 | RSS: Main: 281141248 12:32:29 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | __start_tp_report 12:32:29 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 12:32:29 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 12:32:29 INFO - PROCESS | 1667 | |i|pagename|runs| 12:32:29 INFO - PROCESS | 1667 | |0;dojo.html;2889.581010753442;3082.614673165854;3488.1802776347554;3512.8243587820602;3514.2971405718863;5723.370429252779;5743.597948143632;5778.884422311557;5869.442402971721;5886.499647529965;5644.689542075184;5833.416658334175;5843.386444423338;5880.3825598312205;5965.46310832025;5174.43081261061;5265.86835329116;5278.3665960084845;5338.946610533883;5365.7585408656505;607.7820272638588;5166.483351664841;5208.5572726318305;5266;5274.868128296804;5217.999999999981;5238.083335416325;5270.92093618596;5281.973590132063;5317.12267475866;5213.973930130363;5240.449752775941;5275.314209152824;5289.523942845124;5296.3909150447425;5125.154349532323;5135.281060651511;5153.330067091291;5200.531952124327;5220.451852555503;4823.1800593899125;5552.194931734876;5624.718764061821;5709.600327977043;5713.657180569179;4465.37484752135;6164;6295;6298.244210694746;6304.27500837405;6123.3131248723375;6233.407826256498;6240.500759939194;6273.592216505913;6377.521685873532;5777.7977770777825;5930.525557955353;5935.020721580934;5969.492593129546;5974.910376344358;5199.844004679866;5885.823425297248;6250.812475625738;6344.8413789654705;6372.74509019634;6101.429060711456;6168.414000669929;6214.906776398358;6228.159198508234;6275;6252;6287.056941458726;6289.937100628935;6331.176946996953;6345.524085693592;6117.583823141483;6173.9073913891325;6209.410106039919;6218.284897236786;6293.276273228637;6290.591111577733;6296.779612713533;6309.085182648582;6316.431521163117;6345.111684364193;4961.2558116282125;4980.153373926441;4985.900281994413;5007.774650140679;5023.045621331935;4426.490953540319;4437.267850804646;4438.423005009328;4466.821327146878;4520.389747384061;5725.055365864586;5770.653760774367;5797.391273916262;5847.473727364558;5889.4699477046415;6284.591501552384;6290.245170579468;6300.3699630037545;6300.432961033437;6312.936870631235;5699.08814589672;5820.76716931318;5880.558958078076;5901.262342207224;5916.763329466773;4770.689905156154;5460.017196904516;5464.043792336404;5467.4532546745;5470.206820011155;6392.3927226913365;6420;6439.098526206335;6447.9355206447335;6460.580062295936;5460.972695136657;6112.938870611415;6175.814725558241;6258.217722784652;6292.465140463112;5860.179574859438;5957.046872500379;6377.795309189624;6407.839804004937;6418.775342863164;6251;6274.309825919237;6278;6279.403456671609;6302.275238347649;6105.328413874559;6120.690942950841;6195.535334849995;6310.11658367838;6320.494360451245;6174.9073763892675;6227.626342419469;6232.407921247474;6243.157173781481;6244.750209991549;5157.793688252428;6156.722947467285;6192.938070619236;6231.2522497300615;6234.781782637586;5024.371953505812;5769.538436924952;5798.188253644409;5939.3466718661775;6045.969770151121;6191.876162476815;6221.346758590464;6227.532935029801;6228.439440450381;6259.34276900937;6065.120557519223;6105.725242364193;6117.877642447215;6139.1098290746695;6151.569390142647 12:32:29 INFO - PROCESS | 1667 | |1;ext.html;526.344700847445;536.0806217337266;549.0638461423274;552.687731431741;561.8848136132092;38209.99999999996;38809.22381552371;40215.19569608606;40326.59673403269;40390;34527.65472345276;43952.3407148893;44798.77600612;44936.1012779745;46597;9716.417014979106;9859.852102218472;9871.555779989882;9877.259205559576;9878.160356369717;9103;9410.482423466707;9715.319927605071;9803.2157427406;9877.259205559576;9796.706098817047;9810.018998100204;9838.950805245964;9859.21126309897;9869.309148359618;8464.280536154434;9732.41605503672;9737.610495580167;9839.262055345842;9848.310618256724;9581.61673533058;9666.323357364987;9741.707748767549;9744.464054477;9803.950980245054;40731.185376292306;40786.59213407887;40859.38710919338;41113.383299250534;41196.58803411957;3228.564143840575;3371.6291207967106;3445.0526105320987;3524.7004004659634;3622.9094272643133;24835.130770422948;29112.835486580512;29203.415931681247;29959.801607935875;30242.69757302421;2672.786177105827;2806.256342069353;2824.985875070632;2828.589854471111;2930.0477344863007;335768;437021;437045;440848;442868.5713142892;60767.78464430775;60886.695566521885;61508.76982460326;61910;61955.69022154951;56888.71555642195;64653.67673161604;65995;66762.66618666875;66831.66584167047;15916.0450372978;16002.519924402286;16045.919770401306;16086.35654573804;16141.515754527149;12146.696332591579;12201.816972745415;12272.079594030483;12282.324472154118;12290.508379664714;16891.831081689026;16968.49094527166;17020.06389648581;17068.48794536166;17118.229679664444;6774.661266936732;7407.925850751611;7502.287282708134;7584.4311676624475;7597.506162099446;890;932.7201839448138;972.2707969023232;1004.1314263162312;1077.8197873328693;25693.614595781077;29471.705282947325;29858.40283194324;30425;30731.846340768152;933.9026643693633;948.4356807699546;1030.5517100061497;1090.2477290669412;1090.7273181704575;13216.603501894959;14896.851031489763;15579.844201558066;15626.687466250838;15928.964617299838;648064;666790;667568;671768;672823.9076413858;47559;55287.617809555086;62555;62607;62807;1441.617971237623;1451.003776585197;1461.978070328946;1487.315834716021;1487.4793822162374;30092;30106.69893301039;30241.243968900955;30243.848780755954;30385.088447346614;44142.77928610337;53186.4681353197;53725.19412208742;53754.19368709551;53838.65403364947;483936;483982;486633;487367;487713;24027;26887.73112268852;27294.45411091807;28646.140615781558;41237.38143927904;46669.833254168916;47493.52506475029;47817.08731650695;48221;48972.5102748968;38013.80993095017;39481.40777888391;39715.80852574427;40157.79921100376;40293.59706403016;33728.83135584307;37720.811395942845;38455;38612;39369.80315098406;38158.61841381661;38778.80610596929;38949.83150505489;38991.415128772525;39039.41440878446;32777.672223278416;33467.49798752972;34473.827630861684;34488.31023379569;34820;25318.620220696335;25330.493390131727;25518.23445296644;25780.355491112874;25826.870865645553 12:32:29 INFO - PROCESS | 1667 | |2;jquery.html;327.3713276449663;382.4301790332404;388.36890053662796;397.3225650266296;406.8494656976919;20030.89984550077;21807.23674671387;22050.22824201155;22678.206262780786;22742.862856857173;18059.90970045148;21219.257325993593;21553.56892862142;22189.445263868412;22373.664395034048;5778.43982124826;5811.27359080115;6044.093385992114;6063.151158837766;6068.757249710006;4103.302438585448;5947.494462970652;5972.074328479092;6268.65522396268;6618.437432818217;6616.536842421033;6621.37096975789;6626.801195964104;6661.666916654172;6669.199696036482;6340.270868850095;6648.66756662165;6656.13470248867;6671.866562668768;6682.565633233824;5680.914786278209;5734.025215713339;5775.740091695884;5820.417958204188;5824.388439213864;23926.64110038351;24412.877935610384;25404.85678144488;27404;27637.861810690818;2009.5177157482244;2054.342610364684;2114.1015068595784;2134.541073669169;2730.412961213349;9848.458334791583;9984.500774961223;10051.246156538216;10213.182945364353;10215.02957219063;1539.6689711711924;1734.8438640522413;1763.4797734668305;1773.3527262549205;1774.0774797105432;98998.0100198996;126353.36823315917;129847;129863;133879;11748.060155187564;11800.350980696145;11823.822642660367;11924.761504769856;11942.940285298519;14880;14951.626209344853;14955.027923184958;14956.326965286587;14975.550733478012;8461.70384036568;8505.95747021261;8532.445391049687;8659.26814637075;8667.696630618024;8083.232092951161;8255.174482551816;8255.669773209005;8280.58597070156;8335.583220838933;4576.542345765463;4650.302454631832;4656.371389862393;4714.5521175488275;4723.7401942893475;1714.6399256156346;1784.8125946775401;1867.2251015828278;1952.2386269354963;2002.6595478768645;895.3463971300987;897.8069715011304;920.7375897869075;951.8429459139303;1018.3991445047458;19405.32081377145;20341.881196534036;20396;20932;21968.231111911005;863.6156910175038;919.5034681272172;978.8433850583872;999.8900120986685;1026.3328836256344;9853;10614.416207108528;11122.277051991594;11319.830202546967;11454.54181832734;580363.0981845064;581623;583245;597654;597967;83801.74297385543;96898;134568.32715836554;134673;134910;959.5729900194347;960.1646567486332;961.2022021721954;979.8628192053118;1005.8642083318658;19133.23467061302;19159.904200478908;19170.520736981685;19180.232790688216;19269.4219173425;42950.281988720104;55222.723886380314;55308;55758.72120639371;56537.71731141318;76664.6166769185;77137;79833.80249296382;80126.5993670028;82984;8059.717909873127;8105.3920955929725;8232.588370581567;8243.299319557666;8537.82924341522;10637.680869573926;12077.833147564077;12521.749565008831;12793.936030319788;12903.548375806802;11122.499487523242;11327.433628318717;11527.827082593936;11550.48022838991;11624.360660163773;8355.582220889053;8684.261837743863;10881.020708136306;11131.220814542905;11212.49543770516;11391.430428478378;11425.542978281108;11744.530218791153;11793.41032948332;11868.703282418008;8158.265756081981;8177.100518943031;8270.090290068209;8445.07104218523;8454.450460720034;9368.95315523418;10602.787944241227;11625.709357266136;11694.70763230926;11715.824262636237 12:32:29 INFO - PROCESS | 1667 | |3;mootools.html;1444.5810714892682;1634.6812371587537;1809.891406515609;1862.5250561106916;1982.6133903888747;8206.95896520518;8754.212120909116;8855.91144088559;9248.306377021725;9273.768155796108;8888.688895888645;8967.192952634261;9072.682456114037;9079.455232686043;9129.452232866017;2450.852948823072;2456.705195376557;2468.7778099971;2477.9008839646394;2481.2060140754966;2417.153996101359;2475.4801491686676;2487.9378015549573;2491.5266099441137;2497.113524698733;2443.30365845734;2444.6210837320154;2455.545724041049;2466.5930121529927;2473.7773600375963;2395.3293077938206;2435.025989604155;2458.5943319352286;2464;2473.938151546208;2428.5992811186134;2436.378723425533;2436.439618887666;2455.8280920335583;2459.114718701266;7651.617419129077;9000.414973026798;9043.728688139367;9091.27269818413;9096.590653420611;5435.891282174334;5460.6177567570285;5502.0921547944545;5526.419725928759;5535.308086489189;3579.28414317135;3591.7306202034692;3599.5320608321013;3692.778433294011;3707.462417949382;1033.5555711044249;1052.4842827014784;1053.8524606555088;1055.7466208109997;1057.185966805563;11842.289462632183;11935.582254621133;12099.153059285942;12118.394080296039;12141.878581214252;4185.393117997874;4845.103655823684;4942.802287908516;5021.322121513549;5072.797088116434;10166.983301669921;10167.796644067077;10176.491175441199;10180.134688551409;10204.795904081877;5424.077906755861;5435.836924892181;5491.697956612425;5522.2544956431175;5533.612647114744;4467.6649251305635;4892.926606100911;5046.596272298208;5063.518965698253;5071.112555302807;4130.091379896418;4131.938020929689;4176.1885558094755;4179.519355274121;4250.383694364362;1355.9864401356058;1381.171297221659;1383.3152589468277;1386.7711827548342;1390.7149034447914;912.1790388650135;930.9674161404319;938.7887725261761;939.3514382259092;950.6340059077305;5899.46904778572;5954.791582294599;5989.760409583568;6072.817815465543;6134.153601905122;450.73631925324054;462.5212904643678;469.60553135365774;470.09272104837993;470.3156906700742;3963.3064213762477;4011.4785077940264;4017.397390391465;4102.3026085565525;4104.15864747726;10676.679699609023;11043.116550675926;11074.557017719362;11084.722881927855;11087.50106245221;10874.130069594414;10880.72798180036;11009.669709908716;11029.889701102886;11047.392393418439;5914.497267732291;8248.628811703487;8295.585220738938;8346.833063338821;8486.957565212135;5024.196128619404;5787.102999035156;5846.123081537803;5854.2389489366105;6024.457798798129;8822;9759.316847820868;10169.9491502542;10234.334768240338;10252.794944100928;9891.307608467338;10139.695809125738;10334.483275836328;10352.741181470223;10398.168146548107;6278.780242691667;6829.726810927507;7255.548890222082;7501.174870764103;7739.419543534144;8558.315334773079;8597.140285971353;8645.092265312303;8651.394402391772;8662.220400164015;6966.303369662993;7466.141393739789;7471.290227428385;7700.961495192488;7707.537547747153;7476.70093196266;7496.812579685334;7552.697892084255;7564.50830696025;7620.733274335372;6275.905861412174;6633.673265347046;6980.476464265099;7007.194172670208;7078.681459334445;4712.835050773207;4818.204996175732;4827.106985207748;4914.0908931847725;5012.724300163526;4814.566688998007;4824.204006338915;4922.778474968707;5026.723530205873;5087.160618497906 12:32:29 INFO - PROCESS | 1667 | |4;prototype.html;305.89599536157704;314.34772846343833;319.2004029905088;323.9116568330408;325.0670575448463;4775.450823155338;5351.892962140755;5626.578006649503;5633.830985070449;5683.545316374691;4584.5644663756975;4949.455559888409;5385.2999110115725;5510.862228444291;5534.225208470817;3645.343838109139;4158.8960275993195;4163.646090082347;4175.269327867626;4196.600753389749;3363;3965.821538030781;4182.2681030819485;4194.119234960646;4218.008767939532;3471.7328175216117;3523.5947865995354;3994.48071750672;4138.97930510347;4139.468396693228;3841.3661745811905;4147.419361289422;4155.4182414462;4168.979155104235;4175.91648167035;3028.303490197245;3362.4283871741864;3605.7475976681644;3606.1886075633033;3609.530761001079;5044.596432285409;5068;5311.7344132793205;5325.4437869822705;5418.241446197536;4074.8370065197355;4749.551386827016;4813.350197723297;4828.444728856191;4843.975780121112;4999.250112483157;5362.008028514737;5838.737256823453;5857.414258574151;5881.588288819784;3613.9096522586883;3826.603289799231;3968.3849003404516;3981.7810020448865;3986.82717918735;5172.508556724234;5685.232493613392;6148;6197.566170368076;6205.317415084337;3376.953144525205;3555.768875023115;3646.58064322601;3706.591495231795;4030.415589739471;3238.7732858699665;3933.662554731405;3982.920341593152;4044.292248856438;4099.467069281034;4020.979895100506;4135.234981528427;4705.223638099744;4718.551737584924;4726.385569875894;4660.5106463821485;5838.737256823453;5843.428891287905;5862;5866.061430171152;1319.6803196803196;1346;1356.8100465934776;1374.2372982994534;1385.231196685829;750.7484992527455;830.5099991005336;835.9038710548243;845.9636944742764;850.9361797865062;4143.218416081114;4172.979135104366;4203.07532342884;4207.368894665825;4647.16351056813;4620.5379462053525;4836.847602816712;4913.828016019422;5155.896882062338;5215.556677682363;4125.205535592027;4151.194230509738;4436.423264975532;4542.341360502709;4690.115578919009;2478.1821998740375;2647.3911000469616;2666.520026395229;2708.498927698382;2786.972130278671;4984.651074424828;5049.697018178921;5288.894222115536;5392.73036348181;5403.676099355683;4232.894177645583;4577.679562430598;5196.64816193553;5279.39286982002;5308.443342960226;4794.161021821167;5013.896942672606;5160.374482038146;5366.087765079946;5377.677339359651;4749;4760.166970780169;5136.5617627064485;5136.897262054663;5192.870922921584;4317.4457195408995;4841.225403935354;5089.160288552495;5108.667936584259;5363.383210930637;5541.196526503554;5800.8259752207505;5805.419458054161;6064.756724871302;6372.55392122547;3856.804390638799;3949.7037722170376;4009.679225661882;4021.9945013746565;4027.395890616431;5686.289213848269;5954.880902382015;6069.241344831896;6134.141220229082;6158.06021103351;4731.361266229015;4998.525140111684;5400.594955378284;5923.851903702442;5944.494717949023;5593.384727679871;5913.615614985012;5943.613665111754;5949.851253718692;5951.583389162717;4889.364382630235;5346.465353464622;5695.857603559944;5826.563007774519;5826.592138550261;5856.531477481706;5877.294724633071;5881.264841894763;5887.411258874078;5910.763569457174;4600.608948239437;4848.515148485123;4881.438634556929;5707.885842283048;5744.167095771173 12:32:29 INFO - PROCESS | 1667 | |5;yui.html;660.613541078469;683.1597135523306;721.1598487761757;743.9814004649883;758.6586036283672;15098;15468.922655386736;15821.841781582181;15856.207189640516;15886.285117169711;13932.303384830768;14271.357788899499;14492.710145797078;14528.636784080376;14631.561053168421;703.8345988692653;838.2372041442288;902.2511315608062;920.6179435534262;939.6429356844424;925.5511077127587;931.7996630724393;933.2394098809483;933.9866245124049;936.1153709744294;808.1958451340925;948.3551185194066;966.8018056298478;971.1065819446092;989.8218320702271;971.2909576009482;976.501983988164;977.9364341317827;978.1832170137908;978.280963491833;704.4153352717233;722.2560762414721;723.1214074899023;724.8224185074638;725.3037084398983;15340.23298835065;15424.46014389491;15544;15561.610959725984;15586.220688965506;12747.61757147287;12809.679758006032;12844;12899.742005159938;13109.934450327688;10159.23805714567;10237.259665856822;10305.330153539995;10527.684169474927;10655.147588192925;3450.913727156816;3467.757256991986;3589.335972845032;3630.110622897407;3706.666400023984;74404.62797685977;97479.51260243653;98106.50946745292;101050.49474752652;101977.49011254896;9442.244620430349;9560.66537671192;9597.136257736836;9652.22782177424;9923.80152396948;22717.432064198198;22900.885495572747;23011.654825177637;23064.4233894154;23279.76720232776;6982.825429364205;7290;7334.889976650355;7345.228750981177;7717.922820771832;3927.0771368728324;3973.046468847456;3975.224831157954;3979.9403008954887;4028.053407449247;3530.541029666127;3652.141746689526;3661.139632186434;3666.5700376853047;3676.338259113332;637.6907200007993;641.8010416770816;653.4413076819346;654.2443477783168;656.9737210511622;539.4794023767083;543.7661805423705;552.3647805024254;553.583961881784;557.6550604707196;6347.333529979285;7874.173211812677;7968.888314220042;7977.680892764224;8119.431639785276;534.882325888304;547.3650565344182;553.3332334536873;559.6697948210575;567.3617180671745;3806.410006449005;3826.330392181357;3842.5965273646425;3843.865464708722;3853.3834586466032;69536;86255.56872215724;98787;98884.50557747165;100586;67081;86597;87250.12749872547;87345.56327218324;88076.5596172015;73593.26406735864;75140.1158924679;76430;76614.85077723839;78694;8055.677772889253;8291.58542072882;8397.70608028716;8423.831523369621;8581.927259092614;44437.88905277394;45186.548134518234;47060.52939470561;47403.83419946844;48197.51802481931;54043;68981.11027555089;69560.6521967387;69690.30309696838;69825.65087174531;11119.499622516845;11221.887781122085;11244.775104498029;11446.713832154262;11595.710107247387;12295.32375719344;12315.261084334968;12535.373231338579;12537.749245015231;12577.245365278113;9667.9033209667;11627.302361858316;11752.294862308288;11753.471093800628;12127.757444850877;8377.790555236168;11406.54373825071;11578.36319002463;11754.353510557;11981.76036479248;11233.66299011031;11323.433828308387;11342.20604557673;11424.428778560872;11447.885521145015;8173.591320433836;9479.952600236955;9646.951765241129;9776.85334719994;9813.11681948628;7375.225601311785;8011.038675358995;8396.286315663237;9122.90877091247;9527.90472095298 12:32:29 INFO - PROCESS | 1667 | __end_tp_report 12:32:29 INFO - PROCESS | 1667 | __start_cc_report 12:32:29 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,426 12:32:29 INFO - PROCESS | 1667 | __end_cc_report 12:32:29 INFO - PROCESS | 1667 | __startTimestamp1463513549855__endTimestamp 12:32:29 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | ------- Summary: start ------- 12:32:29 INFO - PROCESS | 1667 | Number of tests: 6 12:32:29 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5726.68 Median:5965.46 stddev:783.70 (13.1%) stddev-sans-first:753.84 12:32:29 INFO - PROCESS | 1667 | Values: 2889.6 3082.6 3488.2 3512.8 3514.3 5723.4 5743.6 5778.9 5869.4 5886.5 5644.7 5833.4 5843.4 5880.4 5965.5 5174.4 5265.9 5278.4 5338.9 5365.8 607.8 5166.5 5208.6 5266.0 5274.9 5218.0 5238.1 5270.9 5282.0 5317.1 5214.0 5240.4 5275.3 5289.5 5296.4 5125.2 5135.3 5153.3 5200.5 5220.5 4823.2 5552.2 5624.7 5709.6 5713.7 4465.4 6164.0 6295.0 6298.2 6304.3 6123.3 6233.4 6240.5 6273.6 6377.5 5777.8 5930.5 5935.0 5969.5 5974.9 5199.8 5885.8 6250.8 6344.8 6372.7 6101.4 6168.4 6214.9 6228.2 6275.0 6252.0 6287.1 6289.9 6331.2 6345.5 6117.6 6173.9 6209.4 6218.3 6293.3 6290.6 6296.8 6309.1 6316.4 6345.1 4961.3 4980.2 4985.9 5007.8 5023.0 4426.5 4437.3 4438.4 4466.8 4520.4 5725.1 5770.7 5797.4 5847.5 5889.5 6284.6 6290.2 6300.4 6300.4 6312.9 5699.1 5820.8 5880.6 5901.3 5916.8 4770.7 5460.0 5464.0 5467.5 5470.2 6392.4 6420.0 6439.1 6447.9 6460.6 5461.0 6112.9 6175.8 6258.2 6292.5 5860.2 5957.0 6377.8 6407.8 6418.8 6251.0 6274.3 6278.0 6279.4 6302.3 6105.3 6120.7 6195.5 6310.1 6320.5 6174.9 6227.6 6232.4 6243.2 6244.8 5157.8 6156.7 6192.9 6231.3 6234.8 5024.4 5769.5 5798.2 5939.3 6046.0 6191.9 6221.3 6227.5 6228.4 6259.3 6065.1 6105.7 6117.9 6139.1 6151.6 12:32:29 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:66570.58 Median:40560.59 stddev:142715.71 (351.9%) stddev-sans-first:143029.92 12:32:29 INFO - PROCESS | 1667 | Values: 526.3 536.1 549.1 552.7 561.9 38210.0 38809.2 40215.2 40326.6 40390.0 34527.7 43952.3 44798.8 44936.1 46597.0 9716.4 9859.9 9871.6 9877.3 9878.2 9103.0 9410.5 9715.3 9803.2 9877.3 9796.7 9810.0 9839.0 9859.2 9869.3 8464.3 9732.4 9737.6 9839.3 9848.3 9581.6 9666.3 9741.7 9744.5 9804.0 40731.2 40786.6 40859.4 41113.4 41196.6 3228.6 3371.6 3445.1 3524.7 3622.9 24835.1 29112.8 29203.4 29959.8 30242.7 2672.8 2806.3 2825.0 2828.6 2930.0 335768.0 437021.0 437045.0 440848.0 442868.6 60767.8 60886.7 61508.8 61910.0 61955.7 56888.7 64653.7 65995.0 66762.7 66831.7 15916.0 16002.5 16045.9 16086.4 16141.5 12146.7 12201.8 12272.1 12282.3 12290.5 16891.8 16968.5 17020.1 17068.5 17118.2 6774.7 7407.9 7502.3 7584.4 7597.5 890.0 932.7 972.3 1004.1 1077.8 25693.6 29471.7 29858.4 30425.0 30731.8 933.9 948.4 1030.6 1090.2 1090.7 13216.6 14896.9 15579.8 15626.7 15929.0 648064.0 666790.0 667568.0 671768.0 672823.9 47559.0 55287.6 62555.0 62607.0 62807.0 1441.6 1451.0 1462.0 1487.3 1487.5 30092.0 30106.7 30241.2 30243.8 30385.1 44142.8 53186.5 53725.2 53754.2 53838.7 483936.0 483982.0 486633.0 487367.0 487713.0 24027.0 26887.7 27294.5 28646.1 41237.4 46669.8 47493.5 47817.1 48221.0 48972.5 38013.8 39481.4 39715.8 40157.8 40293.6 33728.8 37720.8 38455.0 38612.0 39369.8 38158.6 38778.8 38949.8 38991.4 39039.4 32777.7 33467.5 34473.8 34488.3 34820.0 25318.6 25330.5 25518.2 25780.4 25826.9 12:32:29 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:34770.97 Median:385.40 stddev:98224.94 (25486.5%) stddev-sans-first:98466.44 12:32:29 INFO - PROCESS | 1667 | Values: 327.4 382.4 388.4 397.3 406.8 20030.9 21807.2 22050.2 22678.2 22742.9 18059.9 21219.3 21553.6 22189.4 22373.7 5778.4 5811.3 6044.1 6063.2 6068.8 4103.3 5947.5 5972.1 6268.7 6618.4 6616.5 6621.4 6626.8 6661.7 6669.2 6340.3 6648.7 6656.1 6671.9 6682.6 5680.9 5734.0 5775.7 5820.4 5824.4 23926.6 24412.9 25404.9 27404.0 27637.9 2009.5 2054.3 2114.1 2134.5 2730.4 9848.5 9984.5 10051.2 10213.2 10215.0 1539.7 1734.8 1763.5 1773.4 1774.1 98998.0 126353.4 129847.0 129863.0 133879.0 11748.1 11800.4 11823.8 11924.8 11942.9 14880.0 14951.6 14955.0 14956.3 14975.6 8461.7 8506.0 8532.4 8659.3 8667.7 8083.2 8255.2 8255.7 8280.6 8335.6 4576.5 4650.3 4656.4 4714.6 4723.7 1714.6 1784.8 1867.2 1952.2 2002.7 895.3 897.8 920.7 951.8 1018.4 19405.3 20341.9 20396.0 20932.0 21968.2 863.6 919.5 978.8 999.9 1026.3 9853.0 10614.4 11122.3 11319.8 11454.5 580363.1 581623.0 583245.0 597654.0 597967.0 83801.7 96898.0 134568.3 134673.0 134910.0 959.6 960.2 961.2 979.9 1005.9 19133.2 19159.9 19170.5 19180.2 19269.4 42950.3 55222.7 55308.0 55758.7 56537.7 76664.6 77137.0 79833.8 80126.6 82984.0 8059.7 8105.4 8232.6 8243.3 8537.8 10637.7 12077.8 12521.7 12793.9 12903.5 11122.5 11327.4 11527.8 11550.5 11624.4 8355.6 8684.3 10881.0 11131.2 11212.5 11391.4 11425.5 11744.5 11793.4 11868.7 8158.3 8177.1 8270.1 8445.1 8454.5 9369.0 10602.8 11625.7 11694.7 11715.8 12:32:29 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5784.12 Median:4816.39 stddev:3259.00 (67.7%) stddev-sans-first:3251.82 12:32:29 INFO - PROCESS | 1667 | Values: 1444.6 1634.7 1809.9 1862.5 1982.6 8207.0 8754.2 8855.9 9248.3 9273.8 8888.7 8967.2 9072.7 9079.5 9129.5 2450.9 2456.7 2468.8 2477.9 2481.2 2417.2 2475.5 2487.9 2491.5 2497.1 2443.3 2444.6 2455.5 2466.6 2473.8 2395.3 2435.0 2458.6 2464.0 2473.9 2428.6 2436.4 2436.4 2455.8 2459.1 7651.6 9000.4 9043.7 9091.3 9096.6 5435.9 5460.6 5502.1 5526.4 5535.3 3579.3 3591.7 3599.5 3692.8 3707.5 1033.6 1052.5 1053.9 1055.7 1057.2 11842.3 11935.6 12099.2 12118.4 12141.9 4185.4 4845.1 4942.8 5021.3 5072.8 10167.0 10167.8 10176.5 10180.1 10204.8 5424.1 5435.8 5491.7 5522.3 5533.6 4467.7 4892.9 5046.6 5063.5 5071.1 4130.1 4131.9 4176.2 4179.5 4250.4 1356.0 1381.2 1383.3 1386.8 1390.7 912.2 931.0 938.8 939.4 950.6 5899.5 5954.8 5989.8 6072.8 6134.2 450.7 462.5 469.6 470.1 470.3 3963.3 4011.5 4017.4 4102.3 4104.2 10676.7 11043.1 11074.6 11084.7 11087.5 10874.1 10880.7 11009.7 11029.9 11047.4 5914.5 8248.6 8295.6 8346.8 8487.0 5024.2 5787.1 5846.1 5854.2 6024.5 8822.0 9759.3 10169.9 10234.3 10252.8 9891.3 10139.7 10334.5 10352.7 10398.2 6278.8 6829.7 7255.5 7501.2 7739.4 8558.3 8597.1 8645.1 8651.4 8662.2 6966.3 7466.1 7471.3 7701.0 7707.5 7476.7 7496.8 7552.7 7564.5 7620.7 6275.9 6633.7 6980.5 7007.2 7078.7 4712.8 4818.2 4827.1 4914.1 5012.7 4814.6 4824.2 4922.8 5026.7 5087.2 12:32:29 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:4461.14 Median:4832.65 stddev:1391.01 (28.8%) stddev-sans-first:1359.50 12:32:29 INFO - PROCESS | 1667 | Values: 305.9 314.3 319.2 323.9 325.1 4775.5 5351.9 5626.6 5633.8 5683.5 4584.6 4949.5 5385.3 5510.9 5534.2 3645.3 4158.9 4163.6 4175.3 4196.6 3363.0 3965.8 4182.3 4194.1 4218.0 3471.7 3523.6 3994.5 4139.0 4139.5 3841.4 4147.4 4155.4 4169.0 4175.9 3028.3 3362.4 3605.7 3606.2 3609.5 5044.6 5068.0 5311.7 5325.4 5418.2 4074.8 4749.6 4813.4 4828.4 4844.0 4999.3 5362.0 5838.7 5857.4 5881.6 3613.9 3826.6 3968.4 3981.8 3986.8 5172.5 5685.2 6148.0 6197.6 6205.3 3377.0 3555.8 3646.6 3706.6 4030.4 3238.8 3933.7 3982.9 4044.3 4099.5 4021.0 4135.2 4705.2 4718.6 4726.4 4660.5 5838.7 5843.4 5862.0 5866.1 1319.7 1346.0 1356.8 1374.2 1385.2 750.7 830.5 835.9 846.0 850.9 4143.2 4173.0 4203.1 4207.4 4647.2 4620.5 4836.8 4913.8 5155.9 5215.6 4125.2 4151.2 4436.4 4542.3 4690.1 2478.2 2647.4 2666.5 2708.5 2787.0 4984.7 5049.7 5288.9 5392.7 5403.7 4232.9 4577.7 5196.6 5279.4 5308.4 4794.2 5013.9 5160.4 5366.1 5377.7 4749.0 4760.2 5136.6 5136.9 5192.9 4317.4 4841.2 5089.2 5108.7 5363.4 5541.2 5800.8 5805.4 6064.8 6372.6 3856.8 3949.7 4009.7 4022.0 4027.4 5686.3 5954.9 6069.2 6134.1 6158.1 4731.4 4998.5 5400.6 5923.9 5944.5 5593.4 5913.6 5943.6 5949.9 5951.6 4889.4 5346.5 5695.9 5826.6 5826.6 5856.5 5877.3 5881.3 5887.4 5910.8 4600.6 4848.5 4881.4 5707.9 5744.2 12:32:29 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18880.16 Median:563.52 stddev:27293.69 (4843.5%) stddev-sans-first:27335.97 12:32:29 INFO - PROCESS | 1667 | Values: 660.6 683.2 721.2 744.0 758.7 15098.0 15468.9 15821.8 15856.2 15886.3 13932.3 14271.4 14492.7 14528.6 14631.6 703.8 838.2 902.3 920.6 939.6 925.6 931.8 933.2 934.0 936.1 808.2 948.4 966.8 971.1 989.8 971.3 976.5 977.9 978.2 978.3 704.4 722.3 723.1 724.8 725.3 15340.2 15424.5 15544.0 15561.6 15586.2 12747.6 12809.7 12844.0 12899.7 13109.9 10159.2 10237.3 10305.3 10527.7 10655.1 3450.9 3467.8 3589.3 3630.1 3706.7 74404.6 97479.5 98106.5 101050.5 101977.5 9442.2 9560.7 9597.1 9652.2 9923.8 22717.4 22900.9 23011.7 23064.4 23279.8 6982.8 7290.0 7334.9 7345.2 7717.9 3927.1 3973.0 3975.2 3979.9 4028.1 3530.5 3652.1 3661.1 3666.6 3676.3 637.7 641.8 653.4 654.2 657.0 539.5 543.8 552.4 553.6 557.7 6347.3 7874.2 7968.9 7977.7 8119.4 534.9 547.4 553.3 559.7 567.4 3806.4 3826.3 3842.6 3843.9 3853.4 69536.0 86255.6 98787.0 98884.5 100586.0 67081.0 86597.0 87250.1 87345.6 88076.6 73593.3 75140.1 76430.0 76614.9 78694.0 8055.7 8291.6 8397.7 8423.8 8581.9 44437.9 45186.5 47060.5 47403.8 48197.5 54043.0 68981.1 69560.7 69690.3 69825.7 11119.5 11221.9 11244.8 11446.7 11595.7 12295.3 12315.3 12535.4 12537.7 12577.2 9667.9 11627.3 11752.3 11753.5 12127.8 8377.8 11406.5 11578.4 11754.4 11981.8 11233.7 11323.4 11342.2 11424.4 11447.9 8173.6 9480.0 9647.0 9776.9 9813.1 7375.2 8011.0 8396.3 9122.9 9527.9 12:32:29 INFO - PROCESS | 1667 | -------- Summary: end -------- 12:32:29 INFO - PROCESS | 1667 | 12:32:30 INFO - TEST-INFO | 1667: exit 0 12:32:30 INFO - TEST-OK | dromaeo_css | took 1112371ms 12:32:30 INFO - TEST-START | kraken 12:32:30 INFO - operating with platform_type : mac_ 12:32:30 INFO - Initialising browser for kraken test... 12:32:30 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpTZwv4E/profile http://localhost:49279/getInfo.html) 12:32:33 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 12:32:33 INFO - PROCESS | 1676 | colorDepth:24 12:32:33 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 12:32:33 INFO - PROCESS | 1676 | __metrics 12:32:33 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 12:32:34 INFO - TEST-INFO | 1676: exit 0 12:32:34 INFO - Browser initialized. 12:32:34 INFO - Running cycle 1/1 for kraken test... 12:32:34 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpTZwv4E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:45 INFO - PROCESS | 1679 | RSS: Main: 250040320 12:32:45 INFO - PROCESS | 1679 | 12:32:48 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 12:32:49 INFO - PROCESS | 1679 | RSS: Main: 261828608 12:32:49 INFO - PROCESS | 1679 | 12:32:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 12:32:53 INFO - PROCESS | 1679 | RSS: Main: 266596352 12:32:53 INFO - PROCESS | 1679 | 12:32:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 12:32:57 INFO - PROCESS | 1679 | RSS: Main: 266964992 12:32:57 INFO - PROCESS | 1679 | 12:32:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 12:33:00 INFO - PROCESS | 1679 | RSS: Main: 268165120 12:33:00 INFO - PROCESS | 1679 | 12:33:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:33:02 INFO - PROCESS | 1679 | RSS: Main: 268120064 12:33:02 INFO - PROCESS | 1679 | 12:33:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 12:33:06 INFO - PROCESS | 1679 | RSS: Main: 268668928 12:33:06 INFO - PROCESS | 1679 | 12:33:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 12:33:10 INFO - PROCESS | 1679 | RSS: Main: 269340672 12:33:10 INFO - PROCESS | 1679 | 12:33:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 12:33:14 INFO - PROCESS | 1679 | RSS: Main: 268820480 12:33:14 INFO - PROCESS | 1679 | 12:33:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:33:16 INFO - PROCESS | 1679 | RSS: Main: 268234752 12:33:16 INFO - PROCESS | 1679 | 12:33:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:33:19 INFO - PROCESS | 1679 | RSS: Main: 268763136 12:33:19 INFO - PROCESS | 1679 | 12:33:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:33:22 INFO - PROCESS | 1679 | RSS: Main: 268476416 12:33:22 INFO - PROCESS | 1679 | 12:33:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:33:25 INFO - PROCESS | 1679 | RSS: Main: 268693504 12:33:25 INFO - PROCESS | 1679 | 12:33:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:33:29 INFO - PROCESS | 1679 | RSS: Main: 269406208 12:33:29 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 12:33:31 INFO - PROCESS | 1679 | RSS: Main: 271687680 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | __start_tp_report 12:33:31 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 12:33:31 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 12:33:31 INFO - PROCESS | 1679 | |i|pagename|runs| 12:33:31 INFO - PROCESS | 1679 | |0;ai-astar;113;117;108;117;118;112;107;116;148;165 12:33:31 INFO - PROCESS | 1679 | |1;audio-beat-detection;154;119;145;198;120;145;138;122;170;118 12:33:31 INFO - PROCESS | 1679 | |2;audio-dft;201;196;208;257;235;269;242;225;262;198 12:33:31 INFO - PROCESS | 1679 | |3;audio-fft;76;81;78;181;65;82;107;92;134;59 12:33:31 INFO - PROCESS | 1679 | |4;audio-oscillator;82;85;154;77;75;87;124;83;82;127 12:33:31 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;92;104;105;89;90;96;133;89;92;100 12:33:31 INFO - PROCESS | 1679 | |6;imaging-darkroom;97;96;97;97;95;112;97;95;108;150 12:33:31 INFO - PROCESS | 1679 | |7;imaging-desaturate;92;92;116;146;90;89;95;91;90;94 12:33:31 INFO - PROCESS | 1679 | |8;json-parse-financial;59;62;58;58;58;59;59;119;61;59 12:33:31 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;66;66;78;98;106;102;74;64;68 12:33:31 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;89;89;92;85;89;92;103;113;107;76 12:33:31 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;147;141;134;141;140;140;149;156;246;143 12:33:31 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;165;178;167;235;155;221;229;202;170;167 12:33:31 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;57;63;87;70;66;63;66;69;67;65 12:33:31 INFO - PROCESS | 1679 | __end_tp_report 12:33:31 INFO - PROCESS | 1679 | __start_cc_report 12:33:31 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1092 12:33:31 INFO - PROCESS | 1679 | __end_cc_report 12:33:31 INFO - PROCESS | 1679 | __startTimestamp1463513611555__endTimestamp 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | ------- Summary: start ------- 12:33:31 INFO - PROCESS | 1679 | Number of tests: 14 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:122.10 Median:117.00 stddev:18.94 (16.2%) stddev-sans-first:19.80 12:33:31 INFO - PROCESS | 1679 | Values: 113.0 117.0 108.0 117.0 118.0 112.0 107.0 116.0 148.0 165.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:145.00 stddev:25.99 (17.9%) stddev-sans-first:27.25 12:33:31 INFO - PROCESS | 1679 | Values: 154.0 119.0 145.0 198.0 120.0 145.0 138.0 122.0 170.0 118.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:229.30 Median:238.50 stddev:27.83 (11.7%) stddev-sans-first:27.56 12:33:31 INFO - PROCESS | 1679 | Values: 201.0 196.0 208.0 257.0 235.0 269.0 242.0 225.0 262.0 198.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:95.50 Median:77.00 stddev:36.94 (48.0%) stddev-sans-first:38.50 12:33:31 INFO - PROCESS | 1679 | Values: 76.0 81.0 78.0 181.0 65.0 82.0 107.0 92.0 134.0 59.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:82.00 stddev:27.18 (33.1%) stddev-sans-first:28.24 12:33:31 INFO - PROCESS | 1679 | Values: 82.0 85.0 154.0 77.0 75.0 87.0 124.0 83.0 82.0 127.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:99.00 Median:89.50 stddev:13.36 (14.9%) stddev-sans-first:13.93 12:33:31 INFO - PROCESS | 1679 | Values: 92.0 104.0 105.0 89.0 90.0 96.0 133.0 89.0 92.0 100.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:104.40 Median:96.50 stddev:17.05 (17.7%) stddev-sans-first:17.87 12:33:31 INFO - PROCESS | 1679 | Values: 97.0 96.0 97.0 97.0 95.0 112.0 97.0 95.0 108.0 150.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:99.50 Median:91.50 stddev:18.14 (19.8%) stddev-sans-first:19.03 12:33:31 INFO - PROCESS | 1679 | Values: 92.0 92.0 116.0 146.0 90.0 89.0 95.0 91.0 90.0 94.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:59.00 stddev:18.95 (32.1%) stddev-sans-first:19.97 12:33:31 INFO - PROCESS | 1679 | Values: 59.0 62.0 58.0 58.0 58.0 59.0 59.0 119.0 61.0 59.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:67.00 stddev:16.94 (25.3%) stddev-sans-first:17.01 12:33:31 INFO - PROCESS | 1679 | Values: 63.0 66.0 66.0 78.0 98.0 106.0 102.0 74.0 64.0 68.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:93.50 Median:89.00 stddev:11.04 (12.4%) stddev-sans-first:11.59 12:33:31 INFO - PROCESS | 1679 | Values: 89.0 89.0 92.0 85.0 89.0 92.0 103.0 113.0 107.0 76.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:145.00 stddev:32.99 (22.7%) stddev-sans-first:34.90 12:33:31 INFO - PROCESS | 1679 | Values: 147.0 141.0 134.0 141.0 140.0 140.0 149.0 156.0 246.0 143.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.90 Median:190.00 stddev:29.98 (15.8%) stddev-sans-first:30.53 12:33:31 INFO - PROCESS | 1679 | Values: 165.0 178.0 167.0 235.0 155.0 221.0 229.0 202.0 170.0 167.0 12:33:31 INFO - PROCESS | 1679 | 12:33:31 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:66.50 stddev:7.82 (11.8%) stddev-sans-first:7.35 12:33:31 INFO - PROCESS | 1679 | Values: 57.0 63.0 87.0 70.0 66.0 63.0 66.0 69.0 67.0 65.0 12:33:31 INFO - PROCESS | 1679 | -------- Summary: end -------- 12:33:31 INFO - PROCESS | 1679 | 12:33:32 INFO - TEST-INFO | 1679: exit 0 12:33:32 INFO - TEST-OK | kraken | took 62051ms 12:33:32 INFO - SUITE-END | took 1174s 12:33:32 INFO - Completed test suite (00:19:34) 12:33:32 INFO - javascript benchmark 12:33:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7198.5909505271065, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2889.581010753442, 3082.614673165854, 3488.1802776347554, 3512.8243587820602, 3514.2971405718863, 5723.370429252779, 5743.597948143632, 5778.884422311557, 5869.442402971721, 5886.499647529965, 5644.689542075184, 5833.416658334175, 5843.386444423338, 5880.3825598312205, 5965.46310832025, 5174.43081261061, 5265.86835329116, 5278.3665960084845, 5338.946610533883, 5365.7585408656505, 607.7820272638588, 5166.483351664841, 5208.5572726318305, 5266.0, 5274.868128296804, 5217.999999999981, 5238.083335416325, 5270.92093618596, 5281.973590132063, 5317.12267475866, 5213.973930130363, 5240.449752775941, 5275.314209152824, 5289.523942845124, 5296.3909150447425, 5125.154349532323, 5135.281060651511, 5153.330067091291, 5200.531952124327, 5220.451852555503, 4823.1800593899125, 5552.194931734876, 5624.718764061821, 5709.600327977043, 5713.657180569179, 4465.37484752135, 6164.0, 6295.0, 6298.244210694746, 6304.27500837405, 6123.3131248723375, 6233.407826256498, 6240.500759939194, 6273.592216505913, 6377.521685873532, 5777.7977770777825, 5930.525557955353, 5935.020721580934, 5969.492593129546, 5974.910376344358, 5199.844004679866, 5885.823425297248, 6250.812475625738, 6344.8413789654705, 6372.74509019634, 6101.429060711456, 6168.414000669929, 6214.906776398358, 6228.159198508234, 6275.0, 6252.0, 6287.056941458726, 6289.937100628935, 6331.176946996953, 6345.524085693592, 6117.583823141483, 6173.9073913891325, 6209.410106039919, 6218.284897236786, 6293.276273228637, 6290.591111577733, 6296.779612713533, 6309.085182648582, 6316.431521163117, 6345.111684364193, 4961.2558116282125, 4980.153373926441, 4985.900281994413, 5007.774650140679, 5023.045621331935, 4426.490953540319, 4437.267850804646, 4438.423005009328, 4466.821327146878, 4520.389747384061, 5725.055365864586, 5770.653760774367, 5797.391273916262, 5847.473727364558, 5889.4699477046415, 6284.591501552384, 6290.245170579468, 6300.3699630037545, 6300.432961033437, 6312.936870631235, 5699.08814589672, 5820.76716931318, 5880.558958078076, 5901.262342207224, 5916.763329466773, 4770.689905156154, 5460.017196904516, 5464.043792336404, 5467.4532546745, 5470.206820011155, 6392.3927226913365, 6420.0, 6439.098526206335, 6447.9355206447335, 6460.580062295936, 5460.972695136657, 6112.938870611415, 6175.814725558241, 6258.217722784652, 6292.465140463112, 5860.179574859438, 5957.046872500379, 6377.795309189624, 6407.839804004937, 6418.775342863164, 6251.0, 6274.309825919237, 6278.0, 6279.403456671609, 6302.275238347649, 6105.328413874559, 6120.690942950841, 6195.535334849995, 6310.11658367838, 6320.494360451245, 6174.9073763892675, 6227.626342419469, 6232.407921247474, 6243.157173781481, 6244.750209991549, 5157.793688252428, 6156.722947467285, 6192.938070619236, 6231.2522497300615, 6234.781782637586, 5024.371953505812, 5769.538436924952, 5798.188253644409, 5939.3466718661775, 6045.969770151121, 6191.876162476815, 6221.346758590464, 6227.532935029801, 6228.439440450381, 6259.34276900937, 6065.120557519223, 6105.725242364193, 6117.877642447215, 6139.1098290746695, 6151.569390142647], "value": 5678.4798087944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.344700847445, 536.0806217337266, 549.0638461423274, 552.687731431741, 561.8848136132092, 38209.99999999996, 38809.22381552371, 40215.19569608606, 40326.59673403269, 40390.0, 34527.65472345276, 43952.3407148893, 44798.77600612, 44936.1012779745, 46597.0, 9716.417014979106, 9859.852102218472, 9871.555779989882, 9877.259205559576, 9878.160356369717, 9103.0, 9410.482423466707, 9715.319927605071, 9803.2157427406, 9877.259205559576, 9796.706098817047, 9810.018998100204, 9838.950805245964, 9859.21126309897, 9869.309148359618, 8464.280536154434, 9732.41605503672, 9737.610495580167, 9839.262055345842, 9848.310618256724, 9581.61673533058, 9666.323357364987, 9741.707748767549, 9744.464054477, 9803.950980245054, 40731.185376292306, 40786.59213407887, 40859.38710919338, 41113.383299250534, 41196.58803411957, 3228.564143840575, 3371.6291207967106, 3445.0526105320987, 3524.7004004659634, 3622.9094272643133, 24835.130770422948, 29112.835486580512, 29203.415931681247, 29959.801607935875, 30242.69757302421, 2672.786177105827, 2806.256342069353, 2824.985875070632, 2828.589854471111, 2930.0477344863007, 335768.0, 437021.0, 437045.0, 440848.0, 442868.5713142892, 60767.78464430775, 60886.695566521885, 61508.76982460326, 61910.0, 61955.69022154951, 56888.71555642195, 64653.67673161604, 65995.0, 66762.66618666875, 66831.66584167047, 15916.0450372978, 16002.519924402286, 16045.919770401306, 16086.35654573804, 16141.515754527149, 12146.696332591579, 12201.816972745415, 12272.079594030483, 12282.324472154118, 12290.508379664714, 16891.831081689026, 16968.49094527166, 17020.06389648581, 17068.48794536166, 17118.229679664444, 6774.661266936732, 7407.925850751611, 7502.287282708134, 7584.4311676624475, 7597.506162099446, 890.0, 932.7201839448138, 972.2707969023232, 1004.1314263162312, 1077.8197873328693, 25693.614595781077, 29471.705282947325, 29858.40283194324, 30425.0, 30731.846340768152, 933.9026643693633, 948.4356807699546, 1030.5517100061497, 1090.2477290669412, 1090.7273181704575, 13216.603501894959, 14896.851031489763, 15579.844201558066, 15626.687466250838, 15928.964617299838, 648064.0, 666790.0, 667568.0, 671768.0, 672823.9076413858, 47559.0, 55287.617809555086, 62555.0, 62607.0, 62807.0, 1441.617971237623, 1451.003776585197, 1461.978070328946, 1487.315834716021, 1487.4793822162374, 30092.0, 30106.69893301039, 30241.243968900955, 30243.848780755954, 30385.088447346614, 44142.77928610337, 53186.4681353197, 53725.19412208742, 53754.19368709551, 53838.65403364947, 483936.0, 483982.0, 486633.0, 487367.0, 487713.0, 24027.0, 26887.73112268852, 27294.45411091807, 28646.140615781558, 41237.38143927904, 46669.833254168916, 47493.52506475029, 47817.08731650695, 48221.0, 48972.5102748968, 38013.80993095017, 39481.40777888391, 39715.80852574427, 40157.79921100376, 40293.59706403016, 33728.83135584307, 37720.811395942845, 38455.0, 38612.0, 39369.80315098406, 38158.61841381661, 38778.80610596929, 38949.83150505489, 38991.415128772525, 39039.41440878446, 32777.672223278416, 33467.49798752972, 34473.827630861684, 34488.31023379569, 34820.0, 25318.620220696335, 25330.493390131727, 25518.23445296644, 25780.355491112874, 25826.870865645553], "value": 19816.050237861105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.3713276449663, 382.4301790332404, 388.36890053662796, 397.3225650266296, 406.8494656976919, 20030.89984550077, 21807.23674671387, 22050.22824201155, 22678.206262780786, 22742.862856857173, 18059.90970045148, 21219.257325993593, 21553.56892862142, 22189.445263868412, 22373.664395034048, 5778.43982124826, 5811.27359080115, 6044.093385992114, 6063.151158837766, 6068.757249710006, 4103.302438585448, 5947.494462970652, 5972.074328479092, 6268.65522396268, 6618.437432818217, 6616.536842421033, 6621.37096975789, 6626.801195964104, 6661.666916654172, 6669.199696036482, 6340.270868850095, 6648.66756662165, 6656.13470248867, 6671.866562668768, 6682.565633233824, 5680.914786278209, 5734.025215713339, 5775.740091695884, 5820.417958204188, 5824.388439213864, 23926.64110038351, 24412.877935610384, 25404.85678144488, 27404.0, 27637.861810690818, 2009.5177157482244, 2054.342610364684, 2114.1015068595784, 2134.541073669169, 2730.412961213349, 9848.458334791583, 9984.500774961223, 10051.246156538216, 10213.182945364353, 10215.02957219063, 1539.6689711711924, 1734.8438640522413, 1763.4797734668305, 1773.3527262549205, 1774.0774797105432, 98998.0100198996, 126353.36823315917, 129847.0, 129863.0, 133879.0, 11748.060155187564, 11800.350980696145, 11823.822642660367, 11924.761504769856, 11942.940285298519, 14880.0, 14951.626209344853, 14955.027923184958, 14956.326965286587, 14975.550733478012, 8461.70384036568, 8505.95747021261, 8532.445391049687, 8659.26814637075, 8667.696630618024, 8083.232092951161, 8255.174482551816, 8255.669773209005, 8280.58597070156, 8335.583220838933, 4576.542345765463, 4650.302454631832, 4656.371389862393, 4714.5521175488275, 4723.7401942893475, 1714.6399256156346, 1784.8125946775401, 1867.2251015828278, 1952.2386269354963, 2002.6595478768645, 895.3463971300987, 897.8069715011304, 920.7375897869075, 951.8429459139303, 1018.3991445047458, 19405.32081377145, 20341.881196534036, 20396.0, 20932.0, 21968.231111911005, 863.6156910175038, 919.5034681272172, 978.8433850583872, 999.8900120986685, 1026.3328836256344, 9853.0, 10614.416207108528, 11122.277051991594, 11319.830202546967, 11454.54181832734, 580363.0981845064, 581623.0, 583245.0, 597654.0, 597967.0, 83801.74297385543, 96898.0, 134568.32715836554, 134673.0, 134910.0, 959.5729900194347, 960.1646567486332, 961.2022021721954, 979.8628192053118, 1005.8642083318658, 19133.23467061302, 19159.904200478908, 19170.520736981685, 19180.232790688216, 19269.4219173425, 42950.281988720104, 55222.723886380314, 55308.0, 55758.72120639371, 56537.71731141318, 76664.6166769185, 77137.0, 79833.80249296382, 80126.5993670028, 82984.0, 8059.717909873127, 8105.3920955929725, 8232.588370581567, 8243.299319557666, 8537.82924341522, 10637.680869573926, 12077.833147564077, 12521.749565008831, 12793.936030319788, 12903.548375806802, 11122.499487523242, 11327.433628318717, 11527.827082593936, 11550.48022838991, 11624.360660163773, 8355.582220889053, 8684.261837743863, 10881.020708136306, 11131.220814542905, 11212.49543770516, 11391.430428478378, 11425.542978281108, 11744.530218791153, 11793.41032948332, 11868.703282418008, 8158.265756081981, 8177.100518943031, 8270.090290068209, 8445.07104218523, 8454.450460720034, 9368.95315523418, 10602.787944241227, 11625.709357266136, 11694.70763230926, 11715.824262636237], "value": 9643.913493504473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.5810714892682, 1634.6812371587537, 1809.891406515609, 1862.5250561106916, 1982.6133903888747, 8206.95896520518, 8754.212120909116, 8855.91144088559, 9248.306377021725, 9273.768155796108, 8888.688895888645, 8967.192952634261, 9072.682456114037, 9079.455232686043, 9129.452232866017, 2450.852948823072, 2456.705195376557, 2468.7778099971, 2477.9008839646394, 2481.2060140754966, 2417.153996101359, 2475.4801491686676, 2487.9378015549573, 2491.5266099441137, 2497.113524698733, 2443.30365845734, 2444.6210837320154, 2455.545724041049, 2466.5930121529927, 2473.7773600375963, 2395.3293077938206, 2435.025989604155, 2458.5943319352286, 2464.0, 2473.938151546208, 2428.5992811186134, 2436.378723425533, 2436.439618887666, 2455.8280920335583, 2459.114718701266, 7651.617419129077, 9000.414973026798, 9043.728688139367, 9091.27269818413, 9096.590653420611, 5435.891282174334, 5460.6177567570285, 5502.0921547944545, 5526.419725928759, 5535.308086489189, 3579.28414317135, 3591.7306202034692, 3599.5320608321013, 3692.778433294011, 3707.462417949382, 1033.5555711044249, 1052.4842827014784, 1053.8524606555088, 1055.7466208109997, 1057.185966805563, 11842.289462632183, 11935.582254621133, 12099.153059285942, 12118.394080296039, 12141.878581214252, 4185.393117997874, 4845.103655823684, 4942.802287908516, 5021.322121513549, 5072.797088116434, 10166.983301669921, 10167.796644067077, 10176.491175441199, 10180.134688551409, 10204.795904081877, 5424.077906755861, 5435.836924892181, 5491.697956612425, 5522.2544956431175, 5533.612647114744, 4467.6649251305635, 4892.926606100911, 5046.596272298208, 5063.518965698253, 5071.112555302807, 4130.091379896418, 4131.938020929689, 4176.1885558094755, 4179.519355274121, 4250.383694364362, 1355.9864401356058, 1381.171297221659, 1383.3152589468277, 1386.7711827548342, 1390.7149034447914, 912.1790388650135, 930.9674161404319, 938.7887725261761, 939.3514382259092, 950.6340059077305, 5899.46904778572, 5954.791582294599, 5989.760409583568, 6072.817815465543, 6134.153601905122, 450.73631925324054, 462.5212904643678, 469.60553135365774, 470.09272104837993, 470.3156906700742, 3963.3064213762477, 4011.4785077940264, 4017.397390391465, 4102.3026085565525, 4104.15864747726, 10676.679699609023, 11043.116550675926, 11074.557017719362, 11084.722881927855, 11087.50106245221, 10874.130069594414, 10880.72798180036, 11009.669709908716, 11029.889701102886, 11047.392393418439, 5914.497267732291, 8248.628811703487, 8295.585220738938, 8346.833063338821, 8486.957565212135, 5024.196128619404, 5787.102999035156, 5846.123081537803, 5854.2389489366105, 6024.457798798129, 8822.0, 9759.316847820868, 10169.9491502542, 10234.334768240338, 10252.794944100928, 9891.307608467338, 10139.695809125738, 10334.483275836328, 10352.741181470223, 10398.168146548107, 6278.780242691667, 6829.726810927507, 7255.548890222082, 7501.174870764103, 7739.419543534144, 8558.315334773079, 8597.140285971353, 8645.092265312303, 8651.394402391772, 8662.220400164015, 6966.303369662993, 7466.141393739789, 7471.290227428385, 7700.961495192488, 7707.537547747153, 7476.70093196266, 7496.812579685334, 7552.697892084255, 7564.50830696025, 7620.733274335372, 6275.905861412174, 6633.673265347046, 6980.476464265099, 7007.194172670208, 7078.681459334445, 4712.835050773207, 4818.204996175732, 4827.106985207748, 4914.0908931847725, 5012.724300163526, 4814.566688998007, 4824.204006338915, 4922.778474968707, 5026.723530205873, 5087.160618497906], "value": 4592.596995024906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.89599536157704, 314.34772846343833, 319.2004029905088, 323.9116568330408, 325.0670575448463, 4775.450823155338, 5351.892962140755, 5626.578006649503, 5633.830985070449, 5683.545316374691, 4584.5644663756975, 4949.455559888409, 5385.2999110115725, 5510.862228444291, 5534.225208470817, 3645.343838109139, 4158.8960275993195, 4163.646090082347, 4175.269327867626, 4196.600753389749, 3363.0, 3965.821538030781, 4182.2681030819485, 4194.119234960646, 4218.008767939532, 3471.7328175216117, 3523.5947865995354, 3994.48071750672, 4138.97930510347, 4139.468396693228, 3841.3661745811905, 4147.419361289422, 4155.4182414462, 4168.979155104235, 4175.91648167035, 3028.303490197245, 3362.4283871741864, 3605.7475976681644, 3606.1886075633033, 3609.530761001079, 5044.596432285409, 5068.0, 5311.7344132793205, 5325.4437869822705, 5418.241446197536, 4074.8370065197355, 4749.551386827016, 4813.350197723297, 4828.444728856191, 4843.975780121112, 4999.250112483157, 5362.008028514737, 5838.737256823453, 5857.414258574151, 5881.588288819784, 3613.9096522586883, 3826.603289799231, 3968.3849003404516, 3981.7810020448865, 3986.82717918735, 5172.508556724234, 5685.232493613392, 6148.0, 6197.566170368076, 6205.317415084337, 3376.953144525205, 3555.768875023115, 3646.58064322601, 3706.591495231795, 4030.415589739471, 3238.7732858699665, 3933.662554731405, 3982.920341593152, 4044.292248856438, 4099.467069281034, 4020.979895100506, 4135.234981528427, 4705.223638099744, 4718.551737584924, 4726.385569875894, 4660.5106463821485, 5838.737256823453, 5843.428891287905, 5862.0, 5866.061430171152, 1319.6803196803196, 1346.0, 1356.8100465934776, 1374.2372982994534, 1385.231196685829, 750.7484992527455, 830.5099991005336, 835.9038710548243, 845.9636944742764, 850.9361797865062, 4143.218416081114, 4172.979135104366, 4203.07532342884, 4207.368894665825, 4647.16351056813, 4620.5379462053525, 4836.847602816712, 4913.828016019422, 5155.896882062338, 5215.556677682363, 4125.205535592027, 4151.194230509738, 4436.423264975532, 4542.341360502709, 4690.115578919009, 2478.1821998740375, 2647.3911000469616, 2666.520026395229, 2708.498927698382, 2786.972130278671, 4984.651074424828, 5049.697018178921, 5288.894222115536, 5392.73036348181, 5403.676099355683, 4232.894177645583, 4577.679562430598, 5196.64816193553, 5279.39286982002, 5308.443342960226, 4794.161021821167, 5013.896942672606, 5160.374482038146, 5366.087765079946, 5377.677339359651, 4749.0, 4760.166970780169, 5136.5617627064485, 5136.897262054663, 5192.870922921584, 4317.4457195408995, 4841.225403935354, 5089.160288552495, 5108.667936584259, 5363.383210930637, 5541.196526503554, 5800.8259752207505, 5805.419458054161, 6064.756724871302, 6372.55392122547, 3856.804390638799, 3949.7037722170376, 4009.679225661882, 4021.9945013746565, 4027.395890616431, 5686.289213848269, 5954.880902382015, 6069.241344831896, 6134.141220229082, 6158.06021103351, 4731.361266229015, 4998.525140111684, 5400.594955378284, 5923.851903702442, 5944.494717949023, 5593.384727679871, 5913.615614985012, 5943.613665111754, 5949.851253718692, 5951.583389162717, 4889.364382630235, 5346.465353464622, 5695.857603559944, 5826.563007774519, 5826.592138550261, 5856.531477481706, 5877.294724633071, 5881.264841894763, 5887.411258874078, 5910.763569457174, 4600.608948239437, 4848.515148485123, 4881.438634556929, 5707.885842283048, 5744.167095771173], "value": 4023.754148035538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.613541078469, 683.1597135523306, 721.1598487761757, 743.9814004649883, 758.6586036283672, 15098.0, 15468.922655386736, 15821.841781582181, 15856.207189640516, 15886.285117169711, 13932.303384830768, 14271.357788899499, 14492.710145797078, 14528.636784080376, 14631.561053168421, 703.8345988692653, 838.2372041442288, 902.2511315608062, 920.6179435534262, 939.6429356844424, 925.5511077127587, 931.7996630724393, 933.2394098809483, 933.9866245124049, 936.1153709744294, 808.1958451340925, 948.3551185194066, 966.8018056298478, 971.1065819446092, 989.8218320702271, 971.2909576009482, 976.501983988164, 977.9364341317827, 978.1832170137908, 978.280963491833, 704.4153352717233, 722.2560762414721, 723.1214074899023, 724.8224185074638, 725.3037084398983, 15340.23298835065, 15424.46014389491, 15544.0, 15561.610959725984, 15586.220688965506, 12747.61757147287, 12809.679758006032, 12844.0, 12899.742005159938, 13109.934450327688, 10159.23805714567, 10237.259665856822, 10305.330153539995, 10527.684169474927, 10655.147588192925, 3450.913727156816, 3467.757256991986, 3589.335972845032, 3630.110622897407, 3706.666400023984, 74404.62797685977, 97479.51260243653, 98106.50946745292, 101050.49474752652, 101977.49011254896, 9442.244620430349, 9560.66537671192, 9597.136257736836, 9652.22782177424, 9923.80152396948, 22717.432064198198, 22900.885495572747, 23011.654825177637, 23064.4233894154, 23279.76720232776, 6982.825429364205, 7290.0, 7334.889976650355, 7345.228750981177, 7717.922820771832, 3927.0771368728324, 3973.046468847456, 3975.224831157954, 3979.9403008954887, 4028.053407449247, 3530.541029666127, 3652.141746689526, 3661.139632186434, 3666.5700376853047, 3676.338259113332, 637.6907200007993, 641.8010416770816, 653.4413076819346, 654.2443477783168, 656.9737210511622, 539.4794023767083, 543.7661805423705, 552.3647805024254, 553.583961881784, 557.6550604707196, 6347.333529979285, 7874.173211812677, 7968.888314220042, 7977.680892764224, 8119.431639785276, 534.882325888304, 547.3650565344182, 553.3332334536873, 559.6697948210575, 567.3617180671745, 3806.410006449005, 3826.330392181357, 3842.5965273646425, 3843.865464708722, 3853.3834586466032, 69536.0, 86255.56872215724, 98787.0, 98884.50557747165, 100586.0, 67081.0, 86597.0, 87250.12749872547, 87345.56327218324, 88076.5596172015, 73593.26406735864, 75140.1158924679, 76430.0, 76614.85077723839, 78694.0, 8055.677772889253, 8291.58542072882, 8397.70608028716, 8423.831523369621, 8581.927259092614, 44437.88905277394, 45186.548134518234, 47060.52939470561, 47403.83419946844, 48197.51802481931, 54043.0, 68981.11027555089, 69560.6521967387, 69690.30309696838, 69825.65087174531, 11119.499622516845, 11221.887781122085, 11244.775104498029, 11446.713832154262, 11595.710107247387, 12295.32375719344, 12315.261084334968, 12535.373231338579, 12537.749245015231, 12577.245365278113, 9667.9033209667, 11627.302361858316, 11752.294862308288, 11753.471093800628, 12127.757444850877, 8377.790555236168, 11406.54373825071, 11578.36319002463, 11754.353510557, 11981.76036479248, 11233.66299011031, 11323.433828308387, 11342.20604557673, 11424.428778560872, 11447.885521145015, 8173.591320433836, 9479.952600236955, 9646.951765241129, 9776.85334719994, 9813.11681948628, 7375.225601311785, 8011.038675358995, 8396.286315663237, 9122.90877091247, 9527.90472095298], "value": 6938.190012282293, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1637.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 108.0, 117.0, 118.0, 112.0, 107.0, 116.0, 148.0, 165.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 119.0, 145.0, 198.0, 120.0, 145.0, 138.0, 122.0, 170.0, 118.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 196.0, 208.0, 257.0, 235.0, 269.0, 242.0, 225.0, 262.0, 198.0], "value": 229.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 78.0, 181.0, 65.0, 82.0, 107.0, 92.0, 134.0, 59.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 154.0, 77.0, 75.0, 87.0, 124.0, 83.0, 82.0, 127.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 104.0, 105.0, 89.0, 90.0, 96.0, 133.0, 89.0, 92.0, 100.0], "value": 99.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 97.0, 95.0, 112.0, 97.0, 95.0, 108.0, 150.0], "value": 104.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 116.0, 146.0, 90.0, 89.0, 95.0, 91.0, 90.0, 94.0], "value": 99.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 58.0, 58.0, 58.0, 59.0, 59.0, 119.0, 61.0, 59.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 66.0, 78.0, 98.0, 106.0, 102.0, 74.0, 64.0, 68.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 92.0, 85.0, 89.0, 92.0, 103.0, 113.0, 107.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 134.0, 141.0, 140.0, 140.0, 149.0, 156.0, 246.0, 143.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 178.0, 167.0, 235.0, 155.0, 221.0, 229.0, 202.0, 170.0, 167.0], "value": 188.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 87.0, 70.0, 66.0, 63.0, 66.0, 69.0, 67.0, 65.0], "value": 67.3, "unit": "score"}]}]} 12:33:32 INFO - Return code: 0 12:33:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:33:32 ERROR - # TBPL SUCCESS # 12:33:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:33:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:33:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:33:32 INFO - 2016-05-17 12:33:32.903 screenresolution[1684:10712] starting screenresolution argv=screenresolution get 12:33:32 INFO - 2016-05-17 12:33:32.906 screenresolution[1684:10712] Display 0: 1600x1200x32@60 12:33:32 INFO - 2016-05-17 12:33:32.912 screenresolution[1685:10715] starting screenresolution argv=screenresolution list 12:33:32 INFO - Available Modes on Display 0 12:33:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:33:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:33:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:33:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:33:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:33:33 INFO - Intel Iris: 12:33:33 INFO - Chipset Model: Intel Iris 12:33:33 INFO - Type: GPU 12:33:33 INFO - Bus: Built-In 12:33:33 INFO - VRAM (Dynamic, Max): 1536 MB 12:33:33 INFO - Vendor: Intel (0x8086) 12:33:33 INFO - Device ID: 0x0a2e 12:33:33 INFO - Revision ID: 0x0009 12:33:33 INFO - Displays: 12:33:33 INFO - Display: 12:33:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:33:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:33:33 INFO - Display Serial Number: 1600x1200 60 12:33:33 INFO - Main Display: Yes 12:33:33 INFO - Mirror: Off 12:33:33 INFO - Online: Yes 12:33:33 INFO - Rotation: Supported 12:33:33 INFO - Return code: 0 12:33:33 INFO - Running post-action listener: _resource_record_post_action 12:33:33 INFO - ##### 12:33:33 INFO - ##### Finished run-tests step (success) 12:33:33 INFO - ##### 12:33:33 INFO - Running post-run listener: _resource_record_post_run 12:33:33 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 32538112; Write bytes: 700406784; Read time: 323; Write time: 1988 12:33:33 INFO - TinderboxPrint: CPU usage
54.6% 12:33:33 INFO - TinderboxPrint: I/O read bytes / time
32,538,112 / 323 12:33:33 INFO - TinderboxPrint: I/O write bytes / time
700,406,784 / 1,988 12:33:33 INFO - TinderboxPrint: CPU idle
2,197.5 (45.4%) 12:33:33 INFO - TinderboxPrint: CPU system
981.8 (20.3%) 12:33:33 INFO - TinderboxPrint: CPU user
1,666.4 (34.4%) 12:33:33 INFO - TinderboxPrint: Swap in / out
423,870,464 / 0 12:33:33 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 380600832; Write bytes: 374638592; Read time: 29735; Write time: 748 12:33:33 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 31583744; Write bytes: 302982144; Read time: 308; Write time: 1191 12:33:33 INFO - Running post-run listener: _upload_blobber_files 12:33:33 INFO - Blob upload gear active. 12:33:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:33:33 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 12:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:33:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:33:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:33:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:33:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:35 INFO - (blobuploader) - INFO - Done attempting. 12:33:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:33:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:36 INFO - (blobuploader) - INFO - Done attempting. 12:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:39 INFO - (blobuploader) - INFO - Done attempting. 12:33:39 INFO - (blobuploader) - INFO - Iteration through files over. 12:33:39 INFO - Return code: 0 12:33:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:33:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:33:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3464a86f6ac9a1d83ae84ea4a7c4fac70c6ec005193bea989537750caca217beb53b38ca7b6808dc23e317af580a1c56d0616bd0d3e6cde0b518470d2c06ddb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17d6b47e26d3076f68576ea77a69c4797f65b24bf3bde204514e563c98f2e3bbbb7955072e46ed1f735ec6fd24957c15927e4e4b0bf91a58dd3ea592f5d86044", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d805cd7c3626a87f0ad5bf2b2eafb0414a28513a88f3ea08996e5cac3c9b24725ab010c51c9ee085ec2374f45fb81938dc0059ae8958047082940d2ca7238281"} 12:33:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:33:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:33:39 INFO - Contents: 12:33:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3464a86f6ac9a1d83ae84ea4a7c4fac70c6ec005193bea989537750caca217beb53b38ca7b6808dc23e317af580a1c56d0616bd0d3e6cde0b518470d2c06ddb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17d6b47e26d3076f68576ea77a69c4797f65b24bf3bde204514e563c98f2e3bbbb7955072e46ed1f735ec6fd24957c15927e4e4b0bf91a58dd3ea592f5d86044", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d805cd7c3626a87f0ad5bf2b2eafb0414a28513a88f3ea08996e5cac3c9b24725ab010c51c9ee085ec2374f45fb81938dc0059ae8958047082940d2ca7238281"} 12:33:39 INFO - Running post-run listener: copy_logs_to_upload_dir 12:33:39 INFO - Copying logs to upload dir... 12:33:39 INFO - mkdir: /builds/slave/test/build/upload/logs 12:33:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1333.590909 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-05-17 12:33:39.305791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 12:33:39.309462) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.biZBO483Qa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3464a86f6ac9a1d83ae84ea4a7c4fac70c6ec005193bea989537750caca217beb53b38ca7b6808dc23e317af580a1c56d0616bd0d3e6cde0b518470d2c06ddb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17d6b47e26d3076f68576ea77a69c4797f65b24bf3bde204514e563c98f2e3bbbb7955072e46ed1f735ec6fd24957c15927e4e4b0bf91a58dd3ea592f5d86044", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d805cd7c3626a87f0ad5bf2b2eafb0414a28513a88f3ea08996e5cac3c9b24725ab010c51c9ee085ec2374f45fb81938dc0059ae8958047082940d2ca7238281"} build_url:https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/Vq1vmhENR5ecl0jJHufclw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3464a86f6ac9a1d83ae84ea4a7c4fac70c6ec005193bea989537750caca217beb53b38ca7b6808dc23e317af580a1c56d0616bd0d3e6cde0b518470d2c06ddb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17d6b47e26d3076f68576ea77a69c4797f65b24bf3bde204514e563c98f2e3bbbb7955072e46ed1f735ec6fd24957c15927e4e4b0bf91a58dd3ea592f5d86044", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d805cd7c3626a87f0ad5bf2b2eafb0414a28513a88f3ea08996e5cac3c9b24725ab010c51c9ee085ec2374f45fb81938dc0059ae8958047082940d2ca7238281"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 12:33:39.337482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:33:39.337802) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.biZBO483Qa/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GlhDHoX9Dl/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005053 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:33:39.386575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 12:33:39.386859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 12:33:39.387172) ========= ========= Total master_lag: 0.31 =========