builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0200 starttime: 1460390285.4 results: success (0) buildid: 20160411065021 builduid: 1b2fb46e10d94eb486a49d525ebe09a7 revision: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.404878) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.405277) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.405558) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005682 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.428291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.428569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.444026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.444293) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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.005521 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.493515) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.493812) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.494161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.494434) ========= 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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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-04-11 08:58:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.17M=0.001s 2016-04-11 08:58:05 (8.17 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.611800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.612115) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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.021349 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.661351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:05.661667) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d93a1bc945137dfcc94866f1e30da1f55cfb8d9d --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 d93a1bc945137dfcc94866f1e30da1f55cfb8d9d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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-04-11 08:58:05,723 truncating revision to first 12 chars 2016-04-11 08:58:05,723 Setting DEBUG logging. 2016-04-11 08:58:05,723 attempt 1/10 2016-04-11 08:58:05,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d93a1bc94513?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 08:58:06,209 unpacking tar archive at: fx-team-d93a1bc94513/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743020 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:06.420861) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:06.421218) ========= echo d93a1bc945137dfcc94866f1e30da1f55cfb8d9d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd93a1bc945137dfcc94866f1e30da1f55cfb8d9d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 d93a1bc945137dfcc94866f1e30da1f55cfb8d9d program finished with exit code 0 elapsedTime=0.005299 script_repo_revision: 'd93a1bc945137dfcc94866f1e30da1f55cfb8d9d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:06.470661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:06.470995) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 08:58:06.484076) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-11 08:58:06.484348) ========= /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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:06 INFO - MultiFileLogger online at 20160411 08:58:06 in /builds/slave/test 08:58:06 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 08:58:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:58:06 INFO - {'append_to_log': False, 08:58:06 INFO - 'base_work_dir': '/builds/slave/test', 08:58:06 INFO - 'blob_upload_branch': 'Fx-Team', 08:58:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:58:06 INFO - 'branch': 'Fx-Team', 08:58:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:58:06 INFO - 'config_files': ('talos/mac_config.py',), 08:58:06 INFO - 'default_actions': ('clobber', 08:58:06 INFO - 'read-buildbot-config', 08:58:06 INFO - 'download-and-extract', 08:58:06 INFO - 'populate-webroot', 08:58:06 INFO - 'create-virtualenv', 08:58:06 INFO - 'install', 08:58:06 INFO - 'run-tests'), 08:58:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:58:06 INFO - 'download_minidump_stackwalk': True, 08:58:06 INFO - 'download_symbols': 'ondemand', 08:58:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:58:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:58:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:58:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:58:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:58:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:58:06 INFO - 'installer_path': 'installer.exe', 08:58:06 INFO - 'log_level': 'info', 08:58:06 INFO - 'log_name': 'talos', 08:58:06 INFO - 'log_to_console': True, 08:58:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:58:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:58:06 INFO - 'opt_config_files': (), 08:58:06 INFO - 'pip_index': False, 08:58:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:58:06 INFO - 'cmd': ('bash', 08:58:06 INFO - '-c', 08:58:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:58:06 INFO - 'enabled': True, 08:58:06 INFO - 'halt_on_failure': False, 08:58:06 INFO - 'name': 'check_screen_resolution'},), 08:58:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:58:06 INFO - 'cmd': ('bash', 08:58:06 INFO - '-c', 08:58:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:58:06 INFO - 'enabled': True, 08:58:06 INFO - 'halt_on_failure': False, 08:58:06 INFO - 'name': 'check_screen_resolution'},), 08:58:06 INFO - 'run_cmd_checks_enabled': True, 08:58:06 INFO - 'sps_profile': False, 08:58:06 INFO - 'sps_profile_interval': 0, 08:58:06 INFO - 'suite': 'dromaeojs-e10s', 08:58:06 INFO - 'system_bits': '32', 08:58:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:58:06 INFO - 'title': 't-yosemite-r7-0200', 08:58:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:58:06 INFO - 'use_talos_json': True, 08:58:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:58:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:58:06 INFO - 'work_dir': 'build'} 08:58:06 INFO - ##### 08:58:06 INFO - ##### Running clobber step. 08:58:06 INFO - ##### 08:58:06 INFO - Running pre-action listener: _resource_record_pre_action 08:58:06 INFO - Running main action method: clobber 08:58:06 INFO - rmtree: /builds/slave/test/build 08:58:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:58:08 INFO - Running post-action listener: _resource_record_post_action 08:58:08 INFO - ##### 08:58:08 INFO - ##### Running read-buildbot-config step. 08:58:08 INFO - ##### 08:58:08 INFO - Running pre-action listener: _resource_record_pre_action 08:58:08 INFO - Running main action method: read_buildbot_config 08:58:08 INFO - Using buildbot properties: 08:58:08 INFO - { 08:58:08 INFO - "project": "", 08:58:08 INFO - "product": "firefox", 08:58:08 INFO - "script_repo_revision": "production", 08:58:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:58:08 INFO - "repository": "", 08:58:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:58:08 INFO - "buildid": "20160411065021", 08:58:08 INFO - "pgo_build": "False", 08:58:08 INFO - "basedir": "/builds/slave/test", 08:58:08 INFO - "buildnumber": 598, 08:58:08 INFO - "slavename": "t-yosemite-r7-0200", 08:58:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:58:08 INFO - "platform": "yosemite_r7", 08:58:08 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:58:08 INFO - "branch": "fx-team", 08:58:08 INFO - "repo_path": "integration/fx-team", 08:58:08 INFO - "revision": "d93a1bc945137dfcc94866f1e30da1f55cfb8d9d", 08:58:08 INFO - "stage_platform": "macosx64", 08:58:08 INFO - "builduid": "1b2fb46e10d94eb486a49d525ebe09a7", 08:58:08 INFO - "slavebuilddir": "test" 08:58:08 INFO - } 08:58:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:58:08 INFO - Running post-action listener: _resource_record_post_action 08:58:08 INFO - ##### 08:58:08 INFO - ##### Running download-and-extract step. 08:58:08 INFO - ##### 08:58:08 INFO - Running pre-action listener: _resource_record_pre_action 08:58:08 INFO - Running main action method: download_and_extract 08:58:08 INFO - mkdir: /builds/slave/test/build/tests 08:58: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')]} 08:58:08 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:58:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:58:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:58:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 08:58:09 INFO - Downloaded 1199 bytes. 08:58:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:58:09 INFO - Using the following test package requirements: 08:58:09 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:58:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:58:09 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:58:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:58:09 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:58:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:58:09 INFO - u'jsshell-mac.zip'], 08:58:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:58:09 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:58:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:58:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:58:09 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:58:09 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:58:09 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:58:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:58:09 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:58:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:58:09 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:58:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:09 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:58:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:58:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:58:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:58:10 INFO - Downloaded 18018734 bytes. 08:58:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:58:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:58:14 INFO - Return code: 0 08:58:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:14 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:58:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:58:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:58:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:58:15 INFO - Downloaded 18018734 bytes. 08:58:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:58:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:58:18 INFO - Return code: 0 08:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:18 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:58:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:58:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:58:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:58:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:58:19 INFO - Downloaded 10841046 bytes. 08:58:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:58:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:58:19 INFO - Return code: 0 08:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:19 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 08:58:23 INFO - Downloaded 108833223 bytes. 08:58:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:58:23 INFO - mkdir: /builds/slave/test/properties 08:58:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:58:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:58:23 INFO - Contents: 08:58:23 INFO - build_url:https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:58:24 INFO - Running post-action listener: _resource_record_post_action 08:58:24 INFO - Running post-action listener: set_extra_try_arguments 08:58:24 INFO - ##### 08:58:24 INFO - ##### Running populate-webroot step. 08:58:24 INFO - ##### 08:58:24 INFO - Running pre-action listener: _resource_record_pre_action 08:58:24 INFO - Running main action method: populate_webroot 08:58:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:58:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:58:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:58:24 INFO - '--tppagecycles', 08:58:24 INFO - '7'], 08:58:24 INFO - 'tests': ['tsvgm']}}, 08:58:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:58:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:58:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:58:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:58:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:24 INFO - 'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:24 INFO - 'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['damp', 'tps']}, 08:58:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:24 INFO - 'tests': ['damp', 'tps']}, 08:58:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['dromaeo_dom']}, 08:58:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:58:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['a11yr', 08:58:24 INFO - 'ts_paint', 08:58:24 INFO - 'tpaint', 08:58:24 INFO - 'sessionrestore', 08:58:24 INFO - 'sessionrestore_no_auto_restore', 08:58:24 INFO - 'tabpaint']}, 08:58:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:58:24 INFO - 'ts_paint', 08:58:24 INFO - 'tpaint', 08:58:24 INFO - 'sessionrestore', 08:58:24 INFO - 'sessionrestore_no_auto_restore', 08:58:24 INFO - 'tabpaint']}, 08:58:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:58:24 INFO - 'ts_paint', 08:58:24 INFO - 'tpaint', 08:58:24 INFO - 'sessionrestore', 08:58:24 INFO - 'sessionrestore_no_auto_restore', 08:58:24 INFO - 'tabpaint']}, 08:58:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:58:24 INFO - 'ts_paint', 08:58:24 INFO - 'tpaint', 08:58:24 INFO - 'sessionrestore', 08:58:24 INFO - 'sessionrestore_no_auto_restore', 08:58:24 INFO - 'tabpaint']}, 08:58:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['a11yr', 08:58:24 INFO - 'ts_paint', 08:58:24 INFO - 'tpaint', 08:58:24 INFO - 'sessionrestore', 08:58:24 INFO - 'sessionrestore_no_auto_restore', 08:58:24 INFO - 'tabpaint']}, 08:58:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['a11yr', 08:58:24 INFO - 'ts_paint', 08:58:24 INFO - 'tpaint', 08:58:24 INFO - 'sessionrestore', 08:58:24 INFO - 'sessionrestore_no_auto_restore', 08:58:24 INFO - 'tabpaint']}, 08:58:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['tsvgx', 08:58:24 INFO - 'tsvgr_opacity', 08:58:24 INFO - 'tart', 08:58:24 INFO - 'tscrollx', 08:58:24 INFO - 'cart']}, 08:58:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:58:24 INFO - 'tsvgr_opacity', 08:58:24 INFO - 'tart', 08:58:24 INFO - 'tscrollx', 08:58:24 INFO - 'cart']}, 08:58:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:24 INFO - 'talos_options': ['--disable-e10s'], 08:58:24 INFO - 'tests': ['tp5o']}, 08:58:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:24 INFO - 'tests': ['tp5o']}, 08:58:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:24 INFO - 'talos_options': ['--disable-e10s', 08:58:24 INFO - '--xperf_path', 08:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:24 INFO - 'tests': ['tp5n']}, 08:58:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:24 INFO - 'talos_options': ['--xperf_path', 08:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:24 INFO - 'tests': ['tp5n']}}, 08:58:24 INFO - 'talos.zip': {'path': '', 08:58:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:58:24 INFO - Running post-action listener: _resource_record_post_action 08:58:24 INFO - ##### 08:58:24 INFO - ##### Running create-virtualenv step. 08:58:24 INFO - ##### 08:58:24 INFO - Running pre-action listener: _resource_record_pre_action 08:58:24 INFO - Running main action method: create_virtualenv 08:58:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:58:24 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 08:58:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:58:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:58:24 INFO - Using real prefix '/tools/python27' 08:58:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:58:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:58:28 INFO - Installing pip.................done. 08:58:28 INFO - Return code: 0 08:58:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:28 INFO - 'HOME': '/Users/cltbld', 08:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:28 INFO - 'LOGNAME': 'cltbld', 08:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:28 INFO - 'MOZ_NO_REMOTE': '1', 08:58:28 INFO - 'NO_EM_RESTART': '1', 08:58:28 INFO - 'PAGER': '/bin/cat', 08:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:28 INFO - 'PWD': '/builds/slave/test', 08:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:28 INFO - 'SHELL': '/bin/bash', 08:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:28 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:28 INFO - 'USER': 'cltbld', 08:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:28 INFO - 'XPC_FLAGS': '0x0', 08:58:28 INFO - 'XPC_SERVICE_NAME': '0', 08:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:28 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 08:58:28 INFO - Cleaning up... 08:58:28 INFO - Return code: 0 08:58:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:28 INFO - 'HOME': '/Users/cltbld', 08:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:28 INFO - 'LOGNAME': 'cltbld', 08:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:28 INFO - 'MOZ_NO_REMOTE': '1', 08:58:28 INFO - 'NO_EM_RESTART': '1', 08:58:28 INFO - 'PAGER': '/bin/cat', 08:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:28 INFO - 'PWD': '/builds/slave/test', 08:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:28 INFO - 'SHELL': '/bin/bash', 08:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:28 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:28 INFO - 'USER': 'cltbld', 08:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:28 INFO - 'XPC_FLAGS': '0x0', 08:58:28 INFO - 'XPC_SERVICE_NAME': '0', 08:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:28 INFO - Downloading/unpacking psutil>=0.7.1 08:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:58:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:31 INFO - Installing collected packages: psutil 08:58:31 INFO - Running setup.py install for psutil 08:58:31 INFO - building 'psutil._psutil_osx' extension 08:58:31 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 08:58:32 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 08:58:32 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 08:58:32 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 08:58:32 INFO - building 'psutil._psutil_posix' extension 08:58:32 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 08:58:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:58:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:58:32 INFO - ^ 08:58:32 INFO - 1 warning generated. 08:58:32 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 08:58:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:32 INFO - Successfully installed psutil 08:58:32 INFO - Cleaning up... 08:58:32 INFO - Return code: 0 08:58:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:32 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:32 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.0.0'] in /builds/slave/test/build 08:58:32 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.0.0 08:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:32 INFO - 'HOME': '/Users/cltbld', 08:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:32 INFO - 'LOGNAME': 'cltbld', 08:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:32 INFO - 'MOZ_NO_REMOTE': '1', 08:58:32 INFO - 'NO_EM_RESTART': '1', 08:58:32 INFO - 'PAGER': '/bin/cat', 08:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:32 INFO - 'PWD': '/builds/slave/test', 08:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:32 INFO - 'SHELL': '/bin/bash', 08:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:32 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:32 INFO - 'USER': 'cltbld', 08:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:32 INFO - 'XPC_FLAGS': '0x0', 08:58:32 INFO - 'XPC_SERVICE_NAME': '0', 08:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:58:32 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 08:58:32 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 08:58:32 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 08:58:32 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 08:58:32 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 08:58:32 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 08:58:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:58:35 INFO - Installing collected packages: mozsystemmonitor 08:58:35 INFO - Running setup.py install for mozsystemmonitor 08:58:35 INFO - Successfully installed mozsystemmonitor 08:58:35 INFO - Cleaning up... 08:58:35 INFO - Return code: 0 08:58:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:35 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 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:35 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 08:58:35 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 08:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:35 INFO - 'HOME': '/Users/cltbld', 08:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:35 INFO - 'LOGNAME': 'cltbld', 08:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:35 INFO - 'MOZ_NO_REMOTE': '1', 08:58:35 INFO - 'NO_EM_RESTART': '1', 08:58:35 INFO - 'PAGER': '/bin/cat', 08:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:35 INFO - 'PWD': '/builds/slave/test', 08:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:35 INFO - 'SHELL': '/bin/bash', 08:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:35 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:35 INFO - 'USER': 'cltbld', 08:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:35 INFO - 'XPC_FLAGS': '0x0', 08:58:35 INFO - 'XPC_SERVICE_NAME': '0', 08:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:58:35 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 08:58:35 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 08:58:35 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 08:58:35 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 08:58:35 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 08:58:35 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 08:58:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:58:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:58:38 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 08:58:38 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 08:58:38 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 08:58:38 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 08:58:38 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 08:58:38 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 08:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:58:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:39 INFO - Downloading docopt-0.6.1.tar.gz 08:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:58:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:58:39 INFO - Running setup.py install for blobuploader 08:58:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:58:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:58:39 INFO - Running setup.py install for requests 08:58:40 INFO - Running setup.py install for docopt 08:58:40 INFO - Successfully installed blobuploader requests docopt 08:58:40 INFO - Cleaning up... 08:58:40 INFO - Return code: 0 08:58:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:58:40 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')]} 08:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:40 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')]} 08:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:40 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 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:40 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 08:58:40 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 08:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:40 INFO - 'HOME': '/Users/cltbld', 08:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:40 INFO - 'LOGNAME': 'cltbld', 08:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:40 INFO - 'MOZ_NO_REMOTE': '1', 08:58:40 INFO - 'NO_EM_RESTART': '1', 08:58:40 INFO - 'PAGER': '/bin/cat', 08:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:40 INFO - 'PWD': '/builds/slave/test', 08:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:40 INFO - 'SHELL': '/bin/bash', 08:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:40 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:40 INFO - 'USER': 'cltbld', 08:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:40 INFO - 'XPC_FLAGS': '0x0', 08:58:40 INFO - 'XPC_SERVICE_NAME': '0', 08:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:58:40 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-9Ptdnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:58:40 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-6hKwwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:58:40 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-djMCF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-rfwoDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-KCC1FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-toQOsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-Xvrr67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-PwCaAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-F_G32G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-Efrelg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-hHMiEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:58:41 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-LnHH0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:58:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-o3LOhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:58:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-V5mtXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:58:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-4VBaP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:58:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-xeXail-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:58:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-g6f7oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:58:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:58:42 INFO - Running setup.py install for manifestparser 08:58:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:58:42 INFO - Running setup.py install for mozcrash 08:58:42 INFO - Running setup.py install for mozdebug 08:58:42 INFO - Running setup.py install for mozdevice 08:58:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:58:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:58:43 INFO - Running setup.py install for mozfile 08:58:43 INFO - Running setup.py install for mozhttpd 08:58:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:58:43 INFO - Running setup.py install for mozinfo 08:58:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:58:43 INFO - Running setup.py install for mozInstall 08:58:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:58:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:58:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:58:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:58:43 INFO - Running setup.py install for mozleak 08:58:43 INFO - Running setup.py install for mozlog 08:58:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:58:44 INFO - Running setup.py install for moznetwork 08:58:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:58:44 INFO - Running setup.py install for mozprocess 08:58:44 INFO - Running setup.py install for mozprofile 08:58:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:58:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:58:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:58:44 INFO - Running setup.py install for mozrunner 08:58:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:58:44 INFO - Running setup.py install for mozscreenshot 08:58:44 INFO - Running setup.py install for moztest 08:58:45 INFO - Running setup.py install for mozversion 08:58:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:58:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:58:45 INFO - Cleaning up... 08:58:45 INFO - Return code: 0 08:58:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:45 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 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:45 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 08:58:45 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 08:58:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:45 INFO - 'HOME': '/Users/cltbld', 08:58:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:45 INFO - 'LOGNAME': 'cltbld', 08:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:45 INFO - 'MOZ_NO_REMOTE': '1', 08:58:45 INFO - 'NO_EM_RESTART': '1', 08:58:45 INFO - 'PAGER': '/bin/cat', 08:58:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:45 INFO - 'PWD': '/builds/slave/test', 08:58:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:45 INFO - 'SHELL': '/bin/bash', 08:58:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:45 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:45 INFO - 'USER': 'cltbld', 08:58:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:45 INFO - 'XPC_FLAGS': '0x0', 08:58:45 INFO - 'XPC_SERVICE_NAME': '0', 08:58:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:58:45 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-YlJJ4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:58:45 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-06O8_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:58:45 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-OAnyvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:58:45 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-W0dVq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:58:45 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-x8UF0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:58:45 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-qqPS6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-98SqzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-z10TkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-CVPXNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-jod2DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-Pr_sHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-XSrzFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-cZjcza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-mTiP11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:58:46 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-IzAhbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:58:47 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)) 08:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:58:47 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-cdOGDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:58:47 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)) 08:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:58:47 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-oWAtfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:58:47 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)) 08:58:47 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)) 08:58:47 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)) 08:58:47 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)) 08:58:47 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)) 08:58:47 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)) 08:58:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:58:47 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 08:58:47 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 08:58:47 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 08:58:47 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 08:58:47 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 08:58:47 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 08:58:49 INFO - Downloading blessings-1.6.tar.gz 08:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:58:49 INFO - Installing collected packages: blessings 08:58:49 INFO - Running setup.py install for blessings 08:58:49 INFO - Successfully installed blessings 08:58:49 INFO - Cleaning up... 08:58:50 INFO - Return code: 0 08:58:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:58:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:58:50 INFO - Reading from file tmpfile_stdout 08:58:50 INFO - Current package versions: 08:58:50 INFO - blessings == 1.6 08:58:50 INFO - blobuploader == 1.2.4 08:58:50 INFO - docopt == 0.6.1 08:58:50 INFO - manifestparser == 1.1 08:58:50 INFO - mozInstall == 1.12 08:58:50 INFO - mozcrash == 0.17 08:58:50 INFO - mozdebug == 0.1 08:58:50 INFO - mozdevice == 0.48 08:58:50 INFO - mozfile == 1.2 08:58:50 INFO - mozhttpd == 0.7 08:58:50 INFO - mozinfo == 0.9 08:58:50 INFO - mozleak == 0.1 08:58:50 INFO - mozlog == 3.1 08:58:50 INFO - moznetwork == 0.27 08:58:50 INFO - mozprocess == 0.22 08:58:50 INFO - mozprofile == 0.28 08:58:50 INFO - mozrunner == 6.11 08:58:50 INFO - mozscreenshot == 0.1 08:58:50 INFO - mozsystemmonitor == 0.0 08:58:50 INFO - moztest == 0.7 08:58:50 INFO - mozversion == 1.4 08:58:50 INFO - psutil == 3.1.1 08:58:50 INFO - requests == 1.2.3 08:58:50 INFO - wsgiref == 0.1.2 08:58:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:50 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 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:50 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 08:58:50 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 08:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:50 INFO - 'HOME': '/Users/cltbld', 08:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:50 INFO - 'LOGNAME': 'cltbld', 08:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:50 INFO - 'MOZ_NO_REMOTE': '1', 08:58:50 INFO - 'NO_EM_RESTART': '1', 08:58:50 INFO - 'PAGER': '/bin/cat', 08:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:50 INFO - 'PWD': '/builds/slave/test', 08:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:50 INFO - 'SHELL': '/bin/bash', 08:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:50 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:50 INFO - 'USER': 'cltbld', 08:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:50 INFO - 'XPC_FLAGS': '0x0', 08:58:50 INFO - 'XPC_SERVICE_NAME': '0', 08:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 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)) 08:58:50 INFO - Cleaning up... 08:58:50 INFO - Return code: 0 08:58:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:58: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')]} 08:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58: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', 'jsonschema'] in /builds/slave/test/build 08:58: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 jsonschema 08:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:50 INFO - 'HOME': '/Users/cltbld', 08:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:50 INFO - 'LOGNAME': 'cltbld', 08:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:50 INFO - 'MOZ_NO_REMOTE': '1', 08:58:50 INFO - 'NO_EM_RESTART': '1', 08:58:50 INFO - 'PAGER': '/bin/cat', 08:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:50 INFO - 'PWD': '/builds/slave/test', 08:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:50 INFO - 'SHELL': '/bin/bash', 08:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:50 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:50 INFO - 'USER': 'cltbld', 08:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:50 INFO - 'XPC_FLAGS': '0x0', 08:58:50 INFO - 'XPC_SERVICE_NAME': '0', 08:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:50 INFO - Downloading/unpacking jsonschema 08:58:50 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 08:58:50 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 08:58:50 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 08:58:50 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 08:58:50 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 08:58:50 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 08:58:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:58:53 INFO - Downloading/unpacking functools32 (from jsonschema) 08:58:53 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 08:58:53 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 08:58:53 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 08:58:53 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 08:58:53 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 08:58:53 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 08:58:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:58:53 INFO - warning: no files found matching '*.txt' 08:58:53 INFO - no previously-included directories found matching 'build' 08:58:53 INFO - no previously-included directories found matching 'dist' 08:58:53 INFO - no previously-included directories found matching '.git*' 08:58:53 INFO - Installing collected packages: jsonschema, functools32 08:58:53 INFO - Running setup.py install for functools32 08:58:54 INFO - warning: no files found matching '*.txt' 08:58:54 INFO - no previously-included directories found matching 'build' 08:58:54 INFO - no previously-included directories found matching 'dist' 08:58:54 INFO - no previously-included directories found matching '.git*' 08:58:54 INFO - Successfully installed jsonschema functools32 08:58:54 INFO - Cleaning up... 08:58:54 INFO - Return code: 0 08:58:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:58:54 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')]} 08:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:54 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')]} 08:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:54 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 0x1097e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e0d80ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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 08:58:54 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 08:58:54 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 08:58:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:58:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:54 INFO - 'HOME': '/Users/cltbld', 08:58:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:54 INFO - 'LOGNAME': 'cltbld', 08:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:54 INFO - 'MOZ_NO_REMOTE': '1', 08:58:54 INFO - 'NO_EM_RESTART': '1', 08:58:54 INFO - 'PAGER': '/bin/cat', 08:58:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:54 INFO - 'PWD': '/builds/slave/test', 08:58:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:54 INFO - 'SHELL': '/bin/bash', 08:58:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:58:54 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:58:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:54 INFO - 'USER': 'cltbld', 08:58:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:54 INFO - 'XPC_FLAGS': '0x0', 08:58:54 INFO - 'XPC_SERVICE_NAME': '0', 08:58:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:54 INFO - Downloading/unpacking flake8 08:58:54 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 08:58:54 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 08:58:54 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 08:58:54 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 08:58:54 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 08:58:54 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 08:58:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:58:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:58:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:58:58 INFO - no previously-included directories found matching 'docs/_build' 08:58:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:58:58 INFO - Running setup.py install for pep8 08:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:58:58 INFO - no previously-included directories found matching 'docs/_build' 08:58:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:58:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:58:58 INFO - Cleaning up... 08:58:58 INFO - Return code: 0 08:58:58 INFO - Running post-action listener: _resource_record_post_action 08:58:58 INFO - Running post-action listener: _start_resource_monitoring 08:58:58 INFO - Starting resource monitoring. 08:58:58 INFO - ##### 08:58:58 INFO - ##### Running install step. 08:58:58 INFO - ##### 08:58:58 INFO - Running pre-action listener: _resource_record_pre_action 08:58:58 INFO - Running main action method: install 08:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:58:58 INFO - Reading from file tmpfile_stdout 08:58:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:58:58 INFO - Reading from file tmpfile_stdout 08:58:58 INFO - Output received: 08:58:58 INFO - Usage: mozinstall [options] installer 08:58:58 INFO - Options: 08:58:58 INFO - -h, --help show this help message and exit 08:58:58 INFO - -d DEST, --destination=DEST 08:58:58 INFO - Directory to install application into. [default: 08:58:58 INFO - "/builds/slave/test"] 08:58:58 INFO - --app=APP Application being installed. [default: firefox] 08:58:58 INFO - mkdir: /builds/slave/test/build/application 08:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:59:32 INFO - Reading from file tmpfile_stdout 08:59:32 INFO - Output received: 08:59:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:59:32 INFO - Running post-action listener: _resource_record_post_action 08:59:32 INFO - ##### 08:59:32 INFO - ##### Running run-tests step. 08:59:32 INFO - ##### 08:59:32 INFO - Running pre-action listener: _resource_record_pre_action 08:59:32 INFO - Running main action method: run_tests 08:59:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:59:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:59:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:59:32 INFO - 2016-04-11 08:59:32.456 screenresolution[2504:33251] starting screenresolution argv=screenresolution get 08:59:32 INFO - 2016-04-11 08:59:32.459 screenresolution[2504:33251] Display 0: 1600x1200x32@60 08:59:32 INFO - 2016-04-11 08:59:32.465 screenresolution[2505:33254] starting screenresolution argv=screenresolution list 08:59:32 INFO - Available Modes on Display 0 08:59:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:59:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:59:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:59:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:59:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:59:32 INFO - Intel Iris: 08:59:32 INFO - Chipset Model: Intel Iris 08:59:32 INFO - Type: GPU 08:59:32 INFO - Bus: Built-In 08:59:32 INFO - VRAM (Dynamic, Max): 1536 MB 08:59:32 INFO - Vendor: Intel (0x8086) 08:59:32 INFO - Device ID: 0x0a2e 08:59:32 INFO - Revision ID: 0x0009 08:59:32 INFO - Displays: 08:59:32 INFO - Display: 08:59:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:59:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:59:32 INFO - Display Serial Number: 1600x1200 60 08:59:32 INFO - Main Display: Yes 08:59:32 INFO - Mirror: Off 08:59:32 INFO - Online: Yes 08:59:32 INFO - Rotation: Supported 08:59:32 INFO - Return code: 0 08:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:59:32 INFO - Python 2.7.3 08:59:32 INFO - Return code: 0 08:59:32 INFO - grabbing minidump binary from tooltool 08:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:32 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109684e00>, '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 0x1094eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:59:32 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 08:59:32 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 08:59:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:59:32 INFO - Return code: 0 08:59:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:59:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:59:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:59:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:59:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:59:33 INFO - Return code: 0 08:59:33 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/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0200', '--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 08:59:33 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/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0200 --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 08:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xakFnkLRp9/Render', 08:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:33 INFO - 'HOME': '/Users/cltbld', 08:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:33 INFO - 'LOGNAME': 'cltbld', 08:59:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:59:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:33 INFO - 'MOZ_NO_REMOTE': '1', 08:59:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:59:33 INFO - 'NO_EM_RESTART': '1', 08:59:33 INFO - 'PAGER': '/bin/cat', 08:59:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:33 INFO - 'PWD': '/builds/slave/test', 08:59:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:33 INFO - 'SHELL': '/bin/bash', 08:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9bCXqJ7tIn/Listeners', 08:59:33 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 08:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:33 INFO - 'USER': 'cltbld', 08:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:33 INFO - 'XPC_FLAGS': '0x0', 08:59:33 INFO - 'XPC_SERVICE_NAME': '0', 08:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:33 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/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0200', '--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 08:59:34 INFO - mozversion application_buildid: 20160411065021 08:59:34 INFO - mozversion application_changeset: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d 08:59:34 INFO - mozversion application_display_name: Nightly 08:59:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:59:34 INFO - mozversion application_name: Firefox 08:59:34 INFO - mozversion application_remotingname: firefox 08:59:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:59:34 INFO - mozversion application_vendor: Mozilla 08:59:34 INFO - mozversion application_version: 48.0a1 08:59:34 INFO - mozversion platform_buildid: 20160411065021 08:59:34 INFO - mozversion platform_changeset: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d 08:59:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:59:34 INFO - mozversion platform_version: 48.0a1 08:59:34 INFO - using testdate: 1460390374 08:59:34 INFO - actual date: 1460390374 08:59:34 INFO - starting webserver on 'localhost:62801' 08:59:34 INFO - SUITE-START | Running 2 tests 08:59:34 INFO - TEST-START | dromaeo_css 08:59:34 INFO - operating with platform_type : mac_ 08:59:34 INFO - Initialising browser for dromaeo_css test... 08:59:34 INFO - TEST-INFO | started process 2523 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpdKy_2z/profile http://localhost:62801/getInfo.html) 08:59:36 INFO - PROCESS | 2523 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:59:37 INFO - PROCESS | 2523 | __metrics Screen width/height:1600/1200 08:59:37 INFO - PROCESS | 2523 | colorDepth:24 08:59:37 INFO - PROCESS | 2523 | Browser inner width/height: 1024/689 08:59:37 INFO - PROCESS | 2523 | __metrics 08:59:37 ERROR - PROCESS | 2523 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 08:59:37 INFO - TEST-INFO | 2523: exit 0 08:59:37 INFO - Browser initialized. 08:59:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:59:37 INFO - TEST-INFO | started process 2526 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpdKy_2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:49 INFO - PROCESS | 2526 | RSS: Main: 248057856 08:59:49 INFO - PROCESS | 2526 | 09:00:39 INFO - PROCESS | 2526 | 1460390439310 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] 09:02:50 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:62801/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62801/tests/dromaeo/cssquery-ext.html) 09:02:52 INFO - PROCESS | 2526 | RSS: Main: 260165632 09:02:52 INFO - PROCESS | 2526 | 09:05:54 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:62801/tests/dromaeo/cssquery-ext.html (next: http://localhost:62801/tests/dromaeo/cssquery-jquery.html) 09:05:54 INFO - PROCESS | 2526 | RSS: Main: 271785984 09:05:54 INFO - PROCESS | 2526 | 09:08:56 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:62801/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62801/tests/dromaeo/cssquery-mootools.html) 09:08:57 INFO - PROCESS | 2526 | RSS: Main: 273854464 09:08:57 INFO - PROCESS | 2526 | 09:11:58 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:62801/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62801/tests/dromaeo/cssquery-prototype.html) 09:11:59 INFO - PROCESS | 2526 | RSS: Main: 275378176 09:11:59 INFO - PROCESS | 2526 | 09:15:02 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:62801/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62801/tests/dromaeo/cssquery-yui.html) 09:15:02 INFO - PROCESS | 2526 | RSS: Main: 278282240 09:15:02 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:62801/tests/dromaeo/cssquery-yui.html (next: http://localhost:62801/tests/dromaeo/cssquery-dojo.html) 09:18:05 INFO - PROCESS | 2526 | RSS: Main: 279400448 09:18:05 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | __start_tp_report 09:18:05 INFO - PROCESS | 2526 | _x_x_mozilla_page_load 09:18:05 INFO - PROCESS | 2526 | _x_x_mozilla_page_load_details 09:18:05 INFO - PROCESS | 2526 | |i|pagename|runs| 09:18:05 INFO - PROCESS | 2526 | |0;dojo.html;2962.955555666665;3465.3242617689552;3489.59869614994;3505.0185947934588;3525.8893448563686;3514.771539849908;5402.621816472849;5844.824655260339;5870.970645146774;5871.412858714132;5600.887982240363;5773.48038676519;5853.824385268449;5883.85290367741;5921.20063791388;5254.789808407659;5274.7626356814035;5318.760655770499;5333.599980001496;5388.622796404254;5359;5433.945660543383;5441;5455.618106732531;5457.563394928416;4256.510501292345;5103.515166059218;5281.392639846428;5306.177542480922;5373.892522149555;5189.532942035197;5204.583633309327;5228.2941802856885;5232.947670523284;5240.3187585614005;5119.180931051014;5203.687778733288;5203.7398130093725;5233.738313084331;5238.816641417532;5674.347450043257;5728.140778883159;5764.250647415809;5789.2763404574425;5806.390329015477;6231.719572619243;6263.780767673155;6272.56092073555;6343.777967771152;6348.523860710465;6190.41191086846;6224.190855188842;6260.182917687059;6338.397852204033;6343.555951083426;5469.769301907039;5536.7231638418725;5994.340622531518;6023.8192854214885;6075.392460753889;6435.678216089177;6451.806445806634;6460;6476.643784591893;6487.2539657939;6109.4653969264045;6185.165002724664;6257.937420625826;6294.087357333161;6310.4636105930595;6298.244210694746;6337.904931426032;6338.144350512714;6339.144215530844;6366.586171898812;6096.207493025879;6207.193064901534;6222.782202622887;6300.653464059521;6325.209348831396;6163.630182189083;6189.690515474298;6204.565680402418;6270.498360131179;6301.842453938688;4328.5022222444195;5030.673006254655;5033.194688849767;5035.521625445577;5052.57053150479;4494.235979883428;4505.414296141481;4508.661850361236;4519.570640789119;4576.107659006462;5735.971320143372;5861.003629383015;5998.280206375263;6010.579259451796;6028;6215.457278653729;6326.778562750374;6343.904841427382;6346.30190679025;6389.488840892717;5962.5826192167;5997.100434934708;6003.159557661931;6016.299975515027;6026.789062382795;5365.543928766098;5459.69971651555;5513.779448822002;5543.61194716366;5563.972180139073;6415.871682566416;6462;6465.191851018529;6471.5146364022885;6573.737050517926;6186.19579454668;6301.716422761078;6307;6320.462760665211;6329.272133704499;6429.807105786834;6451.741930322734;6471.708773105127;6532.934670653232;6535.869282614416;6203.7828675996125;6281.71732272058;6283.842903927255;6285.214348206474;6301.117843502005;5967.522598192221;6198.907016394848;6303.46420554258;6306.65313407767;6319.24169099711;6138.662373569497;6177.382261773966;6192.535559833121;6257.906131407942;6279.30927597973;6020.518358531394;6213.161223234805;6241.968790156202;6247.3440288769025;6249.500039996698;5963.224780778471;5977.864205800884;6035.382917151424;6043.667598282137;6095.786647467317;6143.788236235041;6228.4705800005695;6235.812925612239;6235.968820156052;6278.497720182466;6108.877822443437;6137;6157.32269450369;6159.106929495288;6190.319064902767 09:18:05 INFO - PROCESS | 2526 | |1;ext.html;506.33164223225344;514.9691018538888;573.925389699339;596.8597379615791;622.3061286665364;36458;36995.260094798155;37092.88721338364;37111.81444092776;37125.44311835324;37428.43857342142;37885.62114378855;38014.23971520568;38098;38163.80918095406;9272.814543709123;9395.436273823558;9428.81142377152;9495.952520237424;9537;9346.01866803986;9401.200897923685;9422.199113075398;9474.66838660647;9501.049895010512;9332.020137885525;9399.060093990614;9451.810963780721;9452.527373631325;9512.904870951306;9423.010583888696;9461.479618620973;9504.762380940463;9508.762280942963;9515.28635352348;9317.161455468973;9351.859722104175;9372.343935924488;9379.343445958786;9524.571394287274;36262.63737362619;36314.63685363139;36460.27079458396;36939.07652308714;36977.630223697684;2489.6887889013874;2977.851107444619;3055.236190952262;3106.8135911845134;3337.9499307510164;24830;25524.23427297184;27234.591481127798;27850.885964561392;28054.71945280562;2682.932926676829;2701.5947607858784;2715.592661100831;2717.565189569659;2735.8358498489956;418301;426750;427498;432700;433941.83029084967;57555.42444575501;58768.41231587715;58809.82380352369;58864.41135588675;59043.114353284735;64787.67606162033;66427.66786166039;66525.66737166283;66739.33260667331;66742;15766.211689415484;15829.445969391247;16014.759778603331;16263.512094636942;16299.59251018734;12222.449989750483;12335.93832030852;12607.369631518388;12750.553730619384;12779.913707334981;18356.908215459105;18524.907375463306;18619.44141675752;18848.905755471136;19028.71456928147;7988.840223195503;8156.143604921516;8166.550839703873;8212.384071194565;8212.794680132925;922.6586163119689;945.1871390604075;1019.6380284998719;1087.836824476319;1090.5910283643634;26375.86812065966;26585.73414265871;29593.964211252503;29687.554686679716;29855.10434686963;1041.4272150317295;1129.7740451909488;1167.9941600292113;1209.9637010889687;1251.9671271201296;15001.549953501413;15042.924785376003;15316.770248446282;15389;15448.691026179413;552994;558791;560002;560732;562493;57772.71113644405;58147;58696;58853;58948.41051589515;1395.2047333020284;1418.3051253751669;1458.2490017640923;1459.1391079263285;1465.0330781684038;28493.572596410657;28659.99690010923;28660.14019579416;29051.709482905746;29173.124806255848;49264.01471970469;49710.25434618556;49828.75085624549;49849;49964.250536241256;538609;540921;542524;545995;546014;24648.507029858945;25050.123245686314;25803.354916127246;25839.612405814303;25907.740922590532;44101.55898440975;44371.556284436745;44671.77664111659;45154;45949;35396;36627;36738.89783306505;37374.626253737115;37449.4382584256;27732;35350.116247094025;36481;36688.63311366852;37464;36651.816740916125;37111.628883710815;37661.623383765815;38173;38401.80799095987;30217.69782302237;31836.681633184297;31909.36181276408;32126.19684507906;32126.83936580302;24039.639405408583;24047.110593412115;24107.638385424583;24208.515829682954;24433.3891652703 09:18:05 INFO - PROCESS | 2526 | |2;jquery.html;364.5716283367043;379.96200379962;392.2273121949758;401.21161916833415;407.76757248368443;18158.546036349082;19306;19606.31377901774;19615.607687846234;19650.606987860236;19459.31892383767;19765.703514447294;19846.40460786175;19860.503487412785;19880.40358789235;5004.349434573519;5693.914591281134;5782.277215348082;6001.979663457223;6600.5049621278595;6445.581037232589;6546.116274302955;6549.345065493437;6549.639769812658;6550.377714117175;5520.944790552104;5899.528037756969;5903.704814759266;5913.113033045035;6479.1901012373455;5820.185174075633;5838.795642152504;5891.88216235675;6711.66441677919;6711.731530738764;5812.854678633025;5899.528037756969;5902.085176797603;5917.408259174092;5926.674032928187;13822.963277754108;19062;19202.75182113158;19902.402927912186;24527.264182074567;2026.009039727213;2130.286354071388;2289.988550057239;2426.575349313863;2454.1778504201116;10086.546105425274;10221.897781022244;10238.89761102387;10824.567017319298;13043.413046412934;1682.6045879218495;1736.2100244388773;1776.1740790532335;1797.7213531902576;1830.1489807239698;81400.37199256041;101596.47605285853;102571;107151.46424267907;111729;11267.605633802941;11530.423478826026;11853.407329633485;11875.643730688093;11876.287422754489;14360.497382591559;14489.565313040626;14689.045212061395;14753.77869331961;14754.926225368805;7439.660861044956;8196;8414.705485307984;8603.225709686158;8654.610542525601;8432;8496.830063398822;8544.359173062045;8589.613467393981;8622.31021518277;4531.68278220528;4556.635469162459;4620.907581848344;4686.95313046872;4692.929606055912;1937.476881242085;1972.6350625134396;1998.3105828489438;2003.4190084875222;2031.3804289691786;881.167296904432;964.6527250189926;999.2555546118043;1007.6473234367912;1066.5200659703164;19253.422397328104;19341.226350946086;19439.611207775764;19614.019299035277;19861.404157875288;919.9540022998823;970.3110791338088;980.9068138526828;990.2028866762325;1035.4770840725537;7636.350910172698;8405.453645513022;9677.37097088687;10279.383237005804;10304.381737095799;605014;611304;619798;624590;627246;111277.33084003747;112465;113549.43225283986;114772;119441.20838187434;924.6347692661361;958.324381311174;961.3991255465335;967.2697113679127;976.9023097690174;13673.931630342182;16736.163191840114;17250.913745431193;17376.652466950844;17541.912290438977;45138.77430612826;45346.63960081203;45449;46051.76974115108;47095;66035;66303;67431.32568674251;67562.66218668876;68096.97854532088;6283.622982621057;7341.522801017917;7728.729494467667;7877.172896845977;8354.540500272544;11354.148438866952;11773.823392649289;12000.519979200733;12154.756904861677;12338.074644401526;8022.398320125897;10320.12278956297;10327.638532651321;10642.361458312525;10803.621873234399;10335.121514671337;10425.582976680847;10431.739206519898;10504;10549.894501055198;7607;10421.791564168523;10526.210534210119;10803.405812680377;10907.945460272647;6216.564840461125;7023.051887995055;7986.081600615771;8056.234657707509;8274.544900030556;7431.628418578941;9326.347155699035;10767.784644307227;10781.083607893417;10855.782884342427 09:18:05 INFO - PROCESS | 2526 | |3;mootools.html;1598.2168737318714;1620.1008440315625;1863.6272745450913;1943.5918457124003;1958.0699167895252;6972.4422046236305;7862;8536.061033286334;8736.868946965793;8757.343199260056;8519.53142577158;8577.31381489481;8642.827143457127;8649;8658.610362533685;2440.8413453125536;2465.186488458813;2468.7407822178684;2470.2465747946867;2470.505898820234;2403.639454081884;2418.455847434322;2433.6227884677905;2455.0793452455327;2460.2004348586693;2090.205721825712;2430.283066495388;2438.5244877248942;2456.201734436306;2485.515324511721;2351;2381.047580967618;2392.3301475586863;2414.396400899775;2427.890744916483;2377.0848223434105;2384.940376490584;2400;2423.2245681381964;2435.232901635979;8710.477371357676;8807.955960220223;8825.249853762438;8832.690855820016;8839.24866386358;5201.219817027439;5351.438098999627;5418.376886658046;5422.9728851355885;5425.050616142199;3072.3240887005045;3465.28961562879;3605.152789094561;3676.963230367689;3682.263547290526;1019.6482213636284;1043.3687618990477;1045.7594753206804;1053.3785066810542;1081.1729027294127;11089.500972456259;11094.278871873303;11201.383923884183;11259.93030662094;11260.94369528147;3816;4679.415073115861;4727.503612120747;4914.213725803854;5130.4356520782685;9957.751056223653;9960.750981225527;9965.302428829913;9966.700998970042;9984.650537231162;5374.516293533601;5375.086235340002;5376.4085950545405;5398.1902714593125;5418.864528386743;4356.281213599784;4781.928271075936;4909.337239472697;4949.183384741549;4950.579200767903;3130.90418353579;3627.854885804591;3896.3181443247317;3913;4002.2995975704716;1213.3387303919385;1296.909216354865;1346.4816045822429;1357.0500649545359;1359.4154513559265;1312.1143228321037;1345.5156143788229;1346.7575836349552;1362.026151301824;1367.6307397002754;7961.681532738741;7962.283394494523;8113.188681131957;8165.63254653542;8189.099199088096;509.1039770004818;514.4700958013252;516.8165301318053;523.3040056724548;536.2412186755774;6167.198264225622;6236.220472440945;6362.968185159045;6380.680965951684;6383.489320854414;10217.795644087077;10530.947345263225;10551.525181366856;10569.524371403306;10700.464976751131;10296.742581435525;10374.066334029974;10397.272190946562;10528.263021588415;10579.788404231873;7969.681212751541;8087.636056377477;8115.229053239933;8146.796330091795;8147.185281471805;6685.76599819004;7760.262775036363;7910.446268761131;7916.287534121726;7927.286544211049;9531.904680953101;9587;9635.903640963501;9663.855042174233;9834.311598188058;8259.876101858357;9800.676908617246;9854.753631159278;9856.5564549594;9961.302708810314;6098.817035488943;6716.429103526255;7322.194558598443;7328.267173282842;7532.736354227576;6833.4191593715095;8124.268815806606;8163.387745918961;8187.099419064018;8188;7207.387372073433;7284;7313.23211062852;7441.55350678961;7491.662875170521;7130.42956563484;7175.964120179366;7244.529105608119;7259.891101633374;7261.4190864729635;7695.6536955836;7803.960980195063;7824.608769561613;7833.608319583884;7852.254035866584;6940.063091482585;6972.58164510131;7007.649617519206;7038.683259253448;7050.801363768274;7064.894026589708;7090.007398964046;7173.0675012248075;7188.137423509213;7223.205447400676 09:18:05 INFO - PROCESS | 2526 | |4;prototype.html;313.91422318608085;317.1895806215121;319.331001551749;327.0613339715018;330.16633001670766;4871.5615594596475;5102.3366962294895;5910.551914780874;6169.938300616993;6197.608080969551;5327.254184414185;5702.629329093616;5878.588498805086;6078.118672792442;6109.266887973449;3623.981880090596;4257.467816522934;4572.382728331682;4616.891945932985;4645.908211570279;3900.4344370066465;4278.7591598436575;4561.817527298904;4565.155446242439;4588.541145885418;3990.840366385341;4039.939400908989;4584.266517357223;4604.3323718060865;4622.306654001893;4398.7580683062415;4598.678092533491;4617.376654151697;4629.004763975761;4632.965407657973;3288.2765791525826;3931.8794143668915;3950.2889479893606;3951.68386529077;3974.4833171687783;4855.368802055746;5333.35999680037;5832.9708351457975;5839.883202335929;5848.181254624356;5228.947710522884;5355.705436201008;5390.703511306877;5392.487713667196;5401.675899446007;4754.453237877654;6331.335209802996;6376.1392212051705;6456.51576131792;6486.545941784077;4381.145676593065;4411.779411029435;4412.889677758049;4431.911361772746;4433.490148632884;5134.973005398898;5903.734331955073;6434.839129021765;6797.218319893226;6883.690233939485;4053.473048503735;4231.249687702956;4482.820687172477;4504.256797628354;4516.932246016247;4539.7049191802425;4549.499555048942;4586.472555656075;4596.1733533877095;4596.747178905125;4679.859604211811;5041.168207245837;5075.264086707407;5343.599230057761;5347.657713928795;6208.317085120633;6478.838029049311;6545.8363540910905;6566.277709451956;6591.868162636721;1259.307380940479;1406.2546850169426;1549.132485807951;1581.8576328130293;1587.1905328282428;915.9908400915906;923.5705396990297;973.522973742875;973.6689525561343;980.2501086668705;5232.712200828915;5458.426865179178;6053.8486537836025;6199.442050215412;6228.968855155786;5207.635465517453;6808.323505307078;6860.931390686129;6889.448844092461;6904.585724856524;5493.862653433696;5929.970350148222;6197.721102550396;6222.12890195373;6286.434220920048;3143.3713257348622;3270.2478429961243;3420.9144771380415;3564.625714300013;3627.8548858045383;6186.3032449079365;6221.844453888599;7153.284671532805;7159.92840071603;7192.748253811092;5527.005139075005;6052.757889684452;6582.769603063965;7007.509474336849;7049;6868.450523958071;7044.859102818017;7045.802213623696;7091;7100.644967751592;5386.461353864583;5498.835034948958;6790.354916282945;6805.6937437816405;6839.62382068991;5703.8859222816145;6519.576227545194;6632.701528431328;6688.2977287386075;6763.222229443677;6441.323661015525;6529;6791.89812152828;7081.4334853210585;7081.858362832611;4092.2633925893624;4259.700791258696;4306.483222013253;4346.826126954887;4375.234333991602;5817.854553636193;6521.684801895449;6607.438367738796;6787.423069039187;6805.251422343439;5869.647821130746;6149.046897730859;6509.283978762238;6544.803655890331;6563.868722625616;5674.2623458950075;5677.432256774455;6225.501959843292;6594.637294948824;6601.900971485527;4970.726610036338;5993.400659933972;6453.741850326122;6460.997090901836;6513.446357059703;5565.526930210977;6083.361247068994;6596.769113081019;6617.536772426077;6623.271440141484;5714.3999880012;6315.684215789284;6469.8706025880165;6517.989711594711;6593.538452308292 09:18:05 INFO - PROCESS | 2526 | |5;yui.html;627.7677259414014;680.1294343240652;695.8817001109811;714.1180641907247;770.2259229474378;14641;14727.92636036821;14808.259587020646;14967.92516037421;16628;16316.673666526662;16401.261943212554;16418.83581164188;16441.588960276;16575.336986520553;915.3683958068945;916.2486760856101;919.5172534419416;923.5843870258377;923.5982347678781;702.5152644675157;890.5814267294394;918.4351623751378;918.5361392496814;921.0283151275402;953.1231267234126;957.8802649668792;965.8454647256441;966.3718582921123;969.9175570076552;834.6661335465801;920.5213289089636;931.5714771205254;956.5934477846956;963.9036096390375;691.9688614012382;710.9964450177768;712.3268511256864;713.3936154268882;714.3784907130829;15553.844461555353;15781.842181578151;15859.52421427359;15876.60308492297;15941.362345506166;11216.383098929555;11759.118066145073;12464.563740269046;12724.872751272462;12789.97680185583;9975.950120249425;10022.596836442905;10075.89924100757;10120.089191972758;10703.1437485001;4021.1756589899;4027.81874815634;4031.23406552754;4163.39630753542;4328.783560821947;66703.66648166729;69250.65374673145;70037;70263;70303;9164.90835091654;9185.173334399937;9365.250779937589;9399;9557.713268601952;20673.793262067185;21048.684269735968;21062.368128955848;21136.682949755766;21255.78744212538;7355.485116041933;7366.116066072105;7429.36850367714;7491.812704682317;7498.962505187439;3432.62637220457;4003.039270575041;4068.613481719232;4107.137501124797;4130.56629053945;3556.342076715816;3601.2257364666198;3653.762505437191;3669.7247706422127;3673.834677439468;646.9293319556048;653.8234676637281;657.6284399314372;659.0476761080193;662.5262937000068;568.6893348418974;575.0827430248746;583.5769067426082;591.1487458060379;611.4496952742478;7727.150013498511;7935.444518883738;7963.323117535075;8041.597920104088;8351.749447516584;560.2017125596091;561.491849875863;572.410417270204;591.0701559408535;597.8804239152187;3483.390406678821;3607.458881167846;3739.2147648993473;3807.58116607173;3819.6944244460933;80390;80623;81651.3669726614;82813.92965175919;83840.58079709562;78647.21352786399;78668;78947.21052789513;79428;80126;66485.6675716628;67243.65512689718;67512.98730518948;69532.652336738;70422.64788676024;7456.067991501062;7459.962700186465;7558.659860306189;7582.090149181913;7717.768466946;29442.558361625022;43036;43326;44071.77964110159;44565;62317;62961.68519157558;63007.6849615749;63060.36939630729;63773;9724.513774311397;9895.455749933535;9953.800923981624;10085.445300508249;10275.691729248134;10752.0323170915;10871.945640271748;11014;11130.443477826238;11192.048675862643;9862.063104005108;10248.590056397661;10256.230782691178;10285.588576456857;10482.889354484807;9565.521723913917;9572.760680982752;10155.492225388849;10430.501374785417;10502.317349372266;8938.68714594986;9089.454632722058;9619.807603847745;9657.034296570288;9674.613015479303;7943.6822527100585;8680.435771674822;8851.513166775632;8978.281737460857;9186;7061.576305421691;8013.719519816778;8101.959490202511;8662.82674346522;8738.475691458532 09:18:05 INFO - PROCESS | 2526 | __end_tp_report 09:18:05 INFO - PROCESS | 2526 | __start_cc_report 09:18:05 INFO - PROCESS | 2526 | _x_x_mozilla_cycle_collect,391 09:18:05 INFO - PROCESS | 2526 | __end_cc_report 09:18:05 INFO - PROCESS | 2526 | __startTimestamp1460391485745__endTimestamp 09:18:05 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | ------- Summary: start ------- 09:18:05 INFO - PROCESS | 2526 | Number of tests: 6 09:18:05 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | [#0] dojo.html Cycles:165 Average:5819.63 Median:6096.21 stddev:694.64 (11.4%) stddev-sans-first:659.63 09:18:05 INFO - PROCESS | 2526 | Values: 2963.0 3465.3 3489.6 3505.0 3525.9 3514.8 5402.6 5844.8 5871.0 5871.4 5600.9 5773.5 5853.8 5883.9 5921.2 5254.8 5274.8 5318.8 5333.6 5388.6 5359.0 5433.9 5441.0 5455.6 5457.6 4256.5 5103.5 5281.4 5306.2 5373.9 5189.5 5204.6 5228.3 5232.9 5240.3 5119.2 5203.7 5203.7 5233.7 5238.8 5674.3 5728.1 5764.3 5789.3 5806.4 6231.7 6263.8 6272.6 6343.8 6348.5 6190.4 6224.2 6260.2 6338.4 6343.6 5469.8 5536.7 5994.3 6023.8 6075.4 6435.7 6451.8 6460.0 6476.6 6487.3 6109.5 6185.2 6257.9 6294.1 6310.5 6298.2 6337.9 6338.1 6339.1 6366.6 6096.2 6207.2 6222.8 6300.7 6325.2 6163.6 6189.7 6204.6 6270.5 6301.8 4328.5 5030.7 5033.2 5035.5 5052.6 4494.2 4505.4 4508.7 4519.6 4576.1 5736.0 5861.0 5998.3 6010.6 6028.0 6215.5 6326.8 6343.9 6346.3 6389.5 5962.6 5997.1 6003.2 6016.3 6026.8 5365.5 5459.7 5513.8 5543.6 5564.0 6415.9 6462.0 6465.2 6471.5 6573.7 6186.2 6301.7 6307.0 6320.5 6329.3 6429.8 6451.7 6471.7 6532.9 6535.9 6203.8 6281.7 6283.8 6285.2 6301.1 5967.5 6198.9 6303.5 6306.7 6319.2 6138.7 6177.4 6192.5 6257.9 6279.3 6020.5 6213.2 6242.0 6247.3 6249.5 5963.2 5977.9 6035.4 6043.7 6095.8 6143.8 6228.5 6235.8 6236.0 6278.5 6108.9 6137.0 6157.3 6159.1 6190.3 09:18:05 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | [#1] ext.html Cycles:180 Average:64470.77 Median:37118.63 stddev:136860.41 (368.7%) stddev-sans-first:137160.07 09:18:05 INFO - PROCESS | 2526 | Values: 506.3 515.0 573.9 596.9 622.3 36458.0 36995.3 37092.9 37111.8 37125.4 37428.4 37885.6 38014.2 38098.0 38163.8 9272.8 9395.4 9428.8 9496.0 9537.0 9346.0 9401.2 9422.2 9474.7 9501.0 9332.0 9399.1 9451.8 9452.5 9512.9 9423.0 9461.5 9504.8 9508.8 9515.3 9317.2 9351.9 9372.3 9379.3 9524.6 36262.6 36314.6 36460.3 36939.1 36977.6 2489.7 2977.9 3055.2 3106.8 3337.9 24830.0 25524.2 27234.6 27850.9 28054.7 2682.9 2701.6 2715.6 2717.6 2735.8 418301.0 426750.0 427498.0 432700.0 433941.8 57555.4 58768.4 58809.8 58864.4 59043.1 64787.7 66427.7 66525.7 66739.3 66742.0 15766.2 15829.4 16014.8 16263.5 16299.6 12222.4 12335.9 12607.4 12750.6 12779.9 18356.9 18524.9 18619.4 18848.9 19028.7 7988.8 8156.1 8166.6 8212.4 8212.8 922.7 945.2 1019.6 1087.8 1090.6 26375.9 26585.7 29594.0 29687.6 29855.1 1041.4 1129.8 1168.0 1210.0 1252.0 15001.5 15042.9 15316.8 15389.0 15448.7 552994.0 558791.0 560002.0 560732.0 562493.0 57772.7 58147.0 58696.0 58853.0 58948.4 1395.2 1418.3 1458.2 1459.1 1465.0 28493.6 28660.0 28660.1 29051.7 29173.1 49264.0 49710.3 49828.8 49849.0 49964.3 538609.0 540921.0 542524.0 545995.0 546014.0 24648.5 25050.1 25803.4 25839.6 25907.7 44101.6 44371.6 44671.8 45154.0 45949.0 35396.0 36627.0 36738.9 37374.6 37449.4 27732.0 35350.1 36481.0 36688.6 37464.0 36651.8 37111.6 37661.6 38173.0 38401.8 30217.7 31836.7 31909.4 32126.2 32126.8 24039.6 24047.1 24107.6 24208.5 24433.4 09:18:05 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | [#2] jquery.html Cycles:180 Average:33747.19 Median:372.27 stddev:102187.93 (27450.2%) stddev-sans-first:102443.85 09:18:05 INFO - PROCESS | 2526 | Values: 364.6 380.0 392.2 401.2 407.8 18158.5 19306.0 19606.3 19615.6 19650.6 19459.3 19765.7 19846.4 19860.5 19880.4 5004.3 5693.9 5782.3 6002.0 6600.5 6445.6 6546.1 6549.3 6549.6 6550.4 5520.9 5899.5 5903.7 5913.1 6479.2 5820.2 5838.8 5891.9 6711.7 6711.7 5812.9 5899.5 5902.1 5917.4 5926.7 13823.0 19062.0 19202.8 19902.4 24527.3 2026.0 2130.3 2290.0 2426.6 2454.2 10086.5 10221.9 10238.9 10824.6 13043.4 1682.6 1736.2 1776.2 1797.7 1830.1 81400.4 101596.5 102571.0 107151.5 111729.0 11267.6 11530.4 11853.4 11875.6 11876.3 14360.5 14489.6 14689.0 14753.8 14754.9 7439.7 8196.0 8414.7 8603.2 8654.6 8432.0 8496.8 8544.4 8589.6 8622.3 4531.7 4556.6 4620.9 4687.0 4692.9 1937.5 1972.6 1998.3 2003.4 2031.4 881.2 964.7 999.3 1007.6 1066.5 19253.4 19341.2 19439.6 19614.0 19861.4 920.0 970.3 980.9 990.2 1035.5 7636.4 8405.5 9677.4 10279.4 10304.4 605014.0 611304.0 619798.0 624590.0 627246.0 111277.3 112465.0 113549.4 114772.0 119441.2 924.6 958.3 961.4 967.3 976.9 13673.9 16736.2 17250.9 17376.7 17541.9 45138.8 45346.6 45449.0 46051.8 47095.0 66035.0 66303.0 67431.3 67562.7 68097.0 6283.6 7341.5 7728.7 7877.2 8354.5 11354.1 11773.8 12000.5 12154.8 12338.1 8022.4 10320.1 10327.6 10642.4 10803.6 10335.1 10425.6 10431.7 10504.0 10549.9 7607.0 10421.8 10526.2 10803.4 10907.9 6216.6 7023.1 7986.1 8056.2 8274.5 7431.6 9326.3 10767.8 10781.1 10855.8 09:18:05 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | [#3] mootools.html Cycles:180 Average:5942.29 Median:5408.28 stddev:3129.47 (57.9%) stddev-sans-first:3121.22 09:18:05 INFO - PROCESS | 2526 | Values: 1598.2 1620.1 1863.6 1943.6 1958.1 6972.4 7862.0 8536.1 8736.9 8757.3 8519.5 8577.3 8642.8 8649.0 8658.6 2440.8 2465.2 2468.7 2470.2 2470.5 2403.6 2418.5 2433.6 2455.1 2460.2 2090.2 2430.3 2438.5 2456.2 2485.5 2351.0 2381.0 2392.3 2414.4 2427.9 2377.1 2384.9 2400.0 2423.2 2435.2 8710.5 8808.0 8825.2 8832.7 8839.2 5201.2 5351.4 5418.4 5423.0 5425.1 3072.3 3465.3 3605.2 3677.0 3682.3 1019.6 1043.4 1045.8 1053.4 1081.2 11089.5 11094.3 11201.4 11259.9 11260.9 3816.0 4679.4 4727.5 4914.2 5130.4 9957.8 9960.8 9965.3 9966.7 9984.7 5374.5 5375.1 5376.4 5398.2 5418.9 4356.3 4781.9 4909.3 4949.2 4950.6 3130.9 3627.9 3896.3 3913.0 4002.3 1213.3 1296.9 1346.5 1357.1 1359.4 1312.1 1345.5 1346.8 1362.0 1367.6 7961.7 7962.3 8113.2 8165.6 8189.1 509.1 514.5 516.8 523.3 536.2 6167.2 6236.2 6363.0 6380.7 6383.5 10217.8 10530.9 10551.5 10569.5 10700.5 10296.7 10374.1 10397.3 10528.3 10579.8 7969.7 8087.6 8115.2 8146.8 8147.2 6685.8 7760.3 7910.4 7916.3 7927.3 9531.9 9587.0 9635.9 9663.9 9834.3 8259.9 9800.7 9854.8 9856.6 9961.3 6098.8 6716.4 7322.2 7328.3 7532.7 6833.4 8124.3 8163.4 8187.1 8188.0 7207.4 7284.0 7313.2 7441.6 7491.7 7130.4 7176.0 7244.5 7259.9 7261.4 7695.7 7804.0 7824.6 7833.6 7852.3 6940.1 6972.6 7007.6 7038.7 7050.8 7064.9 7090.0 7173.1 7188.1 7223.2 09:18:05 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | [#4] prototype.html Cycles:180 Average:5204.66 Median:5766.13 stddev:1651.39 (28.6%) stddev-sans-first:1614.71 09:18:05 INFO - PROCESS | 2526 | Values: 313.9 317.2 319.3 327.1 330.2 4871.6 5102.3 5910.6 6169.9 6197.6 5327.3 5702.6 5878.6 6078.1 6109.3 3624.0 4257.5 4572.4 4616.9 4645.9 3900.4 4278.8 4561.8 4565.2 4588.5 3990.8 4039.9 4584.3 4604.3 4622.3 4398.8 4598.7 4617.4 4629.0 4633.0 3288.3 3931.9 3950.3 3951.7 3974.5 4855.4 5333.4 5833.0 5839.9 5848.2 5228.9 5355.7 5390.7 5392.5 5401.7 4754.5 6331.3 6376.1 6456.5 6486.5 4381.1 4411.8 4412.9 4431.9 4433.5 5135.0 5903.7 6434.8 6797.2 6883.7 4053.5 4231.2 4482.8 4504.3 4516.9 4539.7 4549.5 4586.5 4596.2 4596.7 4679.9 5041.2 5075.3 5343.6 5347.7 6208.3 6478.8 6545.8 6566.3 6591.9 1259.3 1406.3 1549.1 1581.9 1587.2 916.0 923.6 973.5 973.7 980.3 5232.7 5458.4 6053.8 6199.4 6229.0 5207.6 6808.3 6860.9 6889.4 6904.6 5493.9 5930.0 6197.7 6222.1 6286.4 3143.4 3270.2 3420.9 3564.6 3627.9 6186.3 6221.8 7153.3 7159.9 7192.7 5527.0 6052.8 6582.8 7007.5 7049.0 6868.5 7044.9 7045.8 7091.0 7100.6 5386.5 5498.8 6790.4 6805.7 6839.6 5703.9 6519.6 6632.7 6688.3 6763.2 6441.3 6529.0 6791.9 7081.4 7081.9 4092.3 4259.7 4306.5 4346.8 4375.2 5817.9 6521.7 6607.4 6787.4 6805.3 5869.6 6149.0 6509.3 6544.8 6563.9 5674.3 5677.4 6225.5 6594.6 6601.9 4970.7 5993.4 6453.7 6461.0 6513.4 5565.5 6083.4 6596.8 6617.5 6623.3 5714.4 6315.7 6469.9 6518.0 6593.5 09:18:05 INFO - PROCESS | 2526 | 09:18:05 INFO - PROCESS | 2526 | [#5] yui.html Cycles:180 Average:17093.92 Median:66973.66 stddev:23650.17 (35.3%) stddev-sans-first:23684.20 09:18:05 INFO - PROCESS | 2526 | Values: 627.8 680.1 695.9 714.1 770.2 14641.0 14727.9 14808.3 14967.9 16628.0 16316.7 16401.3 16418.8 16441.6 16575.3 915.4 916.2 919.5 923.6 923.6 702.5 890.6 918.4 918.5 921.0 953.1 957.9 965.8 966.4 969.9 834.7 920.5 931.6 956.6 963.9 692.0 711.0 712.3 713.4 714.4 15553.8 15781.8 15859.5 15876.6 15941.4 11216.4 11759.1 12464.6 12724.9 12790.0 9976.0 10022.6 10075.9 10120.1 10703.1 4021.2 4027.8 4031.2 4163.4 4328.8 66703.7 69250.7 70037.0 70263.0 70303.0 9164.9 9185.2 9365.3 9399.0 9557.7 20673.8 21048.7 21062.4 21136.7 21255.8 7355.5 7366.1 7429.4 7491.8 7499.0 3432.6 4003.0 4068.6 4107.1 4130.6 3556.3 3601.2 3653.8 3669.7 3673.8 646.9 653.8 657.6 659.0 662.5 568.7 575.1 583.6 591.1 611.4 7727.2 7935.4 7963.3 8041.6 8351.7 560.2 561.5 572.4 591.1 597.9 3483.4 3607.5 3739.2 3807.6 3819.7 80390.0 80623.0 81651.4 82813.9 83840.6 78647.2 78668.0 78947.2 79428.0 80126.0 66485.7 67243.7 67513.0 69532.7 70422.6 7456.1 7460.0 7558.7 7582.1 7717.8 29442.6 43036.0 43326.0 44071.8 44565.0 62317.0 62961.7 63007.7 63060.4 63773.0 9724.5 9895.5 9953.8 10085.4 10275.7 10752.0 10871.9 11014.0 11130.4 11192.0 9862.1 10248.6 10256.2 10285.6 10482.9 9565.5 9572.8 10155.5 10430.5 10502.3 8938.7 9089.5 9619.8 9657.0 9674.6 7943.7 8680.4 8851.5 8978.3 9186.0 7061.6 8013.7 8102.0 8662.8 8738.5 09:18:05 INFO - PROCESS | 2526 | -------- Summary: end -------- 09:18:05 INFO - PROCESS | 2526 | 09:18:06 INFO - TEST-INFO | 2526: exit 0 09:18:06 INFO - TEST-OK | dromaeo_css | took 1112104ms 09:18:06 INFO - TEST-START | kraken 09:18:06 INFO - operating with platform_type : mac_ 09:18:06 INFO - Initialising browser for kraken test... 09:18:06 INFO - TEST-INFO | started process 2530 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpGHVcAi/profile http://localhost:62801/getInfo.html) 09:18:08 INFO - PROCESS | 2530 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:18:09 INFO - PROCESS | 2530 | __metrics Screen width/height:1600/1200 09:18:09 INFO - PROCESS | 2530 | colorDepth:24 09:18:09 INFO - PROCESS | 2530 | Browser inner width/height: 1024/689 09:18:09 INFO - PROCESS | 2530 | __metrics 09:18:09 ERROR - PROCESS | 2530 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 09:18:10 INFO - TEST-INFO | 2530: exit 0 09:18:10 INFO - Browser initialized. 09:18:10 INFO - Running cycle 1/1 for kraken test... 09:18:10 INFO - TEST-INFO | started process 2533 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpGHVcAi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:21 INFO - PROCESS | 2533 | RSS: Main: 248123392 09:18:21 INFO - PROCESS | 2533 | 09:18:24 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62801/tests/kraken/driver.html?testName=audio-beat-detection) 09:18:25 INFO - PROCESS | 2533 | RSS: Main: 260038656 09:18:25 INFO - PROCESS | 2533 | 09:18:28 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62801/tests/kraken/driver.html?testName=audio-dft) 09:18:29 INFO - PROCESS | 2533 | RSS: Main: 269287424 09:18:29 INFO - PROCESS | 2533 | 09:18:32 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62801/tests/kraken/driver.html?testName=audio-fft) 09:18:33 INFO - PROCESS | 2533 | RSS: Main: 272351232 09:18:33 INFO - PROCESS | 2533 | 09:18:35 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62801/tests/kraken/driver.html?testName=audio-oscillator) 09:18:35 INFO - PROCESS | 2533 | RSS: Main: 274604032 09:18:35 INFO - PROCESS | 2533 | 09:18:37 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62801/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:18:38 INFO - PROCESS | 2533 | RSS: Main: 275296256 09:18:38 INFO - PROCESS | 2533 | 09:18:41 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62801/tests/kraken/driver.html?testName=imaging-darkroom) 09:18:41 INFO - PROCESS | 2533 | RSS: Main: 275238912 09:18:41 INFO - PROCESS | 2533 | 09:18:44 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62801/tests/kraken/driver.html?testName=imaging-desaturate) 09:18:45 INFO - PROCESS | 2533 | RSS: Main: 275369984 09:18:45 INFO - PROCESS | 2533 | 09:18:48 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62801/tests/kraken/driver.html?testName=json-parse-financial) 09:18:49 INFO - PROCESS | 2533 | RSS: Main: 275288064 09:18:49 INFO - PROCESS | 2533 | 09:18:50 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62801/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:18:51 INFO - PROCESS | 2533 | RSS: Main: 275169280 09:18:51 INFO - PROCESS | 2533 | 09:18:53 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62801/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:18:54 INFO - PROCESS | 2533 | RSS: Main: 275079168 09:18:54 INFO - PROCESS | 2533 | 09:18:56 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62801/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:18:56 INFO - PROCESS | 2533 | RSS: Main: 275361792 09:18:56 INFO - PROCESS | 2533 | 09:18:59 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:00 INFO - PROCESS | 2533 | RSS: Main: 275968000 09:19:00 INFO - PROCESS | 2533 | 09:19:03 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:04 INFO - PROCESS | 2533 | RSS: Main: 276283392 09:19:04 INFO - PROCESS | 2533 | 09:19:05 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:62801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62801/tests/kraken/driver.html?testName=ai-astar) 09:19:06 INFO - PROCESS | 2533 | RSS: Main: 277303296 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | __start_tp_report 09:19:06 INFO - PROCESS | 2533 | _x_x_mozilla_page_load 09:19:06 INFO - PROCESS | 2533 | _x_x_mozilla_page_load_details 09:19:06 INFO - PROCESS | 2533 | |i|pagename|runs| 09:19:06 INFO - PROCESS | 2533 | |0;ai-astar;129;161;170;117;117;130;116;117;117;117 09:19:06 INFO - PROCESS | 2533 | |1;audio-beat-detection;163;135;174;209;156;143;122;172;190;155 09:19:06 INFO - PROCESS | 2533 | |2;audio-dft;197;195;211;239;275;226;200;199;209;276 09:19:06 INFO - PROCESS | 2533 | |3;audio-fft;63;86;77;142;57;56;57;61;127;55 09:19:06 INFO - PROCESS | 2533 | |4;audio-oscillator;115;80;126;74;82;81;118;80;81;117 09:19:06 INFO - PROCESS | 2533 | |5;imaging-gaussian-blur;91;87;89;86;90;85;91;89;91;88 09:19:06 INFO - PROCESS | 2533 | |6;imaging-darkroom;114;150;116;95;127;98;92;89;108;108 09:19:06 INFO - PROCESS | 2533 | |7;imaging-desaturate;140;135;91;117;126;124;93;141;161;135 09:19:06 INFO - PROCESS | 2533 | |8;json-parse-financial;58;58;57;58;60;58;58;77;62;58 09:19:06 INFO - PROCESS | 2533 | |9;json-stringify-tinderbox;66;69;73;72;78;76;63;84;88;64 09:19:06 INFO - PROCESS | 2533 | |10;stanford-crypto-aes;81;88;86;87;85;88;87;90;88;87 09:19:06 INFO - PROCESS | 2533 | |11;stanford-crypto-ccm;143;144;168;167;173;143;149;148;241;148 09:19:06 INFO - PROCESS | 2533 | |12;stanford-crypto-pbkdf2;218;178;173;176;175;214;220;193;175;173 09:19:06 INFO - PROCESS | 2533 | |13;stanford-crypto-sha256-iterative;83;97;105;103;76;71;70;67;68;71 09:19:06 INFO - PROCESS | 2533 | __end_tp_report 09:19:06 INFO - PROCESS | 2533 | __start_cc_report 09:19:06 INFO - PROCESS | 2533 | _x_x_mozilla_cycle_collect,1002 09:19:06 INFO - PROCESS | 2533 | __end_cc_report 09:19:06 INFO - PROCESS | 2533 | __startTimestamp1460391546145__endTimestamp 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | ------- Summary: start ------- 09:19:06 INFO - PROCESS | 2533 | Number of tests: 14 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#0] ai-astar Cycles:10 Average:129.10 Median:123.00 stddev:19.99 (16.2%) stddev-sans-first:21.20 09:19:06 INFO - PROCESS | 2533 | Values: 129.0 161.0 170.0 117.0 117.0 130.0 116.0 117.0 117.0 117.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#1] audio-beat-detection Cycles:10 Average:161.90 Median:167.50 stddev:25.85 (15.4%) stddev-sans-first:27.41 09:19:06 INFO - PROCESS | 2533 | Values: 163.0 135.0 174.0 209.0 156.0 143.0 122.0 172.0 190.0 155.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#2] audio-dft Cycles:10 Average:222.70 Median:218.50 stddev:31.06 (14.2%) stddev-sans-first:31.52 09:19:06 INFO - PROCESS | 2533 | Values: 197.0 195.0 211.0 239.0 275.0 226.0 200.0 199.0 209.0 276.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#3] audio-fft Cycles:10 Average:78.10 Median:59.00 stddev:31.57 (53.5%) stddev-sans-first:33.01 09:19:06 INFO - PROCESS | 2533 | Values: 63.0 86.0 77.0 142.0 57.0 56.0 57.0 61.0 127.0 55.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:80.00 stddev:20.61 (25.8%) stddev-sans-first:20.61 09:19:06 INFO - PROCESS | 2533 | Values: 115.0 80.0 126.0 74.0 82.0 81.0 118.0 80.0 81.0 117.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.50 stddev:2.16 (2.4%) stddev-sans-first:2.13 09:19:06 INFO - PROCESS | 2533 | Values: 91.0 87.0 89.0 86.0 90.0 85.0 91.0 89.0 91.0 88.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#6] imaging-darkroom Cycles:10 Average:109.70 Median:119.50 stddev:18.51 (15.5%) stddev-sans-first:19.56 09:19:06 INFO - PROCESS | 2533 | Values: 114.0 150.0 116.0 95.0 127.0 98.0 92.0 89.0 108.0 108.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#7] imaging-desaturate Cycles:10 Average:126.30 Median:140.50 stddev:21.62 (15.4%) stddev-sans-first:22.35 09:19:06 INFO - PROCESS | 2533 | Values: 140.0 135.0 91.0 117.0 126.0 124.0 93.0 141.0 161.0 135.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:58.00 stddev:6.00 (10.4%) stddev-sans-first:6.30 09:19:06 INFO - PROCESS | 2533 | Values: 58.0 58.0 57.0 58.0 60.0 58.0 58.0 77.0 62.0 58.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:74.50 stddev:8.34 (11.2%) stddev-sans-first:8.42 09:19:06 INFO - PROCESS | 2533 | Values: 66.0 69.0 73.0 72.0 78.0 76.0 63.0 84.0 88.0 64.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:2.41 (2.7%) stddev-sans-first:1.41 09:19:06 INFO - PROCESS | 2533 | Values: 81.0 88.0 86.0 87.0 85.0 88.0 87.0 90.0 88.0 87.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:158.00 stddev:29.87 (18.9%) stddev-sans-first:30.84 09:19:06 INFO - PROCESS | 2533 | Values: 143.0 144.0 168.0 167.0 173.0 143.0 149.0 148.0 241.0 148.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.50 Median:185.50 stddev:20.10 (10.8%) stddev-sans-first:18.48 09:19:06 INFO - PROCESS | 2533 | Values: 218.0 178.0 173.0 176.0 175.0 214.0 220.0 193.0 175.0 173.0 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - PROCESS | 2533 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.10 Median:71.00 stddev:15.02 (21.2%) stddev-sans-first:15.92 09:19:06 INFO - PROCESS | 2533 | Values: 83.0 97.0 105.0 103.0 76.0 71.0 70.0 67.0 68.0 71.0 09:19:06 INFO - PROCESS | 2533 | -------- Summary: end -------- 09:19:06 INFO - PROCESS | 2533 | 09:19:06 INFO - TEST-INFO | 2533: exit 0 09:19:06 INFO - TEST-OK | kraken | took 60622ms 09:19:06 INFO - SUITE-END | took 1172s 09:19:07 INFO - Completed test suite (00:19:33) 09:19:07 INFO - javascript benchmark 09:19:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2962.955555666665, 3465.3242617689552, 3489.59869614994, 3505.0185947934588, 3525.8893448563686, 3514.771539849908, 5402.621816472849, 5844.824655260339, 5870.970645146774, 5871.412858714132, 5600.887982240363, 5773.48038676519, 5853.824385268449, 5883.85290367741, 5921.20063791388, 5254.789808407659, 5274.7626356814035, 5318.760655770499, 5333.599980001496, 5388.622796404254, 5359.0, 5433.945660543383, 5441.0, 5455.618106732531, 5457.563394928416, 4256.510501292345, 5103.515166059218, 5281.392639846428, 5306.177542480922, 5373.892522149555, 5189.532942035197, 5204.583633309327, 5228.2941802856885, 5232.947670523284, 5240.3187585614005, 5119.180931051014, 5203.687778733288, 5203.7398130093725, 5233.738313084331, 5238.816641417532, 5674.347450043257, 5728.140778883159, 5764.250647415809, 5789.2763404574425, 5806.390329015477, 6231.719572619243, 6263.780767673155, 6272.56092073555, 6343.777967771152, 6348.523860710465, 6190.41191086846, 6224.190855188842, 6260.182917687059, 6338.397852204033, 6343.555951083426, 5469.769301907039, 5536.7231638418725, 5994.340622531518, 6023.8192854214885, 6075.392460753889, 6435.678216089177, 6451.806445806634, 6460.0, 6476.643784591893, 6487.2539657939, 6109.4653969264045, 6185.165002724664, 6257.937420625826, 6294.087357333161, 6310.4636105930595, 6298.244210694746, 6337.904931426032, 6338.144350512714, 6339.144215530844, 6366.586171898812, 6096.207493025879, 6207.193064901534, 6222.782202622887, 6300.653464059521, 6325.209348831396, 6163.630182189083, 6189.690515474298, 6204.565680402418, 6270.498360131179, 6301.842453938688, 4328.5022222444195, 5030.673006254655, 5033.194688849767, 5035.521625445577, 5052.57053150479, 4494.235979883428, 4505.414296141481, 4508.661850361236, 4519.570640789119, 4576.107659006462, 5735.971320143372, 5861.003629383015, 5998.280206375263, 6010.579259451796, 6028.0, 6215.457278653729, 6326.778562750374, 6343.904841427382, 6346.30190679025, 6389.488840892717, 5962.5826192167, 5997.100434934708, 6003.159557661931, 6016.299975515027, 6026.789062382795, 5365.543928766098, 5459.69971651555, 5513.779448822002, 5543.61194716366, 5563.972180139073, 6415.871682566416, 6462.0, 6465.191851018529, 6471.5146364022885, 6573.737050517926, 6186.19579454668, 6301.716422761078, 6307.0, 6320.462760665211, 6329.272133704499, 6429.807105786834, 6451.741930322734, 6471.708773105127, 6532.934670653232, 6535.869282614416, 6203.7828675996125, 6281.71732272058, 6283.842903927255, 6285.214348206474, 6301.117843502005, 5967.522598192221, 6198.907016394848, 6303.46420554258, 6306.65313407767, 6319.24169099711, 6138.662373569497, 6177.382261773966, 6192.535559833121, 6257.906131407942, 6279.30927597973, 6020.518358531394, 6213.161223234805, 6241.968790156202, 6247.3440288769025, 6249.500039996698, 5963.224780778471, 5977.864205800884, 6035.382917151424, 6043.667598282137, 6095.786647467317, 6143.788236235041, 6228.4705800005695, 6235.812925612239, 6235.968820156052, 6278.497720182466, 6108.877822443437, 6137.0, 6157.32269450369, 6159.106929495288, 6190.319064902767], "value": 5774.789588581933, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.33164223225344, 514.9691018538888, 573.925389699339, 596.8597379615791, 622.3061286665364, 36458.0, 36995.260094798155, 37092.88721338364, 37111.81444092776, 37125.44311835324, 37428.43857342142, 37885.62114378855, 38014.23971520568, 38098.0, 38163.80918095406, 9272.814543709123, 9395.436273823558, 9428.81142377152, 9495.952520237424, 9537.0, 9346.01866803986, 9401.200897923685, 9422.199113075398, 9474.66838660647, 9501.049895010512, 9332.020137885525, 9399.060093990614, 9451.810963780721, 9452.527373631325, 9512.904870951306, 9423.010583888696, 9461.479618620973, 9504.762380940463, 9508.762280942963, 9515.28635352348, 9317.161455468973, 9351.859722104175, 9372.343935924488, 9379.343445958786, 9524.571394287274, 36262.63737362619, 36314.63685363139, 36460.27079458396, 36939.07652308714, 36977.630223697684, 2489.6887889013874, 2977.851107444619, 3055.236190952262, 3106.8135911845134, 3337.9499307510164, 24830.0, 25524.23427297184, 27234.591481127798, 27850.885964561392, 28054.71945280562, 2682.932926676829, 2701.5947607858784, 2715.592661100831, 2717.565189569659, 2735.8358498489956, 418301.0, 426750.0, 427498.0, 432700.0, 433941.83029084967, 57555.42444575501, 58768.41231587715, 58809.82380352369, 58864.41135588675, 59043.114353284735, 64787.67606162033, 66427.66786166039, 66525.66737166283, 66739.33260667331, 66742.0, 15766.211689415484, 15829.445969391247, 16014.759778603331, 16263.512094636942, 16299.59251018734, 12222.449989750483, 12335.93832030852, 12607.369631518388, 12750.553730619384, 12779.913707334981, 18356.908215459105, 18524.907375463306, 18619.44141675752, 18848.905755471136, 19028.71456928147, 7988.840223195503, 8156.143604921516, 8166.550839703873, 8212.384071194565, 8212.794680132925, 922.6586163119689, 945.1871390604075, 1019.6380284998719, 1087.836824476319, 1090.5910283643634, 26375.86812065966, 26585.73414265871, 29593.964211252503, 29687.554686679716, 29855.10434686963, 1041.4272150317295, 1129.7740451909488, 1167.9941600292113, 1209.9637010889687, 1251.9671271201296, 15001.549953501413, 15042.924785376003, 15316.770248446282, 15389.0, 15448.691026179413, 552994.0, 558791.0, 560002.0, 560732.0, 562493.0, 57772.71113644405, 58147.0, 58696.0, 58853.0, 58948.41051589515, 1395.2047333020284, 1418.3051253751669, 1458.2490017640923, 1459.1391079263285, 1465.0330781684038, 28493.572596410657, 28659.99690010923, 28660.14019579416, 29051.709482905746, 29173.124806255848, 49264.01471970469, 49710.25434618556, 49828.75085624549, 49849.0, 49964.250536241256, 538609.0, 540921.0, 542524.0, 545995.0, 546014.0, 24648.507029858945, 25050.123245686314, 25803.354916127246, 25839.612405814303, 25907.740922590532, 44101.55898440975, 44371.556284436745, 44671.77664111659, 45154.0, 45949.0, 35396.0, 36627.0, 36738.89783306505, 37374.626253737115, 37449.4382584256, 27732.0, 35350.116247094025, 36481.0, 36688.63311366852, 37464.0, 36651.816740916125, 37111.628883710815, 37661.623383765815, 38173.0, 38401.80799095987, 30217.69782302237, 31836.681633184297, 31909.36181276408, 32126.19684507906, 32126.83936580302, 24039.639405408583, 24047.110593412115, 24107.638385424583, 24208.515829682954, 24433.3891652703], "value": 19286.229177480614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.5716283367043, 379.96200379962, 392.2273121949758, 401.21161916833415, 407.76757248368443, 18158.546036349082, 19306.0, 19606.31377901774, 19615.607687846234, 19650.606987860236, 19459.31892383767, 19765.703514447294, 19846.40460786175, 19860.503487412785, 19880.40358789235, 5004.349434573519, 5693.914591281134, 5782.277215348082, 6001.979663457223, 6600.5049621278595, 6445.581037232589, 6546.116274302955, 6549.345065493437, 6549.639769812658, 6550.377714117175, 5520.944790552104, 5899.528037756969, 5903.704814759266, 5913.113033045035, 6479.1901012373455, 5820.185174075633, 5838.795642152504, 5891.88216235675, 6711.66441677919, 6711.731530738764, 5812.854678633025, 5899.528037756969, 5902.085176797603, 5917.408259174092, 5926.674032928187, 13822.963277754108, 19062.0, 19202.75182113158, 19902.402927912186, 24527.264182074567, 2026.009039727213, 2130.286354071388, 2289.988550057239, 2426.575349313863, 2454.1778504201116, 10086.546105425274, 10221.897781022244, 10238.89761102387, 10824.567017319298, 13043.413046412934, 1682.6045879218495, 1736.2100244388773, 1776.1740790532335, 1797.7213531902576, 1830.1489807239698, 81400.37199256041, 101596.47605285853, 102571.0, 107151.46424267907, 111729.0, 11267.605633802941, 11530.423478826026, 11853.407329633485, 11875.643730688093, 11876.287422754489, 14360.497382591559, 14489.565313040626, 14689.045212061395, 14753.77869331961, 14754.926225368805, 7439.660861044956, 8196.0, 8414.705485307984, 8603.225709686158, 8654.610542525601, 8432.0, 8496.830063398822, 8544.359173062045, 8589.613467393981, 8622.31021518277, 4531.68278220528, 4556.635469162459, 4620.907581848344, 4686.95313046872, 4692.929606055912, 1937.476881242085, 1972.6350625134396, 1998.3105828489438, 2003.4190084875222, 2031.3804289691786, 881.167296904432, 964.6527250189926, 999.2555546118043, 1007.6473234367912, 1066.5200659703164, 19253.422397328104, 19341.226350946086, 19439.611207775764, 19614.019299035277, 19861.404157875288, 919.9540022998823, 970.3110791338088, 980.9068138526828, 990.2028866762325, 1035.4770840725537, 7636.350910172698, 8405.453645513022, 9677.37097088687, 10279.383237005804, 10304.381737095799, 605014.0, 611304.0, 619798.0, 624590.0, 627246.0, 111277.33084003747, 112465.0, 113549.43225283986, 114772.0, 119441.20838187434, 924.6347692661361, 958.324381311174, 961.3991255465335, 967.2697113679127, 976.9023097690174, 13673.931630342182, 16736.163191840114, 17250.913745431193, 17376.652466950844, 17541.912290438977, 45138.77430612826, 45346.63960081203, 45449.0, 46051.76974115108, 47095.0, 66035.0, 66303.0, 67431.32568674251, 67562.66218668876, 68096.97854532088, 6283.622982621057, 7341.522801017917, 7728.729494467667, 7877.172896845977, 8354.540500272544, 11354.148438866952, 11773.823392649289, 12000.519979200733, 12154.756904861677, 12338.074644401526, 8022.398320125897, 10320.12278956297, 10327.638532651321, 10642.361458312525, 10803.621873234399, 10335.121514671337, 10425.582976680847, 10431.739206519898, 10504.0, 10549.894501055198, 7607.0, 10421.791564168523, 10526.210534210119, 10803.405812680377, 10907.945460272647, 6216.564840461125, 7023.051887995055, 7986.081600615771, 8056.234657707509, 8274.544900030556, 7431.628418578941, 9326.347155699035, 10767.784644307227, 10781.083607893417, 10855.782884342427], "value": 9190.380522515048, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1598.2168737318714, 1620.1008440315625, 1863.6272745450913, 1943.5918457124003, 1958.0699167895252, 6972.4422046236305, 7862.0, 8536.061033286334, 8736.868946965793, 8757.343199260056, 8519.53142577158, 8577.31381489481, 8642.827143457127, 8649.0, 8658.610362533685, 2440.8413453125536, 2465.186488458813, 2468.7407822178684, 2470.2465747946867, 2470.505898820234, 2403.639454081884, 2418.455847434322, 2433.6227884677905, 2455.0793452455327, 2460.2004348586693, 2090.205721825712, 2430.283066495388, 2438.5244877248942, 2456.201734436306, 2485.515324511721, 2351.0, 2381.047580967618, 2392.3301475586863, 2414.396400899775, 2427.890744916483, 2377.0848223434105, 2384.940376490584, 2400.0, 2423.2245681381964, 2435.232901635979, 8710.477371357676, 8807.955960220223, 8825.249853762438, 8832.690855820016, 8839.24866386358, 5201.219817027439, 5351.438098999627, 5418.376886658046, 5422.9728851355885, 5425.050616142199, 3072.3240887005045, 3465.28961562879, 3605.152789094561, 3676.963230367689, 3682.263547290526, 1019.6482213636284, 1043.3687618990477, 1045.7594753206804, 1053.3785066810542, 1081.1729027294127, 11089.500972456259, 11094.278871873303, 11201.383923884183, 11259.93030662094, 11260.94369528147, 3816.0, 4679.415073115861, 4727.503612120747, 4914.213725803854, 5130.4356520782685, 9957.751056223653, 9960.750981225527, 9965.302428829913, 9966.700998970042, 9984.650537231162, 5374.516293533601, 5375.086235340002, 5376.4085950545405, 5398.1902714593125, 5418.864528386743, 4356.281213599784, 4781.928271075936, 4909.337239472697, 4949.183384741549, 4950.579200767903, 3130.90418353579, 3627.854885804591, 3896.3181443247317, 3913.0, 4002.2995975704716, 1213.3387303919385, 1296.909216354865, 1346.4816045822429, 1357.0500649545359, 1359.4154513559265, 1312.1143228321037, 1345.5156143788229, 1346.7575836349552, 1362.026151301824, 1367.6307397002754, 7961.681532738741, 7962.283394494523, 8113.188681131957, 8165.63254653542, 8189.099199088096, 509.1039770004818, 514.4700958013252, 516.8165301318053, 523.3040056724548, 536.2412186755774, 6167.198264225622, 6236.220472440945, 6362.968185159045, 6380.680965951684, 6383.489320854414, 10217.795644087077, 10530.947345263225, 10551.525181366856, 10569.524371403306, 10700.464976751131, 10296.742581435525, 10374.066334029974, 10397.272190946562, 10528.263021588415, 10579.788404231873, 7969.681212751541, 8087.636056377477, 8115.229053239933, 8146.796330091795, 8147.185281471805, 6685.76599819004, 7760.262775036363, 7910.446268761131, 7916.287534121726, 7927.286544211049, 9531.904680953101, 9587.0, 9635.903640963501, 9663.855042174233, 9834.311598188058, 8259.876101858357, 9800.676908617246, 9854.753631159278, 9856.5564549594, 9961.302708810314, 6098.817035488943, 6716.429103526255, 7322.194558598443, 7328.267173282842, 7532.736354227576, 6833.4191593715095, 8124.268815806606, 8163.387745918961, 8187.099419064018, 8188.0, 7207.387372073433, 7284.0, 7313.23211062852, 7441.55350678961, 7491.662875170521, 7130.42956563484, 7175.964120179366, 7244.529105608119, 7259.891101633374, 7261.4190864729635, 7695.6536955836, 7803.960980195063, 7824.608769561613, 7833.608319583884, 7852.254035866584, 6940.063091482585, 6972.58164510131, 7007.649617519206, 7038.683259253448, 7050.801363768274, 7064.894026589708, 7090.007398964046, 7173.0675012248075, 7188.137423509213, 7223.205447400676], "value": 4785.892414605675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.91422318608085, 317.1895806215121, 319.331001551749, 327.0613339715018, 330.16633001670766, 4871.5615594596475, 5102.3366962294895, 5910.551914780874, 6169.938300616993, 6197.608080969551, 5327.254184414185, 5702.629329093616, 5878.588498805086, 6078.118672792442, 6109.266887973449, 3623.981880090596, 4257.467816522934, 4572.382728331682, 4616.891945932985, 4645.908211570279, 3900.4344370066465, 4278.7591598436575, 4561.817527298904, 4565.155446242439, 4588.541145885418, 3990.840366385341, 4039.939400908989, 4584.266517357223, 4604.3323718060865, 4622.306654001893, 4398.7580683062415, 4598.678092533491, 4617.376654151697, 4629.004763975761, 4632.965407657973, 3288.2765791525826, 3931.8794143668915, 3950.2889479893606, 3951.68386529077, 3974.4833171687783, 4855.368802055746, 5333.35999680037, 5832.9708351457975, 5839.883202335929, 5848.181254624356, 5228.947710522884, 5355.705436201008, 5390.703511306877, 5392.487713667196, 5401.675899446007, 4754.453237877654, 6331.335209802996, 6376.1392212051705, 6456.51576131792, 6486.545941784077, 4381.145676593065, 4411.779411029435, 4412.889677758049, 4431.911361772746, 4433.490148632884, 5134.973005398898, 5903.734331955073, 6434.839129021765, 6797.218319893226, 6883.690233939485, 4053.473048503735, 4231.249687702956, 4482.820687172477, 4504.256797628354, 4516.932246016247, 4539.7049191802425, 4549.499555048942, 4586.472555656075, 4596.1733533877095, 4596.747178905125, 4679.859604211811, 5041.168207245837, 5075.264086707407, 5343.599230057761, 5347.657713928795, 6208.317085120633, 6478.838029049311, 6545.8363540910905, 6566.277709451956, 6591.868162636721, 1259.307380940479, 1406.2546850169426, 1549.132485807951, 1581.8576328130293, 1587.1905328282428, 915.9908400915906, 923.5705396990297, 973.522973742875, 973.6689525561343, 980.2501086668705, 5232.712200828915, 5458.426865179178, 6053.8486537836025, 6199.442050215412, 6228.968855155786, 5207.635465517453, 6808.323505307078, 6860.931390686129, 6889.448844092461, 6904.585724856524, 5493.862653433696, 5929.970350148222, 6197.721102550396, 6222.12890195373, 6286.434220920048, 3143.3713257348622, 3270.2478429961243, 3420.9144771380415, 3564.625714300013, 3627.8548858045383, 6186.3032449079365, 6221.844453888599, 7153.284671532805, 7159.92840071603, 7192.748253811092, 5527.005139075005, 6052.757889684452, 6582.769603063965, 7007.509474336849, 7049.0, 6868.450523958071, 7044.859102818017, 7045.802213623696, 7091.0, 7100.644967751592, 5386.461353864583, 5498.835034948958, 6790.354916282945, 6805.6937437816405, 6839.62382068991, 5703.8859222816145, 6519.576227545194, 6632.701528431328, 6688.2977287386075, 6763.222229443677, 6441.323661015525, 6529.0, 6791.89812152828, 7081.4334853210585, 7081.858362832611, 4092.2633925893624, 4259.700791258696, 4306.483222013253, 4346.826126954887, 4375.234333991602, 5817.854553636193, 6521.684801895449, 6607.438367738796, 6787.423069039187, 6805.251422343439, 5869.647821130746, 6149.046897730859, 6509.283978762238, 6544.803655890331, 6563.868722625616, 5674.2623458950075, 5677.432256774455, 6225.501959843292, 6594.637294948824, 6601.900971485527, 4970.726610036338, 5993.400659933972, 6453.741850326122, 6460.997090901836, 6513.446357059703, 5565.526930210977, 6083.361247068994, 6596.769113081019, 6617.536772426077, 6623.271440141484, 5714.3999880012, 6315.684215789284, 6469.8706025880165, 6517.989711594711, 6593.538452308292], "value": 4667.9543769950305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.7677259414014, 680.1294343240652, 695.8817001109811, 714.1180641907247, 770.2259229474378, 14641.0, 14727.92636036821, 14808.259587020646, 14967.92516037421, 16628.0, 16316.673666526662, 16401.261943212554, 16418.83581164188, 16441.588960276, 16575.336986520553, 915.3683958068945, 916.2486760856101, 919.5172534419416, 923.5843870258377, 923.5982347678781, 702.5152644675157, 890.5814267294394, 918.4351623751378, 918.5361392496814, 921.0283151275402, 953.1231267234126, 957.8802649668792, 965.8454647256441, 966.3718582921123, 969.9175570076552, 834.6661335465801, 920.5213289089636, 931.5714771205254, 956.5934477846956, 963.9036096390375, 691.9688614012382, 710.9964450177768, 712.3268511256864, 713.3936154268882, 714.3784907130829, 15553.844461555353, 15781.842181578151, 15859.52421427359, 15876.60308492297, 15941.362345506166, 11216.383098929555, 11759.118066145073, 12464.563740269046, 12724.872751272462, 12789.97680185583, 9975.950120249425, 10022.596836442905, 10075.89924100757, 10120.089191972758, 10703.1437485001, 4021.1756589899, 4027.81874815634, 4031.23406552754, 4163.39630753542, 4328.783560821947, 66703.66648166729, 69250.65374673145, 70037.0, 70263.0, 70303.0, 9164.90835091654, 9185.173334399937, 9365.250779937589, 9399.0, 9557.713268601952, 20673.793262067185, 21048.684269735968, 21062.368128955848, 21136.682949755766, 21255.78744212538, 7355.485116041933, 7366.116066072105, 7429.36850367714, 7491.812704682317, 7498.962505187439, 3432.62637220457, 4003.039270575041, 4068.613481719232, 4107.137501124797, 4130.56629053945, 3556.342076715816, 3601.2257364666198, 3653.762505437191, 3669.7247706422127, 3673.834677439468, 646.9293319556048, 653.8234676637281, 657.6284399314372, 659.0476761080193, 662.5262937000068, 568.6893348418974, 575.0827430248746, 583.5769067426082, 591.1487458060379, 611.4496952742478, 7727.150013498511, 7935.444518883738, 7963.323117535075, 8041.597920104088, 8351.749447516584, 560.2017125596091, 561.491849875863, 572.410417270204, 591.0701559408535, 597.8804239152187, 3483.390406678821, 3607.458881167846, 3739.2147648993473, 3807.58116607173, 3819.6944244460933, 80390.0, 80623.0, 81651.3669726614, 82813.92965175919, 83840.58079709562, 78647.21352786399, 78668.0, 78947.21052789513, 79428.0, 80126.0, 66485.6675716628, 67243.65512689718, 67512.98730518948, 69532.652336738, 70422.64788676024, 7456.067991501062, 7459.962700186465, 7558.659860306189, 7582.090149181913, 7717.768466946, 29442.558361625022, 43036.0, 43326.0, 44071.77964110159, 44565.0, 62317.0, 62961.68519157558, 63007.6849615749, 63060.36939630729, 63773.0, 9724.513774311397, 9895.455749933535, 9953.800923981624, 10085.445300508249, 10275.691729248134, 10752.0323170915, 10871.945640271748, 11014.0, 11130.443477826238, 11192.048675862643, 9862.063104005108, 10248.590056397661, 10256.230782691178, 10285.588576456857, 10482.889354484807, 9565.521723913917, 9572.760680982752, 10155.492225388849, 10430.501374785417, 10502.317349372266, 8938.68714594986, 9089.454632722058, 9619.807603847745, 9657.034296570288, 9674.613015479303, 7943.6822527100585, 8680.435771674822, 8851.513166775632, 8978.281737460857, 9186.0, 7061.576305421691, 8013.719519816778, 8101.959490202511, 8662.82674346522, 8738.475691458532], "value": 6657.891003532896, "unit": "score"}], "name": "dromaeo_css", "value": 7307.409256417723, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 161.0, 170.0, 117.0, 117.0, 130.0, 116.0, 117.0, 117.0, 117.0], "value": 129.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 135.0, 174.0, 209.0, 156.0, 143.0, 122.0, 172.0, 190.0, 155.0], "value": 161.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 195.0, 211.0, 239.0, 275.0, 226.0, 200.0, 199.0, 209.0, 276.0], "value": 222.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 86.0, 77.0, 142.0, 57.0, 56.0, 57.0, 61.0, 127.0, 55.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 80.0, 126.0, 74.0, 82.0, 81.0, 118.0, 80.0, 81.0, 117.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 89.0, 86.0, 90.0, 85.0, 91.0, 89.0, 91.0, 88.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 150.0, 116.0, 95.0, 127.0, 98.0, 92.0, 89.0, 108.0, 108.0], "value": 109.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 91.0, 117.0, 126.0, 124.0, 93.0, 141.0, 161.0, 135.0], "value": 126.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 60.0, 58.0, 58.0, 77.0, 62.0, 58.0], "value": 60.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 73.0, 72.0, 78.0, 76.0, 63.0, 84.0, 88.0, 64.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 86.0, 87.0, 85.0, 88.0, 87.0, 90.0, 88.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 168.0, 167.0, 173.0, 143.0, 149.0, 148.0, 241.0, 148.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [218.0, 178.0, 173.0, 176.0, 175.0, 214.0, 220.0, 193.0, 175.0, 173.0], "value": 189.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 97.0, 105.0, 103.0, 76.0, 71.0, 70.0, 67.0, 68.0, 71.0], "value": 81.1, "unit": "score"}], "name": "kraken", "value": 1665.3000000000002, "alertThreshold": 2.0}]} 09:19:07 INFO - Return code: 0 09:19:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:19:07 ERROR - # TBPL SUCCESS # 09:19:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:19:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:19:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:19:07 INFO - 2016-04-11 09:19:07.491 screenresolution[2538:35672] starting screenresolution argv=screenresolution get 09:19:07 INFO - 2016-04-11 09:19:07.494 screenresolution[2538:35672] Display 0: 1600x1200x32@60 09:19:07 INFO - 2016-04-11 09:19:07.500 screenresolution[2539:35675] starting screenresolution argv=screenresolution list 09:19:07 INFO - Available Modes on Display 0 09:19:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:19:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:19:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:19:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:19:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:19:07 INFO - Intel Iris: 09:19:07 INFO - Chipset Model: Intel Iris 09:19:07 INFO - Type: GPU 09:19:07 INFO - Bus: Built-In 09:19:07 INFO - VRAM (Dynamic, Max): 1536 MB 09:19:07 INFO - Vendor: Intel (0x8086) 09:19:07 INFO - Device ID: 0x0a2e 09:19:07 INFO - Revision ID: 0x0009 09:19:07 INFO - Displays: 09:19:07 INFO - Display: 09:19:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:19:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:19:07 INFO - Display Serial Number: 1600x1200 60 09:19:07 INFO - Main Display: Yes 09:19:07 INFO - Mirror: Off 09:19:07 INFO - Online: Yes 09:19:07 INFO - Rotation: Supported 09:19:07 INFO - Return code: 0 09:19:07 INFO - Running post-action listener: _resource_record_post_action 09:19:07 INFO - Running post-run listener: _resource_record_post_run 09:19:08 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 4096; Write bytes: 694557696; Read time: 0; Write time: 1977 09:19:08 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 375099904; Write bytes: 369223168; Read time: 28326; Write time: 737 09:19:08 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 4096; Write bytes: 300303872; Read time: 0; Write time: 1194 09:19:08 INFO - Running post-run listener: _upload_blobber_files 09:19:08 INFO - Blob upload gear active. 09:19:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:19:08 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 09:19:08 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'] 09:19:08 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 09:19:09 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:19:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:10 INFO - (blobuploader) - INFO - Done attempting. 09:19:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:19:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:19:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:11 INFO - (blobuploader) - INFO - Done attempting. 09:19:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:11 INFO - Return code: 0 09:19:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a49a6de21d84bdf2c318e6e1d151d7559883efb87e89a7aa1631eeac37e92c704b6cbca38d1e5b121b2bc866d3beabef7fe778cb3f377633951f496172fb580", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b608f4d3047da7efa490b910d12f1fffae35d4b125ea4dd479dd27556d2a6567951b36fd186d79fc58656a87258739e9015369fb2101564189bdccc5194ea52"} 09:19:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:11 INFO - Contents: 09:19:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a49a6de21d84bdf2c318e6e1d151d7559883efb87e89a7aa1631eeac37e92c704b6cbca38d1e5b121b2bc866d3beabef7fe778cb3f377633951f496172fb580", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b608f4d3047da7efa490b910d12f1fffae35d4b125ea4dd479dd27556d2a6567951b36fd186d79fc58656a87258739e9015369fb2101564189bdccc5194ea52"} 09:19:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:11 INFO - Copying logs to upload dir... 09:19:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.204027 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-11 09:19:11.747493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 09:19:11.755255) ========= 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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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/3a49a6de21d84bdf2c318e6e1d151d7559883efb87e89a7aa1631eeac37e92c704b6cbca38d1e5b121b2bc866d3beabef7fe778cb3f377633951f496172fb580", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b608f4d3047da7efa490b910d12f1fffae35d4b125ea4dd479dd27556d2a6567951b36fd186d79fc58656a87258739e9015369fb2101564189bdccc5194ea52"} build_url:https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a49a6de21d84bdf2c318e6e1d151d7559883efb87e89a7aa1631eeac37e92c704b6cbca38d1e5b121b2bc866d3beabef7fe778cb3f377633951f496172fb580", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b608f4d3047da7efa490b910d12f1fffae35d4b125ea4dd479dd27556d2a6567951b36fd186d79fc58656a87258739e9015369fb2101564189bdccc5194ea52"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 09:19:11.789080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 09:19:11.789380) ========= 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.xakFnkLRp9/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.9bCXqJ7tIn/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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.005427 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 09:19:11.842483) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 09:19:11.842785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 09:19:11.845283) ========= ========= Total master_lag: 0.29 =========