builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1460010500.86 results: success (0) buildid: 20160406211248 builduid: bd46f513ec404f40bb8b72990fc7307c revision: 8fc46323cee61bddc4c38701d6020379bba5774a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 23:28:20.859533) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 23:28:20.859960) ========= ========= Started set props: basedir (results: 0, elapsed: 13 secs) (at 2016-04-06 23:28:20.860242) ========= 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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005460 basedir: '/builds/slave/test' ========= master_lag: 13.68 ========= ========= Finished set props: basedir (results: 0, elapsed: 13 secs) (at 2016-04-06 23:28:34.547919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 22 secs) (at 2016-04-06 23:28:34.548198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 22 secs) (at 2016-04-06 23:28:57.170777) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-04-06 23:28:57.171036) ========= 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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.006054 ========= master_lag: 7.73 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-04-06 23:29:04.905526) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:04.908836) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:04.909191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-06 23:29:04.909456) ========= 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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-06 23:29:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-04-06 23:29:06 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.611017 ========= master_lag: 1.48 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-06 23:29:06.997358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 23:29:07.003744) ========= 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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.028122 ========= master_lag: 1.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 23:29:08.273354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-06 23:29:08.273720) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8fc46323cee61bddc4c38701d6020379bba5774a --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 8fc46323cee61bddc4c38701d6020379bba5774a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-06 23:29:09,382 truncating revision to first 12 chars 2016-04-06 23:29:09,382 Setting DEBUG logging. 2016-04-06 23:29:09,382 attempt 1/10 2016-04-06 23:29:09,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8fc46323cee6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 23:29:10,361 unpacking tar archive at: fx-team-8fc46323cee6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.227662 ========= master_lag: 1.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-06 23:29:10.568876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:10.569183) ========= echo 8fc46323cee61bddc4c38701d6020379bba5774a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8fc46323cee61bddc4c38701d6020379bba5774a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 8fc46323cee61bddc4c38701d6020379bba5774a program finished with exit code 0 elapsedTime=0.005175 script_repo_revision: '8fc46323cee61bddc4c38701d6020379bba5774a' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:10.639868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:10.640158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:10.748443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-06 23:29:10.748708) ========= /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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:10 INFO - MultiFileLogger online at 20160406 23:29:10 in /builds/slave/test 23:29:10 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 23:29:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:29:10 INFO - {'append_to_log': False, 23:29:10 INFO - 'base_work_dir': '/builds/slave/test', 23:29:10 INFO - 'blob_upload_branch': 'Fx-Team', 23:29:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:29:10 INFO - 'branch': 'Fx-Team', 23:29:10 INFO - 'buildbot_json_path': 'buildprops.json', 23:29:10 INFO - 'config_files': ('talos/mac_config.py',), 23:29:10 INFO - 'default_actions': ('clobber', 23:29:10 INFO - 'read-buildbot-config', 23:29:10 INFO - 'download-and-extract', 23:29:10 INFO - 'populate-webroot', 23:29:10 INFO - 'create-virtualenv', 23:29:10 INFO - 'install', 23:29:10 INFO - 'run-tests'), 23:29:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:29:10 INFO - 'download_minidump_stackwalk': True, 23:29:10 INFO - 'download_symbols': 'ondemand', 23:29:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:29:10 INFO - 'tooltool.py': '/tools/tooltool.py', 23:29:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:29:10 INFO - '/tools/misc-python/virtualenv.py')}, 23:29:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:29:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:29:10 INFO - 'installer_path': 'installer.exe', 23:29:10 INFO - 'log_level': 'info', 23:29:10 INFO - 'log_name': 'talos', 23:29:10 INFO - 'log_to_console': True, 23:29:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:29:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:29:10 INFO - 'opt_config_files': (), 23:29:10 INFO - 'pip_index': False, 23:29:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:29:10 INFO - 'cmd': ('bash', 23:29:10 INFO - '-c', 23:29:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:29:10 INFO - 'enabled': True, 23:29:10 INFO - 'halt_on_failure': False, 23:29:10 INFO - 'name': 'check_screen_resolution'},), 23:29:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:29:10 INFO - 'cmd': ('bash', 23:29:10 INFO - '-c', 23:29:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:29:10 INFO - 'enabled': True, 23:29:10 INFO - 'halt_on_failure': False, 23:29:10 INFO - 'name': 'check_screen_resolution'},), 23:29:10 INFO - 'run_cmd_checks_enabled': True, 23:29:10 INFO - 'sps_profile': False, 23:29:10 INFO - 'sps_profile_interval': 0, 23:29:10 INFO - 'suite': 'dromaeojs-e10s', 23:29:10 INFO - 'system_bits': '32', 23:29:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:29:10 INFO - 'title': 't-yosemite-r7-0071', 23:29:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:29:10 INFO - 'use_talos_json': True, 23:29:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:29:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:29:10 INFO - 'work_dir': 'build'} 23:29:10 INFO - ##### 23:29:10 INFO - ##### Running clobber step. 23:29:10 INFO - ##### 23:29:10 INFO - Running pre-action listener: _resource_record_pre_action 23:29:10 INFO - Running main action method: clobber 23:29:10 INFO - rmtree: /builds/slave/test/build 23:29:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:29:12 INFO - Running post-action listener: _resource_record_post_action 23:29:12 INFO - ##### 23:29:12 INFO - ##### Running read-buildbot-config step. 23:29:12 INFO - ##### 23:29:12 INFO - Running pre-action listener: _resource_record_pre_action 23:29:12 INFO - Running main action method: read_buildbot_config 23:29:12 INFO - Using buildbot properties: 23:29:12 INFO - { 23:29:12 INFO - "project": "", 23:29:12 INFO - "product": "firefox", 23:29:12 INFO - "script_repo_revision": "production", 23:29:12 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 23:29:12 INFO - "repository": "", 23:29:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 23:29:12 INFO - "buildid": "20160406211248", 23:29:12 INFO - "pgo_build": "False", 23:29:12 INFO - "basedir": "/builds/slave/test", 23:29:12 INFO - "buildnumber": 659, 23:29:12 INFO - "slavename": "t-yosemite-r7-0071", 23:29:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 23:29:12 INFO - "platform": "yosemite_r7", 23:29:12 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 23:29:12 INFO - "branch": "fx-team", 23:29:12 INFO - "repo_path": "integration/fx-team", 23:29:12 INFO - "revision": "8fc46323cee61bddc4c38701d6020379bba5774a", 23:29:12 INFO - "stage_platform": "macosx64", 23:29:12 INFO - "builduid": "bd46f513ec404f40bb8b72990fc7307c", 23:29:12 INFO - "slavebuilddir": "test" 23:29:12 INFO - } 23:29:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 23:29:12 INFO - Running post-action listener: _resource_record_post_action 23:29:12 INFO - ##### 23:29:12 INFO - ##### Running download-and-extract step. 23:29:12 INFO - ##### 23:29:12 INFO - Running pre-action listener: _resource_record_pre_action 23:29:12 INFO - Running main action method: download_and_extract 23:29:12 INFO - mkdir: /builds/slave/test/build/tests 23:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:12 INFO - https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 23:29:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 23:29:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 23:29:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:13 INFO - Downloaded 1199 bytes. 23:29:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 23:29:13 INFO - Using the following test package requirements: 23:29:13 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 23:29:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:29:13 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 23:29:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:29:13 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 23:29:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:29:13 INFO - u'jsshell-mac.zip'], 23:29:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:29:13 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 23:29:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 23:29:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:29:13 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 23:29:13 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:29:13 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 23:29:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:29:13 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 23:29:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:29:13 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 23:29:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:13 INFO - https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:29:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:29:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:29:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:14 INFO - Downloaded 17970679 bytes. 23:29:14 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'] 23:29:14 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 23:29:17 INFO - Return code: 0 23:29:17 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 23:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:17 INFO - https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:29:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:29:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:29:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:19 INFO - Downloaded 17970679 bytes. 23:29:19 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'] 23:29:19 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 23:29:22 INFO - Return code: 0 23:29:22 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')]} 23:29:22 INFO - https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:29:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 23:29:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 23:29:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:23 INFO - Downloaded 10847617 bytes. 23:29:23 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'] 23:29:23 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 23:29:23 INFO - Return code: 0 23:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:23 INFO - https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:29:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:29:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:29:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 23:29:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crAfJHbMTmGicexM5BuyWA/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 23:29:26 INFO - Downloaded 108910262 bytes. 23:29:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:29:26 INFO - mkdir: /builds/slave/test/properties 23:29:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:29:26 INFO - Writing to file /builds/slave/test/properties/build_url 23:29:26 INFO - Contents: 23:29:26 INFO - build_url:https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:29:27 INFO - Running post-action listener: _resource_record_post_action 23:29:27 INFO - Running post-action listener: set_extra_try_arguments 23:29:27 INFO - ##### 23:29:27 INFO - ##### Running populate-webroot step. 23:29:27 INFO - ##### 23:29:27 INFO - Running pre-action listener: _resource_record_pre_action 23:29:27 INFO - Running main action method: populate_webroot 23:29:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:29:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:29:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:29:27 INFO - '--tppagecycles', 23:29:27 INFO - '7'], 23:29:27 INFO - 'tests': ['tsvgm']}}, 23:29:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:29:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:29:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:29:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:29:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:27 INFO - 'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:27 INFO - 'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['damp', 'tps']}, 23:29:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:27 INFO - 'tests': ['damp', 'tps']}, 23:29:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['dromaeo_dom']}, 23:29:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:29:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['a11yr', 23:29:27 INFO - 'ts_paint', 23:29:27 INFO - 'tpaint', 23:29:27 INFO - 'sessionrestore', 23:29:27 INFO - 'sessionrestore_no_auto_restore', 23:29:27 INFO - 'tabpaint']}, 23:29:27 INFO - 'other-e10s': {'tests': ['a11yr', 23:29:27 INFO - 'ts_paint', 23:29:27 INFO - 'tpaint', 23:29:27 INFO - 'sessionrestore', 23:29:27 INFO - 'sessionrestore_no_auto_restore', 23:29:27 INFO - 'tabpaint']}, 23:29:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:29:27 INFO - 'ts_paint', 23:29:27 INFO - 'tpaint', 23:29:27 INFO - 'sessionrestore', 23:29:27 INFO - 'sessionrestore_no_auto_restore', 23:29:27 INFO - 'tabpaint']}, 23:29:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:29:27 INFO - 'ts_paint', 23:29:27 INFO - 'tpaint', 23:29:27 INFO - 'sessionrestore', 23:29:27 INFO - 'sessionrestore_no_auto_restore', 23:29:27 INFO - 'tabpaint']}, 23:29:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['a11yr', 23:29:27 INFO - 'ts_paint', 23:29:27 INFO - 'tpaint', 23:29:27 INFO - 'sessionrestore', 23:29:27 INFO - 'sessionrestore_no_auto_restore', 23:29:27 INFO - 'tabpaint']}, 23:29:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['a11yr', 23:29:27 INFO - 'ts_paint', 23:29:27 INFO - 'tpaint', 23:29:27 INFO - 'sessionrestore', 23:29:27 INFO - 'sessionrestore_no_auto_restore', 23:29:27 INFO - 'tabpaint']}, 23:29:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['tsvgx', 23:29:27 INFO - 'tsvgr_opacity', 23:29:27 INFO - 'tart', 23:29:27 INFO - 'tscrollx', 23:29:27 INFO - 'cart']}, 23:29:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:29:27 INFO - 'tsvgr_opacity', 23:29:27 INFO - 'tart', 23:29:27 INFO - 'tscrollx', 23:29:27 INFO - 'cart']}, 23:29:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:27 INFO - 'talos_options': ['--disable-e10s'], 23:29:27 INFO - 'tests': ['tp5o']}, 23:29:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:27 INFO - 'tests': ['tp5o']}, 23:29:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:27 INFO - 'talos_options': ['--disable-e10s', 23:29:27 INFO - '--xperf_path', 23:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:27 INFO - 'tests': ['tp5n']}, 23:29:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:27 INFO - 'talos_options': ['--xperf_path', 23:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:27 INFO - 'tests': ['tp5n']}}, 23:29:27 INFO - 'talos.zip': {'path': '', 23:29:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:29:27 INFO - Running post-action listener: _resource_record_post_action 23:29:27 INFO - ##### 23:29:27 INFO - ##### Running create-virtualenv step. 23:29:27 INFO - ##### 23:29:27 INFO - Running pre-action listener: _resource_record_pre_action 23:29:27 INFO - Running main action method: create_virtualenv 23:29:27 INFO - Creating virtualenv /builds/slave/test/build/venv 23:29:27 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 23:29:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:29:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:29:27 INFO - Using real prefix '/tools/python27' 23:29:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:29:28 INFO - Installing distribute.............................................................................................................................................................................................done. 23:29:31 INFO - Installing pip.................done. 23:29:31 INFO - Return code: 0 23:29:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:29:31 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')]} 23:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:31 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')]} 23:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:31 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 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:31 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 23:29:31 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 23:29:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:31 INFO - 'HOME': '/Users/cltbld', 23:29:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:31 INFO - 'LOGNAME': 'cltbld', 23:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:31 INFO - 'MOZ_NO_REMOTE': '1', 23:29:31 INFO - 'NO_EM_RESTART': '1', 23:29:31 INFO - 'PAGER': '/bin/cat', 23:29:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:31 INFO - 'PWD': '/builds/slave/test', 23:29:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:31 INFO - 'SHELL': '/bin/bash', 23:29:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:31 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:31 INFO - 'USER': 'cltbld', 23:29:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:31 INFO - 'XPC_FLAGS': '0x0', 23:29:31 INFO - 'XPC_SERVICE_NAME': '0', 23:29:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:31 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 23:29:31 INFO - Cleaning up... 23:29:31 INFO - Return code: 0 23:29:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:29:31 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')]} 23:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:31 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')]} 23:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:31 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 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:31 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 23:29:31 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 23:29:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:31 INFO - 'HOME': '/Users/cltbld', 23:29:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:31 INFO - 'LOGNAME': 'cltbld', 23:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:31 INFO - 'MOZ_NO_REMOTE': '1', 23:29:31 INFO - 'NO_EM_RESTART': '1', 23:29:31 INFO - 'PAGER': '/bin/cat', 23:29:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:31 INFO - 'PWD': '/builds/slave/test', 23:29:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:31 INFO - 'SHELL': '/bin/bash', 23:29:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:31 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:31 INFO - 'USER': 'cltbld', 23:29:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:31 INFO - 'XPC_FLAGS': '0x0', 23:29:31 INFO - 'XPC_SERVICE_NAME': '0', 23:29:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:31 INFO - Downloading/unpacking psutil>=0.7.1 23:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:29:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:35 INFO - Installing collected packages: psutil 23:29:35 INFO - Running setup.py install for psutil 23:29:35 INFO - building 'psutil._psutil_osx' extension 23:29:35 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 23:29:35 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 23:29:35 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 23:29:35 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 23:29:36 INFO - building 'psutil._psutil_posix' extension 23:29:36 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 23:29:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:29:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:29:36 INFO - ^ 23:29:36 INFO - 1 warning generated. 23:29:36 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 23:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:36 INFO - Successfully installed psutil 23:29:36 INFO - Cleaning up... 23:29:36 INFO - Return code: 0 23:29:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:36 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 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:36 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 23:29:36 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 23:29:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:36 INFO - 'HOME': '/Users/cltbld', 23:29:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:36 INFO - 'LOGNAME': 'cltbld', 23:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:36 INFO - 'MOZ_NO_REMOTE': '1', 23:29:36 INFO - 'NO_EM_RESTART': '1', 23:29:36 INFO - 'PAGER': '/bin/cat', 23:29:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:36 INFO - 'PWD': '/builds/slave/test', 23:29:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:36 INFO - 'SHELL': '/bin/bash', 23:29:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:36 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:36 INFO - 'USER': 'cltbld', 23:29:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:36 INFO - 'XPC_FLAGS': '0x0', 23:29:36 INFO - 'XPC_SERVICE_NAME': '0', 23:29:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:29:36 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 23:29:36 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 23:29:36 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 23:29:36 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 23:29:36 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 23:29:36 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 23:29:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:29:39 INFO - Installing collected packages: mozsystemmonitor 23:29:39 INFO - Running setup.py install for mozsystemmonitor 23:29:39 INFO - Successfully installed mozsystemmonitor 23:29:39 INFO - Cleaning up... 23:29:39 INFO - Return code: 0 23:29:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:29:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:39 INFO - 'HOME': '/Users/cltbld', 23:29:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:39 INFO - 'LOGNAME': 'cltbld', 23:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:39 INFO - 'MOZ_NO_REMOTE': '1', 23:29:39 INFO - 'NO_EM_RESTART': '1', 23:29:39 INFO - 'PAGER': '/bin/cat', 23:29:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:39 INFO - 'PWD': '/builds/slave/test', 23:29:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:39 INFO - 'SHELL': '/bin/bash', 23:29:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:39 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:39 INFO - 'USER': 'cltbld', 23:29:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:39 INFO - 'XPC_FLAGS': '0x0', 23:29:39 INFO - 'XPC_SERVICE_NAME': '0', 23:29:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:39 INFO - Downloading/unpacking blobuploader==1.2.4 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29:42 INFO - Downloading blobuploader-1.2.4.tar.gz 23:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:29:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:29:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:29:43 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 23:29:43 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 23:29:43 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 23:29:43 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 23:29:43 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 23:29:43 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 23:29:43 INFO - Downloading docopt-0.6.1.tar.gz 23:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:29:43 INFO - Installing collected packages: blobuploader, requests, docopt 23:29:43 INFO - Running setup.py install for blobuploader 23:29:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:29:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:29:44 INFO - Running setup.py install for requests 23:29:44 INFO - Running setup.py install for docopt 23:29:44 INFO - Successfully installed blobuploader requests docopt 23:29:44 INFO - Cleaning up... 23:29:44 INFO - Return code: 0 23:29:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29:44 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')]} 23:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:44 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')]} 23:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:44 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 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:44 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 23:29:44 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 23:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:44 INFO - 'HOME': '/Users/cltbld', 23:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:44 INFO - 'LOGNAME': 'cltbld', 23:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:44 INFO - 'MOZ_NO_REMOTE': '1', 23:29:44 INFO - 'NO_EM_RESTART': '1', 23:29:44 INFO - 'PAGER': '/bin/cat', 23:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:44 INFO - 'PWD': '/builds/slave/test', 23:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:44 INFO - 'SHELL': '/bin/bash', 23:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:44 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:44 INFO - 'USER': 'cltbld', 23:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:44 INFO - 'XPC_FLAGS': '0x0', 23:29:44 INFO - 'XPC_SERVICE_NAME': '0', 23:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-9HYabE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ucbaq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-fG1y3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-wssHEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-FAiIIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-tr0sED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-mEmTzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Nql9Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:29:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-dfYU4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:29:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-mqmmCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:29:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-SLIh3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:29:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_C565K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:29:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-zHYfpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:29:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-v0MN0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-VhTcfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:29:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-AMkZtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:29:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-MPmEeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:29:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:29:46 INFO - Running setup.py install for manifestparser 23:29:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:29:46 INFO - Running setup.py install for mozcrash 23:29:47 INFO - Running setup.py install for mozdebug 23:29:47 INFO - Running setup.py install for mozdevice 23:29:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:29:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:29:47 INFO - Running setup.py install for mozfile 23:29:47 INFO - Running setup.py install for mozhttpd 23:29:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:29:47 INFO - Running setup.py install for mozinfo 23:29:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:29:47 INFO - Running setup.py install for mozInstall 23:29:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:29:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:29:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:29:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:29:47 INFO - Running setup.py install for mozleak 23:29:48 INFO - Running setup.py install for mozlog 23:29:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:29:48 INFO - Running setup.py install for moznetwork 23:29:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:29:48 INFO - Running setup.py install for mozprocess 23:29:48 INFO - Running setup.py install for mozprofile 23:29:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:29:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:29:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:29:48 INFO - Running setup.py install for mozrunner 23:29:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:29:48 INFO - Running setup.py install for mozscreenshot 23:29:49 INFO - Running setup.py install for moztest 23:29:49 INFO - Running setup.py install for mozversion 23:29:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:29:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:29:49 INFO - Cleaning up... 23:29:49 INFO - Return code: 0 23:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29:49 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')]} 23:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:49 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')]} 23:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:49 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 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:49 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 23:29:49 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 23:29:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:49 INFO - 'HOME': '/Users/cltbld', 23:29:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:49 INFO - 'LOGNAME': 'cltbld', 23:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:49 INFO - 'MOZ_NO_REMOTE': '1', 23:29:49 INFO - 'NO_EM_RESTART': '1', 23:29:49 INFO - 'PAGER': '/bin/cat', 23:29:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:49 INFO - 'PWD': '/builds/slave/test', 23:29:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:49 INFO - 'SHELL': '/bin/bash', 23:29:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:49 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:49 INFO - 'USER': 'cltbld', 23:29:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:49 INFO - 'XPC_FLAGS': '0x0', 23:29:49 INFO - 'XPC_SERVICE_NAME': '0', 23:29:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:29:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-h5kG7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:29:49 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)) 23:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:29:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-YBhVye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:29:49 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)) 23:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:29:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-8Yaf8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:29:49 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)) 23:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:29:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-yIxXg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-FyjmJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-BVlupP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-magfPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-mnkBYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-LroIBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-FupkLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ArHkiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Lyfqeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:29:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-S6diVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:29:51 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DfPfMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:51 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-UXlRoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:29:51 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-istbG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:29:51 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-FWfCFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:29:51 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)) 23:29:51 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)) 23:29:51 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)) 23:29:51 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)) 23:29:51 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)) 23:29:51 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)) 23:29:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:54 INFO - Downloading blessings-1.6.tar.gz 23:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:29:54 INFO - Installing collected packages: blessings 23:29:54 INFO - Running setup.py install for blessings 23:29:54 INFO - Successfully installed blessings 23:29:54 INFO - Cleaning up... 23:29:54 INFO - Return code: 0 23:29:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:29:54 INFO - Reading from file tmpfile_stdout 23:29:54 INFO - Current package versions: 23:29:54 INFO - blessings == 1.6 23:29:54 INFO - blobuploader == 1.2.4 23:29:54 INFO - docopt == 0.6.1 23:29:54 INFO - manifestparser == 1.1 23:29:54 INFO - mozInstall == 1.12 23:29:54 INFO - mozcrash == 0.17 23:29:54 INFO - mozdebug == 0.1 23:29:54 INFO - mozdevice == 0.48 23:29:54 INFO - mozfile == 1.2 23:29:54 INFO - mozhttpd == 0.7 23:29:54 INFO - mozinfo == 0.9 23:29:54 INFO - mozleak == 0.1 23:29:54 INFO - mozlog == 3.1 23:29:54 INFO - moznetwork == 0.27 23:29:54 INFO - mozprocess == 0.22 23:29:54 INFO - mozprofile == 0.28 23:29:54 INFO - mozrunner == 6.11 23:29:54 INFO - mozscreenshot == 0.1 23:29:54 INFO - mozsystemmonitor == 0.0 23:29:54 INFO - moztest == 0.7 23:29:54 INFO - mozversion == 1.4 23:29:54 INFO - psutil == 3.1.1 23:29:54 INFO - requests == 1.2.3 23:29:54 INFO - wsgiref == 0.1.2 23:29:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:54 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 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:54 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 23:29:54 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 23:29:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:54 INFO - 'HOME': '/Users/cltbld', 23:29:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:54 INFO - 'LOGNAME': 'cltbld', 23:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:54 INFO - 'MOZ_NO_REMOTE': '1', 23:29:54 INFO - 'NO_EM_RESTART': '1', 23:29:54 INFO - 'PAGER': '/bin/cat', 23:29:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:54 INFO - 'PWD': '/builds/slave/test', 23:29:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:54 INFO - 'SHELL': '/bin/bash', 23:29:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:54 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:54 INFO - 'USER': 'cltbld', 23:29:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:54 INFO - 'XPC_FLAGS': '0x0', 23:29:54 INFO - 'XPC_SERVICE_NAME': '0', 23:29:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 INFO - Cleaning up... 23:29:55 INFO - Return code: 0 23:29:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:29:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:55 INFO - 'HOME': '/Users/cltbld', 23:29:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:55 INFO - 'LOGNAME': 'cltbld', 23:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:55 INFO - 'MOZ_NO_REMOTE': '1', 23:29:55 INFO - 'NO_EM_RESTART': '1', 23:29:55 INFO - 'PAGER': '/bin/cat', 23:29:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:55 INFO - 'PWD': '/builds/slave/test', 23:29:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:55 INFO - 'SHELL': '/bin/bash', 23:29:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:55 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:55 INFO - 'USER': 'cltbld', 23:29:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:55 INFO - 'XPC_FLAGS': '0x0', 23:29:55 INFO - 'XPC_SERVICE_NAME': '0', 23:29:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:55 INFO - Downloading/unpacking jsonschema 23:29:55 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 23:29:55 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 23:29:55 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 23:29:55 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 23:29:55 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 23:29:55 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 23:29:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:29:57 INFO - Downloading/unpacking functools32 (from jsonschema) 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29:58 INFO - Downloading functools32-3.2.3-2.tar.gz 23:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:29:58 INFO - warning: no files found matching '*.txt' 23:29:58 INFO - no previously-included directories found matching 'build' 23:29:58 INFO - no previously-included directories found matching 'dist' 23:29:58 INFO - no previously-included directories found matching '.git*' 23:29:58 INFO - Installing collected packages: jsonschema, functools32 23:29:58 INFO - Running setup.py install for functools32 23:29:58 INFO - warning: no files found matching '*.txt' 23:29:58 INFO - no previously-included directories found matching 'build' 23:29:58 INFO - no previously-included directories found matching 'dist' 23:29:58 INFO - no previously-included directories found matching '.git*' 23:29:58 INFO - Successfully installed jsonschema functools32 23:29:58 INFO - Cleaning up... 23:29:58 INFO - Return code: 0 23:29:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b48464930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, '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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 23:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:29:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:29:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:58 INFO - 'HOME': '/Users/cltbld', 23:29:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:58 INFO - 'LOGNAME': 'cltbld', 23:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:58 INFO - 'MOZ_NO_REMOTE': '1', 23:29:58 INFO - 'NO_EM_RESTART': '1', 23:29:58 INFO - 'PAGER': '/bin/cat', 23:29:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:58 INFO - 'PWD': '/builds/slave/test', 23:29:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:58 INFO - 'SHELL': '/bin/bash', 23:29:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:29:58 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:29:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:58 INFO - 'USER': 'cltbld', 23:29:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:58 INFO - 'XPC_FLAGS': '0x0', 23:29:58 INFO - 'XPC_SERVICE_NAME': '0', 23:29:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:58 INFO - Downloading/unpacking flake8 23:29:58 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 23:29:58 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 23:29:58 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 23:29:58 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 23:29:58 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 23:29:58 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 23:30:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:30:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:30:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:30:02 INFO - no previously-included directories found matching 'docs/_build' 23:30:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:30:02 INFO - Running setup.py install for pep8 23:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:30:02 INFO - no previously-included directories found matching 'docs/_build' 23:30:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:30:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:30:02 INFO - Cleaning up... 23:30:02 INFO - Return code: 0 23:30:02 INFO - Running post-action listener: _resource_record_post_action 23:30:02 INFO - Running post-action listener: _start_resource_monitoring 23:30:02 INFO - Starting resource monitoring. 23:30:02 INFO - ##### 23:30:02 INFO - ##### Running install step. 23:30:02 INFO - ##### 23:30:02 INFO - Running pre-action listener: _resource_record_pre_action 23:30:02 INFO - Running main action method: install 23:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:03 INFO - Reading from file tmpfile_stdout 23:30:03 INFO - Detecting whether we're running mozinstall >=1.0... 23:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:30:03 INFO - Reading from file tmpfile_stdout 23:30:03 INFO - Output received: 23:30:03 INFO - Usage: mozinstall [options] installer 23:30:03 INFO - Options: 23:30:03 INFO - -h, --help show this help message and exit 23:30:03 INFO - -d DEST, --destination=DEST 23:30:03 INFO - Directory to install application into. [default: 23:30:03 INFO - "/builds/slave/test"] 23:30:03 INFO - --app=APP Application being installed. [default: firefox] 23:30:03 INFO - mkdir: /builds/slave/test/build/application 23:30:03 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'] 23:30:03 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 23:30:36 INFO - Reading from file tmpfile_stdout 23:30:36 INFO - Output received: 23:30:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:30:36 INFO - Running post-action listener: _resource_record_post_action 23:30:36 INFO - ##### 23:30:36 INFO - ##### Running run-tests step. 23:30:36 INFO - ##### 23:30:36 INFO - Running pre-action listener: _resource_record_pre_action 23:30:36 INFO - Running main action method: run_tests 23:30:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:30:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:30:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:30:36 INFO - 2016-04-06 23:30:36.941 screenresolution[1639:7745] starting screenresolution argv=screenresolution get 23:30:36 INFO - 2016-04-06 23:30:36.943 screenresolution[1639:7745] Display 0: 1600x1200x32@60 23:30:36 INFO - 2016-04-06 23:30:36.949 screenresolution[1640:7747] starting screenresolution argv=screenresolution list 23:30:36 INFO - Available Modes on Display 0 23:30:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:30:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:30:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:30:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:30:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:30:37 INFO - Intel Iris: 23:30:37 INFO - Chipset Model: Intel Iris 23:30:37 INFO - Type: GPU 23:30:37 INFO - Bus: Built-In 23:30:37 INFO - VRAM (Dynamic, Max): 1536 MB 23:30:37 INFO - Vendor: Intel (0x8086) 23:30:37 INFO - Device ID: 0x0a2e 23:30:37 INFO - Revision ID: 0x0009 23:30:37 INFO - Displays: 23:30:37 INFO - Display: 23:30:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:30:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:30:37 INFO - Display Serial Number: 1600x1200 60 23:30:37 INFO - Main Display: Yes 23:30:37 INFO - Mirror: Off 23:30:37 INFO - Online: Yes 23:30:37 INFO - Rotation: Supported 23:30:37 INFO - Return code: 0 23:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:30:37 INFO - Python 2.7.3 23:30:37 INFO - Return code: 0 23:30:37 INFO - grabbing minidump binary from tooltool 23:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:30:37 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 0x10abd9e00>, '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 0x10aa42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abd4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:30:37 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 23:30:37 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 23:30:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:30:37 INFO - Return code: 0 23:30:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:30:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:30:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:30:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:30:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:30:38 INFO - Return code: 0 23:30:38 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/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 23:30:38 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/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --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 23:30:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G4kmFVydQ7/Render', 23:30:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:38 INFO - 'HOME': '/Users/cltbld', 23:30:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:38 INFO - 'LOGNAME': 'cltbld', 23:30:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:30:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:38 INFO - 'MOZ_NO_REMOTE': '1', 23:30:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:30:38 INFO - 'NO_EM_RESTART': '1', 23:30:38 INFO - 'PAGER': '/bin/cat', 23:30:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:38 INFO - 'PWD': '/builds/slave/test', 23:30:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:30:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:38 INFO - 'SHELL': '/bin/bash', 23:30:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJzmRKKzgU/Listeners', 23:30:38 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 23:30:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:38 INFO - 'USER': 'cltbld', 23:30:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:38 INFO - 'XPC_FLAGS': '0x0', 23:30:38 INFO - 'XPC_SERVICE_NAME': '0', 23:30:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:38 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/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 23:30:38 INFO - mozversion application_buildid: 20160406211248 23:30:38 INFO - mozversion application_changeset: 8fc46323cee61bddc4c38701d6020379bba5774a 23:30:38 INFO - mozversion application_display_name: Nightly 23:30:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:30:38 INFO - mozversion application_name: Firefox 23:30:38 INFO - mozversion application_remotingname: firefox 23:30:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:30:38 INFO - mozversion application_vendor: Mozilla 23:30:38 INFO - mozversion application_version: 48.0a1 23:30:38 INFO - mozversion platform_buildid: 20160406211248 23:30:38 INFO - mozversion platform_changeset: 8fc46323cee61bddc4c38701d6020379bba5774a 23:30:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:30:38 INFO - mozversion platform_version: 48.0a1 23:30:38 INFO - using testdate: 1460010638 23:30:38 INFO - actual date: 1460010638 23:30:38 INFO - starting webserver on 'localhost:49270' 23:30:38 INFO - SUITE-START | Running 2 tests 23:30:38 INFO - TEST-START | dromaeo_css 23:30:38 INFO - operating with platform_type : mac_ 23:30:38 INFO - Initialising browser for dromaeo_css test... 23:30:38 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp4ianQn/profile http://localhost:49270/getInfo.html) 23:30:41 INFO - PROCESS | 1658 | 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] 23:30:41 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 23:30:41 INFO - PROCESS | 1658 | colorDepth:24 23:30:41 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 23:30:41 INFO - PROCESS | 1658 | __metrics 23:30:41 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 23:30:42 INFO - TEST-INFO | 1658: exit 0 23:30:42 INFO - Browser initialized. 23:30:42 INFO - Running cycle 1/1 for dromaeo_css test... 23:30:42 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp4ianQn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:30:54 INFO - PROCESS | 1662 | RSS: Main: 247136256 23:30:54 INFO - PROCESS | 1662 | 23:31:44 INFO - PROCESS | 1662 | 1460010704082 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] 23:33:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 23:33:56 INFO - PROCESS | 1662 | RSS: Main: 259510272 23:33:56 INFO - PROCESS | 1662 | 23:36:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 23:36:59 INFO - PROCESS | 1662 | RSS: Main: 271372288 23:36:59 INFO - PROCESS | 1662 | 23:40:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 23:40:01 INFO - PROCESS | 1662 | RSS: Main: 273379328 23:40:01 INFO - PROCESS | 1662 | 23:43:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 23:43:04 INFO - PROCESS | 1662 | RSS: Main: 274993152 23:43:04 INFO - PROCESS | 1662 | 23:46:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 23:46:07 INFO - PROCESS | 1662 | RSS: Main: 277831680 23:46:07 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 23:49:09 INFO - PROCESS | 1662 | RSS: Main: 278802432 23:49:09 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | __start_tp_report 23:49:09 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 23:49:09 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 23:49:09 INFO - PROCESS | 1662 | |i|pagename|runs| 23:49:09 INFO - PROCESS | 1662 | |0;dojo.html;2930.3553218291977;3535.929281414373;3551.644835516447;3570.9464358034634;3570.982145089274;4780.354652121962;4888;5744.885102297957;5849.268841394825;5909.2022576952095;4345.956970327123;5703.543716502681;5821.854453638651;5841.707914604263;5865.442782935625;5187.740612969355;5209.114450543417;5223.503767142115;5250.868728281805;5309.203619457074;5289.100852855024;5307.124324486455;5333.546648534879;5361.115415956382;5376.731163441812;5123.436421993578;5242.81650142247;5250.894982100374;5258.894822103555;5269.130593452114;5188.299579556787;5217.5043370880085;5229.346331708536;5232.241325007891;5256.421793602701;5121.103806833827;5186.377634683824;5228.9738551307;5232.1628539433505;5237.711925844077;5668.631538949955;5722.256106706143;5785.913211301834;5815.302163740378;5849.795257165979;6176.505879529627;6201.658908760016;6211.409916057967;6215.316315205324;6266.530010249249;6124.9912799099075;6187.195664563578;6259.937400626027;6275.215598050244;6298.275698294663;6002.51979841616;6027.8794424111275;6030;6033.245844269466;6087.391260873921;6326.731786002345;6331.430171284606;6353.841153971188;6354.52341074412;6357.364263573698;6121.483458747775;6129.570930034944;6159.784407545714;6165.568410211332;6199.442050215503;6168.506519478431;6237.688115594202;6243.687815609202;6262.655553944577;6273.7176827042895;6123.6486823095165;6125.387461253839;6128.533679014861;6197.194364732556;6206.193194884727;6119.326874043852;6136.733532366159;6146.647737497743;6185.783497577563;6220.533459990519;4141.544430112685;4240.872773816791;4929.383827021622;4953.504649535018;5003.74981250936;4438;4457.1308594823695;4486.664303863142;4490.348899409567;4500.864974050718;5679.318481782213;5789.392113828072;5847.44449277318;5857.736401861926;5883.646981181143;6214.130021796952;6245.18812554365;6274.6548939808745;6302.747890084437;6321.462675672527;5830;5837.562182836305;5857.853553661193;5878.323992740804;5921.703914804242;4644.117617652635;5342.198670199424;5417.4311697272005;5441.966026454961;5480.7533660985355;6372.58578192416;6411.230652321751;6412.9679351602945;6419.807405777928;6434.935650643433;6184.567080304336;6275.090111933835;6295.622262664255;6297.307296197323;6298.275698294571;6318.810435686937;6319.715612797343;6344.302126766144;6344.587601805868;6363.90454143179;6198.163247961467;6207.720652570735;6237.563370564017;6240.500759939103;6271.905921411091;6171.506279497539;6207;6266.843328916631;6287.717052732546;6295.087212354275;6115.602485838406;6176.258848938156;6193.628382297076;6250.031245157008;6267.874642507033;6202.5658203925295;6240.687965601611;6251.53113516479;6265.592736472115;6274.247090349188;5996.340402555628;6039.214902062704;6089.238845144357;6092.8781424372155;6104.145419641165;5031.798728050983;5200.271961925409;6156.830202261556;6235.469985051322;6242.157308763259;5187.559057480156;6082.2093127893095;6101.969490152698;6116.816495505142;6146.815595532141 23:49:09 INFO - PROCESS | 1662 | |1;ext.html;450.2076345631687;550.4468009650301;563.9943600563996;635.4598591197481;642.585532331646;32609.836950815243;38432;38441;38502;38675.80662096689;39509;39829;40054.39918401226;40174.39738403919;40225.396619050734;9304.627814887397;9477.715668529921;9531.523423828781;9532.761680957961;9595;9358.110979456975;9466.19537339327;9497.287703422271;9544.665936692218;9625.470599117045;9492.620295188219;9547.427154370725;9599.136077753;9647.469389183592;9656.903430965705;9498.240140788721;9509.857352139723;9624.807503849954;9642.2768292378;9647.324687271894;9459.52702364886;9478.857817132748;9531.904680953172;9549.952250238774;9598.088181622805;38281.425778613346;38528.80735596332;38536.229275414335;39068.60931390678;39090.82727518179;2515.7610027047585;2978.3894301668106;3167.8797279560877;3181.8409079546163;3352.011156708777;27940.161795146178;28002.859985700146;28217.85891070552;28546.429071418665;28574.571381429294;2737.835729856195;2804.5652923796843;2835.0927703135003;2843.1044221070297;2897.4060317634835;330210.3489482561;331226;333380;334990;335246.64753352397;57635.84728305411;65939;67499;67672.6616366915;67972.660136699;64333.356666433676;64661.67669161624;64977.675111624136;65054.34945650578;65632;16478;16566.917165414336;16665.666686666198;16694.916525417295;16729.91635041817;12693.301868397142;12704.237745735285;12718.872811271955;12929.741405171844;12946.96424286055;20132.19471221164;20893;21030.263940762;21062.47343816417;21131.366059018255;8383.371247156487;8589.828203436022;8595.828083438297;8608.741737747878;8623;888.1473785166183;991.9702408927744;1001.9098281154731;1021.2238698588977;1027.5941003303653;27099.86450067737;29848.55227171594;29930.85034574813;30423.391532169233;30607.693923060484;915.3729695158837;1065.5577935156978;1071.2180108520824;1085.2240647936605;1138.7132540229488;11370.715732106764;14253.171497644784;14399.64000899965;14509.347079381454;14664.706705865823;602967;613486;615294;618693;621240;49373.50626493761;59268.70365648231;59536.34404731543;59750.51871109684;59756.80486390248;1222.8043513037871;1394.9093308934887;1439.172475826404;1472.7864459653076;1474.9778753318708;23218.535629287657;24715.011399544535;27136.864315678296;27806.582901256093;28183.71816281811;48570.54288371355;49147.01705965789;49282.50717492779;49318.520444386726;49368.75315623399;486623;489238;491915;492289;492677;32948.67051329552;43069.35395969126;43906.780466097465;44211;44597.55402445934;39539.209215816096;41272;41871.7906410466;46615.533844662474;47910.52089479061;36995.815020924725;37145.81427092847;37413.438798417505;37433.064173395884;37764;36096.639033609325;36306.636933630325;36927.63072369242;36928.26143477062;37043.444348334255;36891.8155409232;37444;37638;37865.053373665876;38773.2245355097;30569.54145687772;31479.52780708337;31509;31592.526112107877;31699;23808.40478988039;24599.50800984006;24624.50750985006;25047.749522504542;25094.62358064594 23:49:09 INFO - PROCESS | 1662 | |2;jquery.html;353.6286898756307;359.9442086476597;366.34241536442084;366.58575809335457;367.1995050789278;19481.902590487047;19798.505037374074;20671.379858604265;21009.894950525228;21118.57762844744;11931.58239461619;12319.445624946877;12322.630321090382;12329.136960412774;12348.4443200056;5170.999999999991;5417.918731219015;5692.999999999979;6628.933710662904;6675.098861653688;6578.6381749003785;6579.17760279965;6594.736210551596;6623.105880706115;6626.13860198176;6315.368463153671;6523.412892839643;6566.8686626267445;6603.900941485882;6630.3701148391065;6147.354527774564;6425.421712045915;6429.099926010339;6440.4203621673805;6451.83870403239;5629.8592535186535;5711.657300561979;5717.171010203498;5729.684867332295;5749.568782341341;13452.260125693083;13515.662108447368;13840.61593840608;17713.29146834125;25232.612206328646;1996.0618509300605;2015.7581090269116;2117.851750377474;2190.441437433444;2750.2986738381583;9633.759156021086;9647.903520964841;9898.802023959552;10060.346077504939;10196.74508137295;1689.358043943306;1715.7169067104037;1720.4494561740248;1755.6576467588825;1755.8068612452748;93087.06912930851;95061;101225.97548049071;103308.48345758223;104432.95567044384;10887.346759194315;11006.779864402668;11037.006669399792;11173.273737207055;11339.262947908359;13404.664883377798;13637;13721.725565488634;13726.382312795748;13822.23977681217;8364.874526882102;8460.703875364332;8529.402941794138;8556.358273129541;8646.221840034426;8509.489430634181;8633.827323453495;8662.91337086621;8685.869711954325;8761.737147885573;4344.804483798237;4388.012697143181;4392.209402307615;4426.424564806554;4447.799849006802;1829.3140072472822;1867.7478540396874;1870.1864688860117;1880.6332765110947;1883.2561138350275;859.6647307550061;886.3086792302015;958.3435346787334;960.9807803843884;993.7913038262046;19242.615147696968;19808.20767169326;19880.50298742514;19962.702424342373;20148.899255503628;760.7793739815502;781.9061712594525;843.4306842881153;942.4109931292942;1011.7470632341915;8623.741287761377;8639.704044393391;9718.951405242928;10278.434686092187;10793.571446424492;599634;604507;610146;617823;618463;80677;81820.77268840972;100006.49977250761;109821.45089274502;110281;981.0728861226073;983.3362480325751;1004.3672486333709;1008.8385858262643;1010.237270860481;17595.736063959306;17712.025838578487;17960.910195448938;18053.548661283574;18063.458096257134;47075.05849883052;48195.75902120467;49574.51276461712;50552.4723763803;51790.705232369495;69598.65200673965;70023;70749;71116;72060.55878882497;6173.629582225081;7458.03045604068;7519.699212031457;7633.618319083913;7712.344450721752;9819.16537094355;9835.459049752046;11915.106367022681;11959.641210763692;12188.878111218773;10232.795344093225;10385.376877387382;10428.947855260674;10570.894291056991;10600.204984626029;10238.488075596339;10238.590456381662;10421.531031103466;10497.317674351143;10563.207759418228;10361.74095647615;10655;10780.353178809297;11018.889811102106;11051.281666691639;7553.169151393233;7583.469157158946;7593.620318983918;7613.809654758676;7682.769516914502;10236.232282578687;10524.36853788775;10792.838107428552;10854.240203185702;10872.293300935415 23:49:09 INFO - PROCESS | 1662 | |3;mootools.html;1582.9445969391074;1587.5316781549438;1862.2923289150121;1961.6174845905045;1968.1832039703525;8121.187881211876;8760.430572012814;8780.517071561062;8975.057618950006;9012.008679045308;8720.95639521803;8740.72741087317;8762.474251544912;8880.156385143417;8883.244924181436;2425.34515680767;2455.26342097371;2467.642191882176;2477.9628305575343;2479.2438306316567;2393.922734769361;2428.162284012013;2488.950220995579;2500.72492025877;2520.2943175910773;2475.814313926454;2497.5254701606727;2520.2565243253284;2521.042004038463;2528.683914510686;2452.8896199670967;2476.319012271622;2492.7881130103874;2505.7744802967727;2514.8994040238367;2112.725345705064;2480.8015358771436;2495.6506089147533;2501.4746903150362;2524.507720994407;8165.8366832663605;8363.958180209122;8902.599383027715;8956.507392093432;8987.775305617346;5490.3411590608985;5548.611597188158;5605.467480589337;5650.378458369576;5650.943490565083;3196.536502207167;3513.1744040150543;3616.27674465108;3634.3276493848457;3665.706743460517;882.1839798186652;980.6711905368195;997.0478193325357;1024.7950409917971;1039.6205385034484;10167.89832101677;12098.334591597459;12378.381080945917;12383.257004579664;12403.565875194325;4919.77860996256;4936.703797772145;4994.525520075587;4998.975005125024;5056.7610935320345;8799.91200087991;10172.186225101974;10260.538275777608;10293;10343.172546196287;5375.892482150413;5397.2443857859935;5485.17722341644;5555.694436805934;5575.2473416088305;4367.432233809584;4468.843590474317;4511.684182107287;4983.626228032912;5011.57401620859;3390.1524618845287;3913.354296541039;3933.370660694275;3982.820773065219;4009.9373665978537;1328.435414948643;1345.3744009035845;1347.8947263244045;1352.4236329791763;1354.7561438940888;1319.617310979805;1350.338334216227;1374.0381732786889;1394.7001394700187;1405.5783265020452;8195.057568379594;8214.342852571779;8218.794530136674;8222.506649600924;8250.298724608356;509.9260607211933;510.532862430879;513.4813838023623;518.9014087323396;521.0438844719981;6242.531810114259;6246.031865060922;6282.874342513124;6306.463950564162;6311.431971122529;10654.680359589225;10725.83911241332;11072.335659860435;11102.888971110347;11125.443727813577;9056.320775941698;10412.68761937143;10547.314424562379;10911.83632245517;10952.123830093573;8469.703560375357;8472.703455379033;8481.745547633582;8482.533460659599;8543.871841922377;6501.512386570931;7214.71141154348;7446.813829654302;7983.8802417964935;8008.27925486709;9443.244540436886;9753;9757;9834.459104749307;9853.605855765976;9898.604055837686;10006.299559030798;10070.19438444908;10182.796344072929;10201.897981020391;6735.966320168368;7269.854602908018;7530.171681114964;7557.5465472071855;7621.31408173267;8287;8385.790355241168;8412.537310447984;8421.989361276686;8430.662773488992;7259.419246460165;7266.418686505172;7372.59450730215;7483.363914067365;7508.986286851424;7228.132624085143;7315.30504602062;7355.411567074728;7413.443991700537;7421.332080112816;7573.129090154483;7589.6584653689615;7603.581803000667;7639.388848892187;7707.229277072248;6970.128733908262;6974.930250697428;7055.611941343275;7077.752278670222;7122.857542849218;7054.506184567031;7115.964420177866;7151.4636402269;7216.675249613675;7217.963910180415 23:49:09 INFO - PROCESS | 1662 | |4;prototype.html;324.024685696055;325.18541054658084;326.99346013079753;334.56005352960847;335.69284105043903;5698.487136157745;6623.37077977592;6769.695363708633;6813.591184528932;6834.555753875995;6682.599044057348;6682.665866706658;6697.564658297208;6709.060731497594;6776;3803.467514547952;4823.42118945727;4943.629227807911;4950.529699678543;4980.352554167953;4894.3147959285725;4928.901421971558;4929.162042452774;4929.753512324387;4935.876603084916;4819.855404337858;4883;4887.584555312785;4892.3639926809465;4914.483979182188;4894;4895.412550493946;4902.509749025105;4905.411350637928;4920.852374428755;4235.53409124996;4244.66042716585;4251.489821221442;4253.553376895412;4276.978615106936;5222.660527065728;6286.151369565142;6375.617462952191;6461.93538064618;6520.413772425147;5933.703314834241;5972.522198224132;5974.820755377345;6006.12911127884;6012.639241645472;5191.8182863599595;7188.2811718828225;7251.419886409075;7253.601051942141;7265.636718164071;4799.2321228603605;4802.447718512381;4811.13399588074;4819.228923372279;4823.43238447506;6206.937930620681;7687.884681729778;7691.846163076763;7693.230676932318;7717.768466945944;4183.769892655933;4524.479684836286;4579.290210017452;4877.268409738496;4898.093852637274;3981.3629819228786;4375.190589740908;4830.203016502308;4830.468648448667;4842.539958703917;4854.708717476963;5714.714264286769;5816.621919575214;5827.533797296291;5844.26946631671;7321.597312147776;7323.450741194431;7333.449991250677;7342.853142937111;7346.302101300368;1464.4142343062647;1612.5565469495982;1644.9753253700965;1667.6998140334613;1671.4233589411633;1014.60937539048;1046.4506134279563;1058.7353161709573;1059.2585190366774;1066.1311031509294;6739.764108256286;6773.1872175338285;6790.287019862942;6792.63764436607;6813.182418109858;7560.886586701204;7600.46796724224;7610.581418021951;7629.732959346507;7651.120121186135;5564.582656300794;6533.150690410216;6586.440152586988;6776.15298087739;6791.0153027811675;3988.900277493086;3999.8200080996426;4017.8593749218635;4019.773968939443;4022.2357752027606;7929.563873986871;7931.405144614062;7931.643076061591;7938.6030698466;7942.285194332422;7408.555331710372;7827.099883513355;7877.921220787719;7892.092409372881;7945.960270198612;6494.350564943562;6507.861124303228;7881.133075361706;7936.84126317482;8017.358611311081;7556.697732090654;7657;7673.040869891263;7673.53958762476;7679.2704693054075;7502.887456688045;7510.061242344707;7512.699492020477;7515.511491753018;7548.509346892434;7651.655675494728;7925.682972681258;7938.841223175619;7962.482438641469;7978.521288722695;4666.533346665306;4677.462091859344;4715.457722361835;4720.858374248778;4735.952640473552;7584.848303033798;7606.125295591078;7613.238676132342;7616.619169041636;7633.427492937941;5605.719714014364;7355.889661654973;7376.114866215874;7378.5941773202985;7382.187959324578;7044.471664625071;7343.559386436617;7365.300296471826;7407.111146662435;7418.36943859778;7160.570365777861;7182.3535881770895;7203.675834587351;7214.783556493314;7215.350618444365;7362.042934418491;7374.815629609303;7377.77866664001;7381.077365329334;7435.851282974419;5505.9724701376235;7090.397316227972;7166.319199676022;7175.103112110986;7226.89159662616 23:49:09 INFO - PROCESS | 1662 | |5;yui.html;557.1447827584656;634.2420807135469;644.5939058393211;674.554793836068;687.2543290529774;13673.589792306222;14432.422703091877;14631.268436578155;14704.852951470482;14707.558773236806;11051.392173430459;15314.081155130672;15583;15583.454579089734;15622.453214137508;728.6429649471747;886.6364790435922;892.9330300227476;908.6138391183754;910.8087301666658;898.2993265253114;899.4603238057146;899.6581299106331;900.7703035725881;902.3503077784018;940.3229674634287;945.470536499559;954.4225743425231;958.8561715742625;961.3126614470652;942.6559305853349;946.7869729310919;951.5813042261452;953.5851904421598;953.952302384878;698.8322802527408;708.1219288082792;708.5465302206592;708.8298808286025;712.6828561290228;14904.478343257933;14978.850211497855;15084.24578771068;15102.622434439118;15150;12260.570880019246;12277.57028504007;12383.93808030963;12436.875631243753;12516.81224781629;8353.540555269457;9781.642820771393;9883.258755593288;9939.353941993748;10226.335288206243;2930.5018146915077;3399.8640054397792;3432.2792213635166;3495.580530336376;3553.5558055243096;77878.6106069466;78631.606841966;79126.20873791246;79588.60205698934;80235;9183.448993060438;9196.678116265899;9244.260459163252;9265.768355791024;9383.24934005278;20764.792352076285;20765.480862978548;21308.893455532623;21340.146394144373;21423.357299281048;7034.507584469038;7092.609906455092;7254.673539690727;7292.19785823559;7374.778756637309;3096.690330966885;3996.1208534122447;4007.699422543321;4018.6985976051915;4031.07285324377;3498.527698760686;3508.3509550733197;3515.472679098156;3534.3638145134123;3544.521489598923;606.2724730323541;607.5655906027212;608.5405518833342;617.1360095865824;619.789271647633;508.84480233529126;522.7271593669427;522.9111051121318;534.7860356989612;570.0565563991601;7604.315611594983;7652.502587331805;8187.754367368989;8213.630386632616;8365.564815183989;562.2381672833334;568.2697733412544;594.067314316519;598.9730462129214;612.9417705317987;3664.3953747631344;3698.389765688685;3929.7445666031617;4099.651529619956;4190.308599081179;86538.26923461496;88250;89412.5529372349;89596.55201723949;90028;64978.35021649723;66480.66759666268;77581.61209193918;77859.61070194613;78840.6057969718;49696.751516242184;63039.369606304266;67770;67810;70660.64669676618;8473.57632118404;8475.194856488624;8505.659773608986;8520.872186917077;8527.232549070613;48020.51979480161;50103.24845127399;50448.49551504438;50603.2409513865;52239.73880130575;62767;66081.66959165173;66925;67389.3261067383;67915.66042169757;10302.690919272434;10317.27779055459;10689.251752377259;10790.67627971162;10915.727106822393;11894.940525297317;12003.1597788154;12012.279263244232;12034.217775844541;12060.336681482602;11374;11443.828342575034;11594.956453919187;11666.70833229176;11756.529738810352;11239;11264.887351126385;11409.20135590534;11421.029212517029;11704.94147529257;10969.23215374916;11002.779944400907;11081.667549973514;11123.27698699582;11406.258593191416;9323.86014209801;9387.530623468936;9445.858312125461;9532.523373831142;9646.951765241129;8587.484750914715;8702.608382622671;9099.363044586815;9650.758731031781;9735.513224338896 23:49:09 INFO - PROCESS | 1662 | __end_tp_report 23:49:09 INFO - PROCESS | 1662 | __start_cc_report 23:49:09 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,389 23:49:09 INFO - PROCESS | 1662 | __end_cc_report 23:49:09 INFO - PROCESS | 1662 | __startTimestamp1460011749904__endTimestamp 23:49:09 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | ------- Summary: start ------- 23:49:09 INFO - PROCESS | 1662 | Number of tests: 6 23:49:09 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5756.35 Median:6092.88 stddev:682.07 (11.2%) stddev-sans-first:647.13 23:49:09 INFO - PROCESS | 1662 | Values: 2930.4 3535.9 3551.6 3570.9 3571.0 4780.4 4888.0 5744.9 5849.3 5909.2 4346.0 5703.5 5821.9 5841.7 5865.4 5187.7 5209.1 5223.5 5250.9 5309.2 5289.1 5307.1 5333.5 5361.1 5376.7 5123.4 5242.8 5250.9 5258.9 5269.1 5188.3 5217.5 5229.3 5232.2 5256.4 5121.1 5186.4 5229.0 5232.2 5237.7 5668.6 5722.3 5785.9 5815.3 5849.8 6176.5 6201.7 6211.4 6215.3 6266.5 6125.0 6187.2 6259.9 6275.2 6298.3 6002.5 6027.9 6030.0 6033.2 6087.4 6326.7 6331.4 6353.8 6354.5 6357.4 6121.5 6129.6 6159.8 6165.6 6199.4 6168.5 6237.7 6243.7 6262.7 6273.7 6123.6 6125.4 6128.5 6197.2 6206.2 6119.3 6136.7 6146.6 6185.8 6220.5 4141.5 4240.9 4929.4 4953.5 5003.7 4438.0 4457.1 4486.7 4490.3 4500.9 5679.3 5789.4 5847.4 5857.7 5883.6 6214.1 6245.2 6274.7 6302.7 6321.5 5830.0 5837.6 5857.9 5878.3 5921.7 4644.1 5342.2 5417.4 5442.0 5480.8 6372.6 6411.2 6413.0 6419.8 6434.9 6184.6 6275.1 6295.6 6297.3 6298.3 6318.8 6319.7 6344.3 6344.6 6363.9 6198.2 6207.7 6237.6 6240.5 6271.9 6171.5 6207.0 6266.8 6287.7 6295.1 6115.6 6176.3 6193.6 6250.0 6267.9 6202.6 6240.7 6251.5 6265.6 6274.2 5996.3 6039.2 6089.2 6092.9 6104.1 5031.8 5200.3 6156.8 6235.5 6242.2 5187.6 6082.2 6102.0 6116.8 6146.8 23:49:09 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:62723.52 Median:38471.50 stddev:131545.80 (341.9%) stddev-sans-first:131831.73 23:49:09 INFO - PROCESS | 1662 | Values: 450.2 550.4 564.0 635.5 642.6 32609.8 38432.0 38441.0 38502.0 38675.8 39509.0 39829.0 40054.4 40174.4 40225.4 9304.6 9477.7 9531.5 9532.8 9595.0 9358.1 9466.2 9497.3 9544.7 9625.5 9492.6 9547.4 9599.1 9647.5 9656.9 9498.2 9509.9 9624.8 9642.3 9647.3 9459.5 9478.9 9531.9 9550.0 9598.1 38281.4 38528.8 38536.2 39068.6 39090.8 2515.8 2978.4 3167.9 3181.8 3352.0 27940.2 28002.9 28217.9 28546.4 28574.6 2737.8 2804.6 2835.1 2843.1 2897.4 330210.3 331226.0 333380.0 334990.0 335246.6 57635.8 65939.0 67499.0 67672.7 67972.7 64333.4 64661.7 64977.7 65054.3 65632.0 16478.0 16566.9 16665.7 16694.9 16729.9 12693.3 12704.2 12718.9 12929.7 12947.0 20132.2 20893.0 21030.3 21062.5 21131.4 8383.4 8589.8 8595.8 8608.7 8623.0 888.1 992.0 1001.9 1021.2 1027.6 27099.9 29848.6 29930.9 30423.4 30607.7 915.4 1065.6 1071.2 1085.2 1138.7 11370.7 14253.2 14399.6 14509.3 14664.7 602967.0 613486.0 615294.0 618693.0 621240.0 49373.5 59268.7 59536.3 59750.5 59756.8 1222.8 1394.9 1439.2 1472.8 1475.0 23218.5 24715.0 27136.9 27806.6 28183.7 48570.5 49147.0 49282.5 49318.5 49368.8 486623.0 489238.0 491915.0 492289.0 492677.0 32948.7 43069.4 43906.8 44211.0 44597.6 39539.2 41272.0 41871.8 46615.5 47910.5 36995.8 37145.8 37413.4 37433.1 37764.0 36096.6 36306.6 36927.6 36928.3 37043.4 36891.8 37444.0 37638.0 37865.1 38773.2 30569.5 31479.5 31509.0 31592.5 31699.0 23808.4 24599.5 24624.5 25047.7 25094.6 23:49:09 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:32987.06 Median:366.89 stddev:100709.71 (27449.4%) stddev-sans-first:100962.42 23:49:09 INFO - PROCESS | 1662 | Values: 353.6 359.9 366.3 366.6 367.2 19481.9 19798.5 20671.4 21009.9 21118.6 11931.6 12319.4 12322.6 12329.1 12348.4 5171.0 5417.9 5693.0 6628.9 6675.1 6578.6 6579.2 6594.7 6623.1 6626.1 6315.4 6523.4 6566.9 6603.9 6630.4 6147.4 6425.4 6429.1 6440.4 6451.8 5629.9 5711.7 5717.2 5729.7 5749.6 13452.3 13515.7 13840.6 17713.3 25232.6 1996.1 2015.8 2117.9 2190.4 2750.3 9633.8 9647.9 9898.8 10060.3 10196.7 1689.4 1715.7 1720.4 1755.7 1755.8 93087.1 95061.0 101226.0 103308.5 104433.0 10887.3 11006.8 11037.0 11173.3 11339.3 13404.7 13637.0 13721.7 13726.4 13822.2 8364.9 8460.7 8529.4 8556.4 8646.2 8509.5 8633.8 8662.9 8685.9 8761.7 4344.8 4388.0 4392.2 4426.4 4447.8 1829.3 1867.7 1870.2 1880.6 1883.3 859.7 886.3 958.3 961.0 993.8 19242.6 19808.2 19880.5 19962.7 20148.9 760.8 781.9 843.4 942.4 1011.7 8623.7 8639.7 9719.0 10278.4 10793.6 599634.0 604507.0 610146.0 617823.0 618463.0 80677.0 81820.8 100006.5 109821.5 110281.0 981.1 983.3 1004.4 1008.8 1010.2 17595.7 17712.0 17960.9 18053.5 18063.5 47075.1 48195.8 49574.5 50552.5 51790.7 69598.7 70023.0 70749.0 71116.0 72060.6 6173.6 7458.0 7519.7 7633.6 7712.3 9819.2 9835.5 11915.1 11959.6 12188.9 10232.8 10385.4 10428.9 10570.9 10600.2 10238.5 10238.6 10421.5 10497.3 10563.2 10361.7 10655.0 10780.4 11018.9 11051.3 7553.2 7583.5 7593.6 7613.8 7682.8 10236.2 10524.4 10792.8 10854.2 10872.3 23:49:09 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6064.08 Median:5441.21 stddev:3219.98 (59.2%) stddev-sans-first:3211.40 23:49:09 INFO - PROCESS | 1662 | Values: 1582.9 1587.5 1862.3 1961.6 1968.2 8121.2 8760.4 8780.5 8975.1 9012.0 8721.0 8740.7 8762.5 8880.2 8883.2 2425.3 2455.3 2467.6 2478.0 2479.2 2393.9 2428.2 2489.0 2500.7 2520.3 2475.8 2497.5 2520.3 2521.0 2528.7 2452.9 2476.3 2492.8 2505.8 2514.9 2112.7 2480.8 2495.7 2501.5 2524.5 8165.8 8364.0 8902.6 8956.5 8987.8 5490.3 5548.6 5605.5 5650.4 5650.9 3196.5 3513.2 3616.3 3634.3 3665.7 882.2 980.7 997.0 1024.8 1039.6 10167.9 12098.3 12378.4 12383.3 12403.6 4919.8 4936.7 4994.5 4999.0 5056.8 8799.9 10172.2 10260.5 10293.0 10343.2 5375.9 5397.2 5485.2 5555.7 5575.2 4367.4 4468.8 4511.7 4983.6 5011.6 3390.2 3913.4 3933.4 3982.8 4009.9 1328.4 1345.4 1347.9 1352.4 1354.8 1319.6 1350.3 1374.0 1394.7 1405.6 8195.1 8214.3 8218.8 8222.5 8250.3 509.9 510.5 513.5 518.9 521.0 6242.5 6246.0 6282.9 6306.5 6311.4 10654.7 10725.8 11072.3 11102.9 11125.4 9056.3 10412.7 10547.3 10911.8 10952.1 8469.7 8472.7 8481.7 8482.5 8543.9 6501.5 7214.7 7446.8 7983.9 8008.3 9443.2 9753.0 9757.0 9834.5 9853.6 9898.6 10006.3 10070.2 10182.8 10201.9 6736.0 7269.9 7530.2 7557.5 7621.3 8287.0 8385.8 8412.5 8422.0 8430.7 7259.4 7266.4 7372.6 7483.4 7509.0 7228.1 7315.3 7355.4 7413.4 7421.3 7573.1 7589.7 7603.6 7639.4 7707.2 6970.1 6974.9 7055.6 7077.8 7122.9 7054.5 7116.0 7151.5 7216.7 7218.0 23:49:09 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5897.15 Median:6652.98 stddev:1936.76 (29.1%) stddev-sans-first:1896.48 23:49:09 INFO - PROCESS | 1662 | Values: 324.0 325.2 327.0 334.6 335.7 5698.5 6623.4 6769.7 6813.6 6834.6 6682.6 6682.7 6697.6 6709.1 6776.0 3803.5 4823.4 4943.6 4950.5 4980.4 4894.3 4928.9 4929.2 4929.8 4935.9 4819.9 4883.0 4887.6 4892.4 4914.5 4894.0 4895.4 4902.5 4905.4 4920.9 4235.5 4244.7 4251.5 4253.6 4277.0 5222.7 6286.2 6375.6 6461.9 6520.4 5933.7 5972.5 5974.8 6006.1 6012.6 5191.8 7188.3 7251.4 7253.6 7265.6 4799.2 4802.4 4811.1 4819.2 4823.4 6206.9 7687.9 7691.8 7693.2 7717.8 4183.8 4524.5 4579.3 4877.3 4898.1 3981.4 4375.2 4830.2 4830.5 4842.5 4854.7 5714.7 5816.6 5827.5 5844.3 7321.6 7323.5 7333.4 7342.9 7346.3 1464.4 1612.6 1645.0 1667.7 1671.4 1014.6 1046.5 1058.7 1059.3 1066.1 6739.8 6773.2 6790.3 6792.6 6813.2 7560.9 7600.5 7610.6 7629.7 7651.1 5564.6 6533.2 6586.4 6776.2 6791.0 3988.9 3999.8 4017.9 4019.8 4022.2 7929.6 7931.4 7931.6 7938.6 7942.3 7408.6 7827.1 7877.9 7892.1 7946.0 6494.4 6507.9 7881.1 7936.8 8017.4 7556.7 7657.0 7673.0 7673.5 7679.3 7502.9 7510.1 7512.7 7515.5 7548.5 7651.7 7925.7 7938.8 7962.5 7978.5 4666.5 4677.5 4715.5 4720.9 4736.0 7584.8 7606.1 7613.2 7616.6 7633.4 5605.7 7355.9 7376.1 7378.6 7382.2 7044.5 7343.6 7365.3 7407.1 7418.4 7160.6 7182.4 7203.7 7214.8 7215.4 7362.0 7374.8 7377.8 7381.1 7435.9 5506.0 7090.4 7166.3 7175.1 7226.9 23:49:09 INFO - PROCESS | 1662 | 23:49:09 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:17727.76 Median:615.04 stddev:24648.48 (4007.6%) stddev-sans-first:24683.91 23:49:09 INFO - PROCESS | 1662 | Values: 557.1 634.2 644.6 674.6 687.3 13673.6 14432.4 14631.3 14704.9 14707.6 11051.4 15314.1 15583.0 15583.5 15622.5 728.6 886.6 892.9 908.6 910.8 898.3 899.5 899.7 900.8 902.4 940.3 945.5 954.4 958.9 961.3 942.7 946.8 951.6 953.6 954.0 698.8 708.1 708.5 708.8 712.7 14904.5 14978.9 15084.2 15102.6 15150.0 12260.6 12277.6 12383.9 12436.9 12516.8 8353.5 9781.6 9883.3 9939.4 10226.3 2930.5 3399.9 3432.3 3495.6 3553.6 77878.6 78631.6 79126.2 79588.6 80235.0 9183.4 9196.7 9244.3 9265.8 9383.2 20764.8 20765.5 21308.9 21340.1 21423.4 7034.5 7092.6 7254.7 7292.2 7374.8 3096.7 3996.1 4007.7 4018.7 4031.1 3498.5 3508.4 3515.5 3534.4 3544.5 606.3 607.6 608.5 617.1 619.8 508.8 522.7 522.9 534.8 570.1 7604.3 7652.5 8187.8 8213.6 8365.6 562.2 568.3 594.1 599.0 612.9 3664.4 3698.4 3929.7 4099.7 4190.3 86538.3 88250.0 89412.6 89596.6 90028.0 64978.4 66480.7 77581.6 77859.6 78840.6 49696.8 63039.4 67770.0 67810.0 70660.6 8473.6 8475.2 8505.7 8520.9 8527.2 48020.5 50103.2 50448.5 50603.2 52239.7 62767.0 66081.7 66925.0 67389.3 67915.7 10302.7 10317.3 10689.3 10790.7 10915.7 11894.9 12003.2 12012.3 12034.2 12060.3 11374.0 11443.8 11595.0 11666.7 11756.5 11239.0 11264.9 11409.2 11421.0 11704.9 10969.2 11002.8 11081.7 11123.3 11406.3 9323.9 9387.5 9445.9 9532.5 9647.0 8587.5 8702.6 9099.4 9650.8 9735.5 23:49:09 INFO - PROCESS | 1662 | -------- Summary: end -------- 23:49:09 INFO - PROCESS | 1662 | 23:49:10 INFO - TEST-INFO | 1662: exit 0 23:49:10 INFO - TEST-OK | dromaeo_css | took 1111794ms 23:49:10 INFO - TEST-START | kraken 23:49:10 INFO - operating with platform_type : mac_ 23:49:10 INFO - Initialising browser for kraken test... 23:49:10 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpMuX0v3/profile http://localhost:49270/getInfo.html) 23:49:12 INFO - PROCESS | 1672 | 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] 23:49:13 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 23:49:13 INFO - PROCESS | 1672 | colorDepth:24 23:49:13 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 23:49:13 INFO - PROCESS | 1672 | __metrics 23:49:13 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 23:49:14 INFO - TEST-INFO | 1672: exit 0 23:49:14 INFO - Browser initialized. 23:49:14 INFO - Running cycle 1/1 for kraken test... 23:49:14 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpMuX0v3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:26 INFO - PROCESS | 1675 | RSS: Main: 247087104 23:49:26 INFO - PROCESS | 1675 | 23:49:28 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 23:49:29 INFO - PROCESS | 1675 | RSS: Main: 258965504 23:49:29 INFO - PROCESS | 1675 | 23:49:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 23:49:32 INFO - PROCESS | 1675 | RSS: Main: 267845632 23:49:32 INFO - PROCESS | 1675 | 23:49:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 23:49:36 INFO - PROCESS | 1675 | RSS: Main: 270991360 23:49:36 INFO - PROCESS | 1675 | 23:49:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 23:49:39 INFO - PROCESS | 1675 | RSS: Main: 271773696 23:49:39 INFO - PROCESS | 1675 | 23:49:41 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:49:41 INFO - PROCESS | 1675 | RSS: Main: 272375808 23:49:41 INFO - PROCESS | 1675 | 23:49:44 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 23:49:45 INFO - PROCESS | 1675 | RSS: Main: 273698816 23:49:45 INFO - PROCESS | 1675 | 23:49:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 23:49:49 INFO - PROCESS | 1675 | RSS: Main: 273772544 23:49:49 INFO - PROCESS | 1675 | 23:49:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 23:49:53 INFO - PROCESS | 1675 | RSS: Main: 274518016 23:49:53 INFO - PROCESS | 1675 | 23:49:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:49:55 INFO - PROCESS | 1675 | RSS: Main: 274071552 23:49:55 INFO - PROCESS | 1675 | 23:49:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:49:57 INFO - PROCESS | 1675 | RSS: Main: 273928192 23:49:57 INFO - PROCESS | 1675 | 23:49:59 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:50:00 INFO - PROCESS | 1675 | RSS: Main: 274173952 23:50:00 INFO - PROCESS | 1675 | 23:50:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:50:03 INFO - PROCESS | 1675 | RSS: Main: 274526208 23:50:03 INFO - PROCESS | 1675 | 23:50:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:50:06 INFO - PROCESS | 1675 | RSS: Main: 274485248 23:50:06 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 23:50:08 INFO - PROCESS | 1675 | RSS: Main: 276127744 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | __start_tp_report 23:50:08 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 23:50:08 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 23:50:08 INFO - PROCESS | 1675 | |i|pagename|runs| 23:50:08 INFO - PROCESS | 1675 | |0;ai-astar;113;105;113;112;124;127;115;116;114;115 23:50:08 INFO - PROCESS | 1675 | |1;audio-beat-detection;155;124;145;156;122;140;140;134;195;118 23:50:08 INFO - PROCESS | 1675 | |2;audio-dft;200;196;197;198;200;209;213;196;204;198 23:50:08 INFO - PROCESS | 1675 | |3;audio-fft;72;60;83;84;80;59;66;128;55;56 23:50:08 INFO - PROCESS | 1675 | |4;audio-oscillator;83;104;150;77;80;80;118;81;79;125 23:50:08 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;90;88;90;88;90;86;103;92;137;132 23:50:08 INFO - PROCESS | 1675 | |6;imaging-darkroom;114;113;91;134;89;142;91;156;153;95 23:50:08 INFO - PROCESS | 1675 | |7;imaging-desaturate;111;113;150;143;146;79;145;151;147;92 23:50:08 INFO - PROCESS | 1675 | |8;json-parse-financial;51;51;54;56;58;53;54;62;59;56 23:50:08 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;66;68;65;78;74;71;68;69;66;69 23:50:08 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;88;77;102;112;82;86;108;107;88;86 23:50:08 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;133;136;136;122;122;131;125;132;145;130 23:50:08 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;129;143;142;140;139;133;144;140;139;143 23:50:08 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;57;84;99;103;96;61;71;95;99;99 23:50:08 INFO - PROCESS | 1675 | __end_tp_report 23:50:08 INFO - PROCESS | 1675 | __start_cc_report 23:50:08 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,982 23:50:08 INFO - PROCESS | 1675 | __end_cc_report 23:50:08 INFO - PROCESS | 1675 | __startTimestamp1460011808970__endTimestamp 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | ------- Summary: start ------- 23:50:08 INFO - PROCESS | 1675 | Number of tests: 14 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:6.17 (5.4%) stddev-sans-first:6.48 23:50:08 INFO - PROCESS | 1675 | Values: 113.0 105.0 113.0 112.0 124.0 127.0 115.0 116.0 114.0 115.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:142.50 stddev:22.48 (15.8%) stddev-sans-first:23.41 23:50:08 INFO - PROCESS | 1675 | Values: 155.0 124.0 145.0 156.0 122.0 140.0 140.0 134.0 195.0 118.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:201.10 Median:200.00 stddev:5.80 (2.9%) stddev-sans-first:6.14 23:50:08 INFO - PROCESS | 1675 | Values: 200.0 196.0 197.0 198.0 200.0 209.0 213.0 196.0 204.0 198.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:74.30 Median:69.00 stddev:21.87 (31.7%) stddev-sans-first:23.18 23:50:08 INFO - PROCESS | 1675 | Values: 72.0 60.0 83.0 84.0 80.0 59.0 66.0 128.0 55.0 56.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:79.50 stddev:25.46 (32.0%) stddev-sans-first:26.44 23:50:08 INFO - PROCESS | 1675 | Values: 83.0 104.0 150.0 77.0 80.0 80.0 118.0 81.0 79.0 125.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:99.60 Median:89.00 stddev:19.00 (21.3%) stddev-sans-first:19.83 23:50:08 INFO - PROCESS | 1675 | Values: 90.0 88.0 90.0 88.0 90.0 86.0 103.0 92.0 137.0 132.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:117.80 Median:122.50 stddev:26.60 (21.7%) stddev-sans-first:28.18 23:50:08 INFO - PROCESS | 1675 | Values: 114.0 113.0 91.0 134.0 89.0 142.0 91.0 156.0 153.0 95.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:127.70 Median:148.50 stddev:26.71 (18.0%) stddev-sans-first:27.64 23:50:08 INFO - PROCESS | 1675 | Values: 111.0 113.0 150.0 143.0 146.0 79.0 145.0 151.0 147.0 92.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:3.53 (6.3%) stddev-sans-first:3.37 23:50:08 INFO - PROCESS | 1675 | Values: 51.0 51.0 54.0 56.0 58.0 53.0 54.0 62.0 59.0 56.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:4.01 (5.8%) stddev-sans-first:4.06 23:50:08 INFO - PROCESS | 1675 | Values: 66.0 68.0 65.0 78.0 74.0 71.0 68.0 69.0 66.0 69.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:84.00 stddev:12.40 (14.8%) stddev-sans-first:12.99 23:50:08 INFO - PROCESS | 1675 | Values: 88.0 77.0 102.0 112.0 82.0 86.0 108.0 107.0 88.0 86.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:132.50 stddev:7.07 (5.3%) stddev-sans-first:7.47 23:50:08 INFO - PROCESS | 1675 | Values: 133.0 136.0 136.0 122.0 122.0 131.0 125.0 132.0 145.0 130.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:141.00 stddev:4.76 (3.4%) stddev-sans-first:3.32 23:50:08 INFO - PROCESS | 1675 | Values: 129.0 143.0 142.0 140.0 139.0 133.0 144.0 140.0 139.0 143.0 23:50:08 INFO - PROCESS | 1675 | 23:50:08 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.40 Median:95.50 stddev:17.23 (18.0%) stddev-sans-first:14.62 23:50:08 INFO - PROCESS | 1675 | Values: 57.0 84.0 99.0 103.0 96.0 61.0 71.0 95.0 99.0 99.0 23:50:08 INFO - PROCESS | 1675 | -------- Summary: end -------- 23:50:08 INFO - PROCESS | 1675 | 23:50:09 INFO - TEST-INFO | 1675: exit 0 23:50:09 INFO - TEST-OK | kraken | took 59178ms 23:50:09 INFO - SUITE-END | took 1170s 23:50:10 INFO - Completed test suite (00:19:31) 23:50:10 INFO - javascript benchmark 23:50:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2930.3553218291977, 3535.929281414373, 3551.644835516447, 3570.9464358034634, 3570.982145089274, 4780.354652121962, 4888.0, 5744.885102297957, 5849.268841394825, 5909.2022576952095, 4345.956970327123, 5703.543716502681, 5821.854453638651, 5841.707914604263, 5865.442782935625, 5187.740612969355, 5209.114450543417, 5223.503767142115, 5250.868728281805, 5309.203619457074, 5289.100852855024, 5307.124324486455, 5333.546648534879, 5361.115415956382, 5376.731163441812, 5123.436421993578, 5242.81650142247, 5250.894982100374, 5258.894822103555, 5269.130593452114, 5188.299579556787, 5217.5043370880085, 5229.346331708536, 5232.241325007891, 5256.421793602701, 5121.103806833827, 5186.377634683824, 5228.9738551307, 5232.1628539433505, 5237.711925844077, 5668.631538949955, 5722.256106706143, 5785.913211301834, 5815.302163740378, 5849.795257165979, 6176.505879529627, 6201.658908760016, 6211.409916057967, 6215.316315205324, 6266.530010249249, 6124.9912799099075, 6187.195664563578, 6259.937400626027, 6275.215598050244, 6298.275698294663, 6002.51979841616, 6027.8794424111275, 6030.0, 6033.245844269466, 6087.391260873921, 6326.731786002345, 6331.430171284606, 6353.841153971188, 6354.52341074412, 6357.364263573698, 6121.483458747775, 6129.570930034944, 6159.784407545714, 6165.568410211332, 6199.442050215503, 6168.506519478431, 6237.688115594202, 6243.687815609202, 6262.655553944577, 6273.7176827042895, 6123.6486823095165, 6125.387461253839, 6128.533679014861, 6197.194364732556, 6206.193194884727, 6119.326874043852, 6136.733532366159, 6146.647737497743, 6185.783497577563, 6220.533459990519, 4141.544430112685, 4240.872773816791, 4929.383827021622, 4953.504649535018, 5003.74981250936, 4438.0, 4457.1308594823695, 4486.664303863142, 4490.348899409567, 4500.864974050718, 5679.318481782213, 5789.392113828072, 5847.44449277318, 5857.736401861926, 5883.646981181143, 6214.130021796952, 6245.18812554365, 6274.6548939808745, 6302.747890084437, 6321.462675672527, 5830.0, 5837.562182836305, 5857.853553661193, 5878.323992740804, 5921.703914804242, 4644.117617652635, 5342.198670199424, 5417.4311697272005, 5441.966026454961, 5480.7533660985355, 6372.58578192416, 6411.230652321751, 6412.9679351602945, 6419.807405777928, 6434.935650643433, 6184.567080304336, 6275.090111933835, 6295.622262664255, 6297.307296197323, 6298.275698294571, 6318.810435686937, 6319.715612797343, 6344.302126766144, 6344.587601805868, 6363.90454143179, 6198.163247961467, 6207.720652570735, 6237.563370564017, 6240.500759939103, 6271.905921411091, 6171.506279497539, 6207.0, 6266.843328916631, 6287.717052732546, 6295.087212354275, 6115.602485838406, 6176.258848938156, 6193.628382297076, 6250.031245157008, 6267.874642507033, 6202.5658203925295, 6240.687965601611, 6251.53113516479, 6265.592736472115, 6274.247090349188, 5996.340402555628, 6039.214902062704, 6089.238845144357, 6092.8781424372155, 6104.145419641165, 5031.798728050983, 5200.271961925409, 6156.830202261556, 6235.469985051322, 6242.157308763259, 5187.559057480156, 6082.2093127893095, 6101.969490152698, 6116.816495505142, 6146.815595532141], "unit": "score", "name": "dojo.html", "value": 5713.430053865306}, {"lowerIsBetter": false, "replicates": [450.2076345631687, 550.4468009650301, 563.9943600563996, 635.4598591197481, 642.585532331646, 32609.836950815243, 38432.0, 38441.0, 38502.0, 38675.80662096689, 39509.0, 39829.0, 40054.39918401226, 40174.39738403919, 40225.396619050734, 9304.627814887397, 9477.715668529921, 9531.523423828781, 9532.761680957961, 9595.0, 9358.110979456975, 9466.19537339327, 9497.287703422271, 9544.665936692218, 9625.470599117045, 9492.620295188219, 9547.427154370725, 9599.136077753, 9647.469389183592, 9656.903430965705, 9498.240140788721, 9509.857352139723, 9624.807503849954, 9642.2768292378, 9647.324687271894, 9459.52702364886, 9478.857817132748, 9531.904680953172, 9549.952250238774, 9598.088181622805, 38281.425778613346, 38528.80735596332, 38536.229275414335, 39068.60931390678, 39090.82727518179, 2515.7610027047585, 2978.3894301668106, 3167.8797279560877, 3181.8409079546163, 3352.011156708777, 27940.161795146178, 28002.859985700146, 28217.85891070552, 28546.429071418665, 28574.571381429294, 2737.835729856195, 2804.5652923796843, 2835.0927703135003, 2843.1044221070297, 2897.4060317634835, 330210.3489482561, 331226.0, 333380.0, 334990.0, 335246.64753352397, 57635.84728305411, 65939.0, 67499.0, 67672.6616366915, 67972.660136699, 64333.356666433676, 64661.67669161624, 64977.675111624136, 65054.34945650578, 65632.0, 16478.0, 16566.917165414336, 16665.666686666198, 16694.916525417295, 16729.91635041817, 12693.301868397142, 12704.237745735285, 12718.872811271955, 12929.741405171844, 12946.96424286055, 20132.19471221164, 20893.0, 21030.263940762, 21062.47343816417, 21131.366059018255, 8383.371247156487, 8589.828203436022, 8595.828083438297, 8608.741737747878, 8623.0, 888.1473785166183, 991.9702408927744, 1001.9098281154731, 1021.2238698588977, 1027.5941003303653, 27099.86450067737, 29848.55227171594, 29930.85034574813, 30423.391532169233, 30607.693923060484, 915.3729695158837, 1065.5577935156978, 1071.2180108520824, 1085.2240647936605, 1138.7132540229488, 11370.715732106764, 14253.171497644784, 14399.64000899965, 14509.347079381454, 14664.706705865823, 602967.0, 613486.0, 615294.0, 618693.0, 621240.0, 49373.50626493761, 59268.70365648231, 59536.34404731543, 59750.51871109684, 59756.80486390248, 1222.8043513037871, 1394.9093308934887, 1439.172475826404, 1472.7864459653076, 1474.9778753318708, 23218.535629287657, 24715.011399544535, 27136.864315678296, 27806.582901256093, 28183.71816281811, 48570.54288371355, 49147.01705965789, 49282.50717492779, 49318.520444386726, 49368.75315623399, 486623.0, 489238.0, 491915.0, 492289.0, 492677.0, 32948.67051329552, 43069.35395969126, 43906.780466097465, 44211.0, 44597.55402445934, 39539.209215816096, 41272.0, 41871.7906410466, 46615.533844662474, 47910.52089479061, 36995.815020924725, 37145.81427092847, 37413.438798417505, 37433.064173395884, 37764.0, 36096.639033609325, 36306.636933630325, 36927.63072369242, 36928.26143477062, 37043.444348334255, 36891.8155409232, 37444.0, 37638.0, 37865.053373665876, 38773.2245355097, 30569.54145687772, 31479.52780708337, 31509.0, 31592.526112107877, 31699.0, 23808.40478988039, 24599.50800984006, 24624.50750985006, 25047.749522504542, 25094.62358064594], "unit": "score", "name": "ext.html", "value": 19590.978236337618}, {"lowerIsBetter": false, "replicates": [353.6286898756307, 359.9442086476597, 366.34241536442084, 366.58575809335457, 367.1995050789278, 19481.902590487047, 19798.505037374074, 20671.379858604265, 21009.894950525228, 21118.57762844744, 11931.58239461619, 12319.445624946877, 12322.630321090382, 12329.136960412774, 12348.4443200056, 5170.999999999991, 5417.918731219015, 5692.999999999979, 6628.933710662904, 6675.098861653688, 6578.6381749003785, 6579.17760279965, 6594.736210551596, 6623.105880706115, 6626.13860198176, 6315.368463153671, 6523.412892839643, 6566.8686626267445, 6603.900941485882, 6630.3701148391065, 6147.354527774564, 6425.421712045915, 6429.099926010339, 6440.4203621673805, 6451.83870403239, 5629.8592535186535, 5711.657300561979, 5717.171010203498, 5729.684867332295, 5749.568782341341, 13452.260125693083, 13515.662108447368, 13840.61593840608, 17713.29146834125, 25232.612206328646, 1996.0618509300605, 2015.7581090269116, 2117.851750377474, 2190.441437433444, 2750.2986738381583, 9633.759156021086, 9647.903520964841, 9898.802023959552, 10060.346077504939, 10196.74508137295, 1689.358043943306, 1715.7169067104037, 1720.4494561740248, 1755.6576467588825, 1755.8068612452748, 93087.06912930851, 95061.0, 101225.97548049071, 103308.48345758223, 104432.95567044384, 10887.346759194315, 11006.779864402668, 11037.006669399792, 11173.273737207055, 11339.262947908359, 13404.664883377798, 13637.0, 13721.725565488634, 13726.382312795748, 13822.23977681217, 8364.874526882102, 8460.703875364332, 8529.402941794138, 8556.358273129541, 8646.221840034426, 8509.489430634181, 8633.827323453495, 8662.91337086621, 8685.869711954325, 8761.737147885573, 4344.804483798237, 4388.012697143181, 4392.209402307615, 4426.424564806554, 4447.799849006802, 1829.3140072472822, 1867.7478540396874, 1870.1864688860117, 1880.6332765110947, 1883.2561138350275, 859.6647307550061, 886.3086792302015, 958.3435346787334, 960.9807803843884, 993.7913038262046, 19242.615147696968, 19808.20767169326, 19880.50298742514, 19962.702424342373, 20148.899255503628, 760.7793739815502, 781.9061712594525, 843.4306842881153, 942.4109931292942, 1011.7470632341915, 8623.741287761377, 8639.704044393391, 9718.951405242928, 10278.434686092187, 10793.571446424492, 599634.0, 604507.0, 610146.0, 617823.0, 618463.0, 80677.0, 81820.77268840972, 100006.49977250761, 109821.45089274502, 110281.0, 981.0728861226073, 983.3362480325751, 1004.3672486333709, 1008.8385858262643, 1010.237270860481, 17595.736063959306, 17712.025838578487, 17960.910195448938, 18053.548661283574, 18063.458096257134, 47075.05849883052, 48195.75902120467, 49574.51276461712, 50552.4723763803, 51790.705232369495, 69598.65200673965, 70023.0, 70749.0, 71116.0, 72060.55878882497, 6173.629582225081, 7458.03045604068, 7519.699212031457, 7633.618319083913, 7712.344450721752, 9819.16537094355, 9835.459049752046, 11915.106367022681, 11959.641210763692, 12188.878111218773, 10232.795344093225, 10385.376877387382, 10428.947855260674, 10570.894291056991, 10600.204984626029, 10238.488075596339, 10238.590456381662, 10421.531031103466, 10497.317674351143, 10563.207759418228, 10361.74095647615, 10655.0, 10780.353178809297, 11018.889811102106, 11051.281666691639, 7553.169151393233, 7583.469157158946, 7593.620318983918, 7613.809654758676, 7682.769516914502, 10236.232282578687, 10524.36853788775, 10792.838107428552, 10854.240203185702, 10872.293300935415], "unit": "score", "name": "jquery.html", "value": 8986.003781763733}, {"lowerIsBetter": false, "replicates": [1582.9445969391074, 1587.5316781549438, 1862.2923289150121, 1961.6174845905045, 1968.1832039703525, 8121.187881211876, 8760.430572012814, 8780.517071561062, 8975.057618950006, 9012.008679045308, 8720.95639521803, 8740.72741087317, 8762.474251544912, 8880.156385143417, 8883.244924181436, 2425.34515680767, 2455.26342097371, 2467.642191882176, 2477.9628305575343, 2479.2438306316567, 2393.922734769361, 2428.162284012013, 2488.950220995579, 2500.72492025877, 2520.2943175910773, 2475.814313926454, 2497.5254701606727, 2520.2565243253284, 2521.042004038463, 2528.683914510686, 2452.8896199670967, 2476.319012271622, 2492.7881130103874, 2505.7744802967727, 2514.8994040238367, 2112.725345705064, 2480.8015358771436, 2495.6506089147533, 2501.4746903150362, 2524.507720994407, 8165.8366832663605, 8363.958180209122, 8902.599383027715, 8956.507392093432, 8987.775305617346, 5490.3411590608985, 5548.611597188158, 5605.467480589337, 5650.378458369576, 5650.943490565083, 3196.536502207167, 3513.1744040150543, 3616.27674465108, 3634.3276493848457, 3665.706743460517, 882.1839798186652, 980.6711905368195, 997.0478193325357, 1024.7950409917971, 1039.6205385034484, 10167.89832101677, 12098.334591597459, 12378.381080945917, 12383.257004579664, 12403.565875194325, 4919.77860996256, 4936.703797772145, 4994.525520075587, 4998.975005125024, 5056.7610935320345, 8799.91200087991, 10172.186225101974, 10260.538275777608, 10293.0, 10343.172546196287, 5375.892482150413, 5397.2443857859935, 5485.17722341644, 5555.694436805934, 5575.2473416088305, 4367.432233809584, 4468.843590474317, 4511.684182107287, 4983.626228032912, 5011.57401620859, 3390.1524618845287, 3913.354296541039, 3933.370660694275, 3982.820773065219, 4009.9373665978537, 1328.435414948643, 1345.3744009035845, 1347.8947263244045, 1352.4236329791763, 1354.7561438940888, 1319.617310979805, 1350.338334216227, 1374.0381732786889, 1394.7001394700187, 1405.5783265020452, 8195.057568379594, 8214.342852571779, 8218.794530136674, 8222.506649600924, 8250.298724608356, 509.9260607211933, 510.532862430879, 513.4813838023623, 518.9014087323396, 521.0438844719981, 6242.531810114259, 6246.031865060922, 6282.874342513124, 6306.463950564162, 6311.431971122529, 10654.680359589225, 10725.83911241332, 11072.335659860435, 11102.888971110347, 11125.443727813577, 9056.320775941698, 10412.68761937143, 10547.314424562379, 10911.83632245517, 10952.123830093573, 8469.703560375357, 8472.703455379033, 8481.745547633582, 8482.533460659599, 8543.871841922377, 6501.512386570931, 7214.71141154348, 7446.813829654302, 7983.8802417964935, 8008.27925486709, 9443.244540436886, 9753.0, 9757.0, 9834.459104749307, 9853.605855765976, 9898.604055837686, 10006.299559030798, 10070.19438444908, 10182.796344072929, 10201.897981020391, 6735.966320168368, 7269.854602908018, 7530.171681114964, 7557.5465472071855, 7621.31408173267, 8287.0, 8385.790355241168, 8412.537310447984, 8421.989361276686, 8430.662773488992, 7259.419246460165, 7266.418686505172, 7372.59450730215, 7483.363914067365, 7508.986286851424, 7228.132624085143, 7315.30504602062, 7355.411567074728, 7413.443991700537, 7421.332080112816, 7573.129090154483, 7589.6584653689615, 7603.581803000667, 7639.388848892187, 7707.229277072248, 6970.128733908262, 6974.930250697428, 7055.611941343275, 7077.752278670222, 7122.857542849218, 7054.506184567031, 7115.964420177866, 7151.4636402269, 7216.675249613675, 7217.963910180415], "unit": "score", "name": "mootools.html", "value": 4865.547202465463}, {"lowerIsBetter": false, "replicates": [324.024685696055, 325.18541054658084, 326.99346013079753, 334.56005352960847, 335.69284105043903, 5698.487136157745, 6623.37077977592, 6769.695363708633, 6813.591184528932, 6834.555753875995, 6682.599044057348, 6682.665866706658, 6697.564658297208, 6709.060731497594, 6776.0, 3803.467514547952, 4823.42118945727, 4943.629227807911, 4950.529699678543, 4980.352554167953, 4894.3147959285725, 4928.901421971558, 4929.162042452774, 4929.753512324387, 4935.876603084916, 4819.855404337858, 4883.0, 4887.584555312785, 4892.3639926809465, 4914.483979182188, 4894.0, 4895.412550493946, 4902.509749025105, 4905.411350637928, 4920.852374428755, 4235.53409124996, 4244.66042716585, 4251.489821221442, 4253.553376895412, 4276.978615106936, 5222.660527065728, 6286.151369565142, 6375.617462952191, 6461.93538064618, 6520.413772425147, 5933.703314834241, 5972.522198224132, 5974.820755377345, 6006.12911127884, 6012.639241645472, 5191.8182863599595, 7188.2811718828225, 7251.419886409075, 7253.601051942141, 7265.636718164071, 4799.2321228603605, 4802.447718512381, 4811.13399588074, 4819.228923372279, 4823.43238447506, 6206.937930620681, 7687.884681729778, 7691.846163076763, 7693.230676932318, 7717.768466945944, 4183.769892655933, 4524.479684836286, 4579.290210017452, 4877.268409738496, 4898.093852637274, 3981.3629819228786, 4375.190589740908, 4830.203016502308, 4830.468648448667, 4842.539958703917, 4854.708717476963, 5714.714264286769, 5816.621919575214, 5827.533797296291, 5844.26946631671, 7321.597312147776, 7323.450741194431, 7333.449991250677, 7342.853142937111, 7346.302101300368, 1464.4142343062647, 1612.5565469495982, 1644.9753253700965, 1667.6998140334613, 1671.4233589411633, 1014.60937539048, 1046.4506134279563, 1058.7353161709573, 1059.2585190366774, 1066.1311031509294, 6739.764108256286, 6773.1872175338285, 6790.287019862942, 6792.63764436607, 6813.182418109858, 7560.886586701204, 7600.46796724224, 7610.581418021951, 7629.732959346507, 7651.120121186135, 5564.582656300794, 6533.150690410216, 6586.440152586988, 6776.15298087739, 6791.0153027811675, 3988.900277493086, 3999.8200080996426, 4017.8593749218635, 4019.773968939443, 4022.2357752027606, 7929.563873986871, 7931.405144614062, 7931.643076061591, 7938.6030698466, 7942.285194332422, 7408.555331710372, 7827.099883513355, 7877.921220787719, 7892.092409372881, 7945.960270198612, 6494.350564943562, 6507.861124303228, 7881.133075361706, 7936.84126317482, 8017.358611311081, 7556.697732090654, 7657.0, 7673.040869891263, 7673.53958762476, 7679.2704693054075, 7502.887456688045, 7510.061242344707, 7512.699492020477, 7515.511491753018, 7548.509346892434, 7651.655675494728, 7925.682972681258, 7938.841223175619, 7962.482438641469, 7978.521288722695, 4666.533346665306, 4677.462091859344, 4715.457722361835, 4720.858374248778, 4735.952640473552, 7584.848303033798, 7606.125295591078, 7613.238676132342, 7616.619169041636, 7633.427492937941, 5605.719714014364, 7355.889661654973, 7376.114866215874, 7378.5941773202985, 7382.187959324578, 7044.471664625071, 7343.559386436617, 7365.300296471826, 7407.111146662435, 7418.36943859778, 7160.570365777861, 7182.3535881770895, 7203.675834587351, 7214.783556493314, 7215.350618444365, 7362.042934418491, 7374.815629609303, 7377.77866664001, 7381.077365329334, 7435.851282974419, 5505.9724701376235, 7090.397316227972, 7166.319199676022, 7175.103112110986, 7226.89159662616], "unit": "score", "name": "prototype.html", "value": 5247.607121669345}, {"lowerIsBetter": false, "replicates": [557.1447827584656, 634.2420807135469, 644.5939058393211, 674.554793836068, 687.2543290529774, 13673.589792306222, 14432.422703091877, 14631.268436578155, 14704.852951470482, 14707.558773236806, 11051.392173430459, 15314.081155130672, 15583.0, 15583.454579089734, 15622.453214137508, 728.6429649471747, 886.6364790435922, 892.9330300227476, 908.6138391183754, 910.8087301666658, 898.2993265253114, 899.4603238057146, 899.6581299106331, 900.7703035725881, 902.3503077784018, 940.3229674634287, 945.470536499559, 954.4225743425231, 958.8561715742625, 961.3126614470652, 942.6559305853349, 946.7869729310919, 951.5813042261452, 953.5851904421598, 953.952302384878, 698.8322802527408, 708.1219288082792, 708.5465302206592, 708.8298808286025, 712.6828561290228, 14904.478343257933, 14978.850211497855, 15084.24578771068, 15102.622434439118, 15150.0, 12260.570880019246, 12277.57028504007, 12383.93808030963, 12436.875631243753, 12516.81224781629, 8353.540555269457, 9781.642820771393, 9883.258755593288, 9939.353941993748, 10226.335288206243, 2930.5018146915077, 3399.8640054397792, 3432.2792213635166, 3495.580530336376, 3553.5558055243096, 77878.6106069466, 78631.606841966, 79126.20873791246, 79588.60205698934, 80235.0, 9183.448993060438, 9196.678116265899, 9244.260459163252, 9265.768355791024, 9383.24934005278, 20764.792352076285, 20765.480862978548, 21308.893455532623, 21340.146394144373, 21423.357299281048, 7034.507584469038, 7092.609906455092, 7254.673539690727, 7292.19785823559, 7374.778756637309, 3096.690330966885, 3996.1208534122447, 4007.699422543321, 4018.6985976051915, 4031.07285324377, 3498.527698760686, 3508.3509550733197, 3515.472679098156, 3534.3638145134123, 3544.521489598923, 606.2724730323541, 607.5655906027212, 608.5405518833342, 617.1360095865824, 619.789271647633, 508.84480233529126, 522.7271593669427, 522.9111051121318, 534.7860356989612, 570.0565563991601, 7604.315611594983, 7652.502587331805, 8187.754367368989, 8213.630386632616, 8365.564815183989, 562.2381672833334, 568.2697733412544, 594.067314316519, 598.9730462129214, 612.9417705317987, 3664.3953747631344, 3698.389765688685, 3929.7445666031617, 4099.651529619956, 4190.308599081179, 86538.26923461496, 88250.0, 89412.5529372349, 89596.55201723949, 90028.0, 64978.35021649723, 66480.66759666268, 77581.61209193918, 77859.61070194613, 78840.6057969718, 49696.751516242184, 63039.369606304266, 67770.0, 67810.0, 70660.64669676618, 8473.57632118404, 8475.194856488624, 8505.659773608986, 8520.872186917077, 8527.232549070613, 48020.51979480161, 50103.24845127399, 50448.49551504438, 50603.2409513865, 52239.73880130575, 62767.0, 66081.66959165173, 66925.0, 67389.3261067383, 67915.66042169757, 10302.690919272434, 10317.27779055459, 10689.251752377259, 10790.67627971162, 10915.727106822393, 11894.940525297317, 12003.1597788154, 12012.279263244232, 12034.217775844541, 12060.336681482602, 11374.0, 11443.828342575034, 11594.956453919187, 11666.70833229176, 11756.529738810352, 11239.0, 11264.887351126385, 11409.20135590534, 11421.029212517029, 11704.94147529257, 10969.23215374916, 11002.779944400907, 11081.667549973514, 11123.27698699582, 11406.258593191416, 9323.86014209801, 9387.530623468936, 9445.858312125461, 9532.523373831142, 9646.951765241129, 8587.484750914715, 8702.608382622671, 9099.363044586815, 9650.758731031781, 9735.513224338896], "unit": "score", "name": "yui.html", "value": 6745.8056931680285}], "name": "dromaeo_css", "value": 7466.436827191697}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 113.0, 112.0, 124.0, 127.0, 115.0, 116.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 145.0, 156.0, 122.0, 140.0, 140.0, 134.0, 195.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [200.0, 196.0, 197.0, 198.0, 200.0, 209.0, 213.0, 196.0, 204.0, 198.0], "unit": "score", "name": "audio-dft", "value": 201.1}, {"lowerIsBetter": true, "replicates": [72.0, 60.0, 83.0, 84.0, 80.0, 59.0, 66.0, 128.0, 55.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.3}, {"lowerIsBetter": true, "replicates": [83.0, 104.0, 150.0, 77.0, 80.0, 80.0, 118.0, 81.0, 79.0, 125.0], "unit": "score", "name": "audio-oscillator", "value": 97.7}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 90.0, 88.0, 90.0, 86.0, 103.0, 92.0, 137.0, 132.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.6}, {"lowerIsBetter": true, "replicates": [114.0, 113.0, 91.0, 134.0, 89.0, 142.0, 91.0, 156.0, 153.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 117.8}, {"lowerIsBetter": true, "replicates": [111.0, 113.0, 150.0, 143.0, 146.0, 79.0, 145.0, 151.0, 147.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 127.7}, {"lowerIsBetter": true, "replicates": [51.0, 51.0, 54.0, 56.0, 58.0, 53.0, 54.0, 62.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 65.0, 78.0, 74.0, 71.0, 68.0, 69.0, 66.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [88.0, 77.0, 102.0, 112.0, 82.0, 86.0, 108.0, 107.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.6}, {"lowerIsBetter": true, "replicates": [133.0, 136.0, 136.0, 122.0, 122.0, 131.0, 125.0, 132.0, 145.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.2}, {"lowerIsBetter": true, "replicates": [129.0, 143.0, 142.0, 140.0, 139.0, 133.0, 144.0, 140.0, 139.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [57.0, 84.0, 99.0, 103.0, 96.0, 61.0, 71.0, 95.0, 99.0, 99.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 86.4}], "name": "kraken", "value": 1551.7000000000003}]} 23:50:10 INFO - Return code: 0 23:50:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:50:10 ERROR - # TBPL SUCCESS # 23:50:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:50:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:50:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:50:10 INFO - 2016-04-06 23:50:10.255 screenresolution[1680:10681] starting screenresolution argv=screenresolution get 23:50:10 INFO - 2016-04-06 23:50:10.257 screenresolution[1680:10681] Display 0: 1600x1200x32@60 23:50:10 INFO - 2016-04-06 23:50:10.263 screenresolution[1681:10684] starting screenresolution argv=screenresolution list 23:50:10 INFO - Available Modes on Display 0 23:50:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:50:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:50:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:50:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:50:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:50:10 INFO - Intel Iris: 23:50:10 INFO - Chipset Model: Intel Iris 23:50:10 INFO - Type: GPU 23:50:10 INFO - Bus: Built-In 23:50:10 INFO - VRAM (Dynamic, Max): 1536 MB 23:50:10 INFO - Vendor: Intel (0x8086) 23:50:10 INFO - Device ID: 0x0a2e 23:50:10 INFO - Revision ID: 0x0009 23:50:10 INFO - Displays: 23:50:10 INFO - Display: 23:50:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:50:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:50:10 INFO - Display Serial Number: 1600x1200 60 23:50:10 INFO - Main Display: Yes 23:50:10 INFO - Mirror: Off 23:50:10 INFO - Online: Yes 23:50:10 INFO - Rotation: Supported 23:50:10 INFO - Return code: 0 23:50:10 INFO - Running post-action listener: _resource_record_post_action 23:50:10 INFO - Running post-run listener: _resource_record_post_run 23:50:11 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 37582336; Write bytes: 699211264; Read time: 449; Write time: 1945 23:50:11 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 393216512; Write bytes: 394971136; Read time: 29870; Write time: 703 23:50:11 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 35767808; Write bytes: 303343104; Read time: 384; Write time: 1240 23:50:11 INFO - Running post-run listener: _upload_blobber_files 23:50:11 INFO - Blob upload gear active. 23:50:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:50:11 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 23:50:11 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'] 23:50:11 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 23:50:11 INFO - (blobuploader) - INFO - Open directory for files ... 23:50:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:50:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:50:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:12 INFO - (blobuploader) - INFO - Done attempting. 23:50:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:50:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:50:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:13 INFO - (blobuploader) - INFO - Done attempting. 23:50:13 INFO - (blobuploader) - INFO - Iteration through files over. 23:50:13 INFO - Return code: 0 23:50:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:50:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:50:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99fccdee524e917e8e0b00c6a9074de1472f237d768317f470e112bae43de9fdad4f2261f7a6a9a7d67d5d52e28f83b7d9581ef2f1148f13fa5d167a58e7acb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/544019f9d66dacbc19d6612569edd1ef9780712b74211b4fe5b7f1832d4371a686fb0b7981af96b1efd77f660e2d87f67c17a4b441237cccd08094b1b7a0aae3"} 23:50:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:50:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:50:13 INFO - Contents: 23:50:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99fccdee524e917e8e0b00c6a9074de1472f237d768317f470e112bae43de9fdad4f2261f7a6a9a7d67d5d52e28f83b7d9581ef2f1148f13fa5d167a58e7acb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/544019f9d66dacbc19d6612569edd1ef9780712b74211b4fe5b7f1832d4371a686fb0b7981af96b1efd77f660e2d87f67c17a4b441237cccd08094b1b7a0aae3"} 23:50:13 INFO - Running post-run listener: copy_logs_to_upload_dir 23:50:13 INFO - Copying logs to upload dir... 23:50:13 INFO - mkdir: /builds/slave/test/build/upload/logs 23:50:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.983194 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-06 23:50:13.820556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 23:50:13.824096) ========= 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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/99fccdee524e917e8e0b00c6a9074de1472f237d768317f470e112bae43de9fdad4f2261f7a6a9a7d67d5d52e28f83b7d9581ef2f1148f13fa5d167a58e7acb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/544019f9d66dacbc19d6612569edd1ef9780712b74211b4fe5b7f1832d4371a686fb0b7981af96b1efd77f660e2d87f67c17a4b441237cccd08094b1b7a0aae3"} build_url:https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/crAfJHbMTmGicexM5BuyWA/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/99fccdee524e917e8e0b00c6a9074de1472f237d768317f470e112bae43de9fdad4f2261f7a6a9a7d67d5d52e28f83b7d9581ef2f1148f13fa5d167a58e7acb4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/544019f9d66dacbc19d6612569edd1ef9780712b74211b4fe5b7f1832d4371a686fb0b7981af96b1efd77f660e2d87f67c17a4b441237cccd08094b1b7a0aae3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 23:50:13.864876) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:50:13.865238) ========= 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.G4kmFVydQ7/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.IJzmRKKzgU/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005210 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:50:13.919456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 23:50:13.919777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 23:50:13.920164) ========= ========= Total master_lag: 25.43 =========