builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0110 starttime: 1458215104.84 results: success (0) buildid: 20160317030120 builduid: d058884754a04770ae326ee125094ce2 revision: fefe2bc3e54fa101dc12e2858546ab5df2ee6d20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:04.843528) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:04.843981) ========= ========= Started set props: basedir (results: 0, elapsed: 7 secs) (at 2016-03-17 04:45:04.844268) ========= 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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.005527 basedir: '/builds/slave/test' ========= master_lag: 7.73 ========= ========= Finished set props: basedir (results: 0, elapsed: 7 secs) (at 2016-03-17 04:45:12.575948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 17 secs) (at 2016-03-17 04:45:12.576467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 17 secs) (at 2016-03-17 04:45:30.013979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 04:45:30.014252) ========= 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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.006389 ========= master_lag: 1.42 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 04:45:31.436604) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:31.439924) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:31.440292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 04:45:31.440564) ========= 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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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-03-17 04:45:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-03-17 04:45:32 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.588690 ========= master_lag: 1.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 04:45:33.331115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:33.331393) ========= 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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.026454 ========= master_lag: 0.38 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:33.741238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:33.741554) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fefe2bc3e54fa101dc12e2858546ab5df2ee6d20 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fefe2bc3e54fa101dc12e2858546ab5df2ee6d20 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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-03-17 04:45:33,826 truncating revision to first 12 chars 2016-03-17 04:45:33,826 Setting DEBUG logging. 2016-03-17 04:45:33,826 attempt 1/10 2016-03-17 04:45:33,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fefe2bc3e54f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 04:45:34,505 unpacking tar archive at: mozilla-central-fefe2bc3e54f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.920639 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:34.697025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:34.697361) ========= echo fefe2bc3e54fa101dc12e2858546ab5df2ee6d20 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fefe2bc3e54fa101dc12e2858546ab5df2ee6d20'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 fefe2bc3e54fa101dc12e2858546ab5df2ee6d20 program finished with exit code 0 elapsedTime=0.005539 script_repo_revision: 'fefe2bc3e54fa101dc12e2858546ab5df2ee6d20' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:34.755448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:34.755791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 04:45:34.798095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2016-03-17 04:45:34.798498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:45:34 INFO - MultiFileLogger online at 20160317 04:45:34 in /builds/slave/test 04:45:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:45:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:34 INFO - {'append_to_log': False, 04:45:34 INFO - 'base_work_dir': '/builds/slave/test', 04:45:34 INFO - 'blob_upload_branch': 'Firefox', 04:45:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:34 INFO - 'branch': 'Firefox', 04:45:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:34 INFO - 'config_files': ('talos/mac_config.py',), 04:45:34 INFO - 'default_actions': ('clobber', 04:45:34 INFO - 'read-buildbot-config', 04:45:34 INFO - 'download-and-extract', 04:45:34 INFO - 'populate-webroot', 04:45:34 INFO - 'create-virtualenv', 04:45:34 INFO - 'install', 04:45:34 INFO - 'run-tests'), 04:45:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:34 INFO - 'download_minidump_stackwalk': True, 04:45:34 INFO - 'download_symbols': 'ondemand', 04:45:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:34 INFO - 'installer_path': 'installer.exe', 04:45:34 INFO - 'log_level': 'info', 04:45:34 INFO - 'log_name': 'talos', 04:45:34 INFO - 'log_to_console': True, 04:45:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:45:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:45:34 INFO - 'opt_config_files': (), 04:45:34 INFO - 'pip_index': False, 04:45:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:34 INFO - 'cmd': ('bash', 04:45:34 INFO - '-c', 04:45:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:34 INFO - 'enabled': True, 04:45:34 INFO - 'halt_on_failure': False, 04:45:34 INFO - 'name': 'check_screen_resolution'},), 04:45:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:34 INFO - 'cmd': ('bash', 04:45:34 INFO - '-c', 04:45:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:34 INFO - 'enabled': True, 04:45:34 INFO - 'halt_on_failure': False, 04:45:34 INFO - 'name': 'check_screen_resolution'},), 04:45:34 INFO - 'run_cmd_checks_enabled': True, 04:45:34 INFO - 'sps_profile': False, 04:45:34 INFO - 'sps_profile_interval': 0, 04:45:34 INFO - 'suite': 'dromaeojs-e10s', 04:45:34 INFO - 'system_bits': '32', 04:45:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:34 INFO - 'title': 't-yosemite-r7-0110', 04:45:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:34 INFO - 'use_talos_json': True, 04:45:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:34 INFO - 'work_dir': 'build'} 04:45:34 INFO - ##### 04:45:34 INFO - ##### Running clobber step. 04:45:34 INFO - ##### 04:45:34 INFO - Running pre-action listener: _resource_record_pre_action 04:45:34 INFO - Running main action method: clobber 04:45:34 INFO - rmtree: /builds/slave/test/build 04:45:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:36 INFO - Running post-action listener: _resource_record_post_action 04:45:36 INFO - ##### 04:45:36 INFO - ##### Running read-buildbot-config step. 04:45:36 INFO - ##### 04:45:36 INFO - Running pre-action listener: _resource_record_pre_action 04:45:36 INFO - Running main action method: read_buildbot_config 04:45:36 INFO - Using buildbot properties: 04:45:36 INFO - { 04:45:36 INFO - "project": "", 04:45:36 INFO - "product": "firefox", 04:45:36 INFO - "script_repo_revision": "production", 04:45:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:45:36 INFO - "repository": "", 04:45:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:45:36 INFO - "buildid": "20160317030120", 04:45:36 INFO - "pgo_build": "False", 04:45:36 INFO - "basedir": "/builds/slave/test", 04:45:36 INFO - "buildnumber": 209, 04:45:36 INFO - "slavename": "t-yosemite-r7-0110", 04:45:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:45:36 INFO - "platform": "yosemite_r7", 04:45:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:45:36 INFO - "branch": "mozilla-central", 04:45:36 INFO - "repo_path": "mozilla-central", 04:45:36 INFO - "revision": "fefe2bc3e54fa101dc12e2858546ab5df2ee6d20", 04:45:36 INFO - "stage_platform": "macosx64", 04:45:36 INFO - "builduid": "d058884754a04770ae326ee125094ce2", 04:45:36 INFO - "slavebuilddir": "test" 04:45:36 INFO - } 04:45:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:45:36 INFO - Running post-action listener: _resource_record_post_action 04:45:36 INFO - ##### 04:45:36 INFO - ##### Running download-and-extract step. 04:45:36 INFO - ##### 04:45:36 INFO - Running pre-action listener: _resource_record_pre_action 04:45:36 INFO - Running main action method: download_and_extract 04:45:36 INFO - mkdir: /builds/slave/test/build/tests 04:45: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')]} 04:45:36 INFO - https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:40 INFO - Downloaded 1199 bytes. 04:45:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:45:40 INFO - Using the following test package requirements: 04:45:40 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:45:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:45:40 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:45:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:45:40 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:45:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:45:40 INFO - u'jsshell-mac.zip'], 04:45:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:45:40 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:45:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:45:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:45:40 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:45:40 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:45:40 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:45:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:45:40 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:45:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:45:40 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:45:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:40 INFO - https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:41 INFO - Downloaded 17870537 bytes. 04:45:41 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'] 04:45:41 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 04:45:44 INFO - Return code: 0 04:45:44 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 04:45: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')]} 04:45:44 INFO - https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:45:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:45:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:45:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:50 INFO - Downloaded 17870537 bytes. 04:45:50 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'] 04:45:50 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 04:45:53 INFO - Return code: 0 04:45:53 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')]} 04:45:53 INFO - https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:45:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:45:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:45:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:54 INFO - Downloaded 10846565 bytes. 04:45:54 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'] 04:45:54 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 04:45:55 INFO - Return code: 0 04:45: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')]} 04:45:55 INFO - https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:45:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:45:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:45:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:45:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwghgXLHT6O1Fi3uQMEkug/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 04:45:57 INFO - Downloaded 111216162 bytes. 04:45:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:45:57 INFO - mkdir: /builds/slave/test/properties 04:45:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:57 INFO - Contents: 04:45:57 INFO - build_url:https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:45:59 INFO - Running post-action listener: _resource_record_post_action 04:45:59 INFO - Running post-action listener: set_extra_try_arguments 04:45:59 INFO - ##### 04:45:59 INFO - ##### Running populate-webroot step. 04:45:59 INFO - ##### 04:45:59 INFO - Running pre-action listener: _resource_record_pre_action 04:45:59 INFO - Running main action method: populate_webroot 04:45:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:59 INFO - '--tppagecycles', 04:45:59 INFO - '7'], 04:45:59 INFO - 'tests': ['tsvgm']}}, 04:45:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:45:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:45:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:59 INFO - 'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:59 INFO - 'tests': ['damp', 'tps']}, 04:45:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:59 INFO - 'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['damp', 'tps']}, 04:45:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:45:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:59 INFO - 'other': {'tests': ['a11yr', 04:45:59 INFO - 'ts_paint', 04:45:59 INFO - 'tpaint', 04:45:59 INFO - 'sessionrestore', 04:45:59 INFO - 'sessionrestore_no_auto_restore', 04:45:59 INFO - 'tabpaint']}, 04:45:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['a11yr', 04:45:59 INFO - 'ts_paint', 04:45:59 INFO - 'tpaint', 04:45:59 INFO - 'sessionrestore', 04:45:59 INFO - 'sessionrestore_no_auto_restore', 04:45:59 INFO - 'tabpaint']}, 04:45:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['a11yr', 04:45:59 INFO - 'ts_paint', 04:45:59 INFO - 'tpaint', 04:45:59 INFO - 'sessionrestore', 04:45:59 INFO - 'sessionrestore_no_auto_restore', 04:45:59 INFO - 'tabpaint']}, 04:45:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['a11yr', 04:45:59 INFO - 'ts_paint', 04:45:59 INFO - 'tpaint', 04:45:59 INFO - 'sessionrestore', 04:45:59 INFO - 'sessionrestore_no_auto_restore', 04:45:59 INFO - 'tabpaint']}, 04:45:59 INFO - 'other_l64': {'tests': ['a11yr', 04:45:59 INFO - 'ts_paint', 04:45:59 INFO - 'tpaint', 04:45:59 INFO - 'sessionrestore', 04:45:59 INFO - 'sessionrestore_no_auto_restore', 04:45:59 INFO - 'tabpaint']}, 04:45:59 INFO - 'other_nol64': {'tests': ['a11yr', 04:45:59 INFO - 'ts_paint', 04:45:59 INFO - 'tpaint', 04:45:59 INFO - 'sessionrestore', 04:45:59 INFO - 'sessionrestore_no_auto_restore', 04:45:59 INFO - 'tabpaint']}, 04:45:59 INFO - 'svgr': {'tests': ['tsvgx', 04:45:59 INFO - 'tsvgr_opacity', 04:45:59 INFO - 'tart', 04:45:59 INFO - 'tscrollx', 04:45:59 INFO - 'cart']}, 04:45:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['tsvgx', 04:45:59 INFO - 'tsvgr_opacity', 04:45:59 INFO - 'tart', 04:45:59 INFO - 'tscrollx', 04:45:59 INFO - 'cart']}, 04:45:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:59 INFO - 'tests': ['tp5o']}, 04:45:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:59 INFO - 'talos_options': ['--e10s'], 04:45:59 INFO - 'tests': ['tp5o']}, 04:45:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:59 INFO - 'talos_options': ['--xperf_path', 04:45:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:59 INFO - 'tests': ['tp5n']}, 04:45:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:59 INFO - 'talos_options': ['--e10s', 04:45:59 INFO - '--xperf_path', 04:45:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:59 INFO - 'tests': ['tp5n']}}, 04:45:59 INFO - 'talos.zip': {'path': '', 04:45:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:59 INFO - Running post-action listener: _resource_record_post_action 04:45:59 INFO - ##### 04:45:59 INFO - ##### Running create-virtualenv step. 04:45:59 INFO - ##### 04:45:59 INFO - Running pre-action listener: _resource_record_pre_action 04:45:59 INFO - Running main action method: create_virtualenv 04:45:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:59 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 04:45:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:59 INFO - Using real prefix '/tools/python27' 04:45:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:03 INFO - Installing pip.................done. 04:46:03 INFO - Return code: 0 04:46:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:03 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 04:46:03 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 04:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:03 INFO - 'HOME': '/Users/cltbld', 04:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:03 INFO - 'LOGNAME': 'cltbld', 04:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:03 INFO - 'MOZ_NO_REMOTE': '1', 04:46:03 INFO - 'NO_EM_RESTART': '1', 04:46:03 INFO - 'PAGER': '/bin/cat', 04:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:03 INFO - 'PWD': '/builds/slave/test', 04:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:03 INFO - 'SHELL': '/bin/bash', 04:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:03 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:03 INFO - 'USER': 'cltbld', 04:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:03 INFO - 'XPC_FLAGS': '0x0', 04:46:03 INFO - 'XPC_SERVICE_NAME': '0', 04:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:03 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 04:46:03 INFO - Cleaning up... 04:46:03 INFO - Return code: 0 04:46:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:03 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 04:46:03 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 04:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:03 INFO - 'HOME': '/Users/cltbld', 04:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:03 INFO - 'LOGNAME': 'cltbld', 04:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:03 INFO - 'MOZ_NO_REMOTE': '1', 04:46:03 INFO - 'NO_EM_RESTART': '1', 04:46:03 INFO - 'PAGER': '/bin/cat', 04:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:03 INFO - 'PWD': '/builds/slave/test', 04:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:03 INFO - 'SHELL': '/bin/bash', 04:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:03 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:03 INFO - 'USER': 'cltbld', 04:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:03 INFO - 'XPC_FLAGS': '0x0', 04:46:03 INFO - 'XPC_SERVICE_NAME': '0', 04:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:03 INFO - Downloading/unpacking psutil>=0.7.1 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:07 INFO - Installing collected packages: psutil 04:46:07 INFO - Running setup.py install for psutil 04:46:07 INFO - building 'psutil._psutil_osx' extension 04:46:07 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 04:46:07 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 04:46:07 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 04:46:07 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 04:46:08 INFO - building 'psutil._psutil_posix' extension 04:46:08 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 04:46:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:46:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:46:08 INFO - ^ 04:46:08 INFO - 1 warning generated. 04:46:08 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 04:46:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:08 INFO - Successfully installed psutil 04:46:08 INFO - Cleaning up... 04:46:08 INFO - Return code: 0 04:46:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:08 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:08 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 04:46:08 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 04:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:08 INFO - 'HOME': '/Users/cltbld', 04:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:08 INFO - 'LOGNAME': 'cltbld', 04:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:08 INFO - 'MOZ_NO_REMOTE': '1', 04:46:08 INFO - 'NO_EM_RESTART': '1', 04:46:08 INFO - 'PAGER': '/bin/cat', 04:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:08 INFO - 'PWD': '/builds/slave/test', 04:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:08 INFO - 'SHELL': '/bin/bash', 04:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:08 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:08 INFO - 'USER': 'cltbld', 04:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:08 INFO - 'XPC_FLAGS': '0x0', 04:46:08 INFO - 'XPC_SERVICE_NAME': '0', 04:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:46:08 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 04:46:08 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 04:46:08 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 04:46:08 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 04:46:08 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 04:46:08 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 04:46:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:46:11 INFO - Installing collected packages: mozsystemmonitor 04:46:11 INFO - Running setup.py install for mozsystemmonitor 04:46:11 INFO - Successfully installed mozsystemmonitor 04:46:11 INFO - Cleaning up... 04:46:11 INFO - Return code: 0 04:46:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:11 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:11 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 04:46:11 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 04:46:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:11 INFO - 'HOME': '/Users/cltbld', 04:46:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:11 INFO - 'LOGNAME': 'cltbld', 04:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:11 INFO - 'MOZ_NO_REMOTE': '1', 04:46:11 INFO - 'NO_EM_RESTART': '1', 04:46:11 INFO - 'PAGER': '/bin/cat', 04:46:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:11 INFO - 'PWD': '/builds/slave/test', 04:46:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:11 INFO - 'SHELL': '/bin/bash', 04:46:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:11 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:11 INFO - 'USER': 'cltbld', 04:46:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:11 INFO - 'XPC_FLAGS': '0x0', 04:46:11 INFO - 'XPC_SERVICE_NAME': '0', 04:46:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:11 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:13 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:15 INFO - Downloading docopt-0.6.1.tar.gz 04:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:15 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:15 INFO - Running setup.py install for blobuploader 04:46:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:15 INFO - Running setup.py install for requests 04:46:15 INFO - Running setup.py install for docopt 04:46:15 INFO - Successfully installed blobuploader requests docopt 04:46:15 INFO - Cleaning up... 04:46:16 INFO - Return code: 0 04:46:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:16 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')]} 04:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:16 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')]} 04:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:16 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:16 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 04:46:16 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 04:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:16 INFO - 'HOME': '/Users/cltbld', 04:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:16 INFO - 'LOGNAME': 'cltbld', 04:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:16 INFO - 'MOZ_NO_REMOTE': '1', 04:46:16 INFO - 'NO_EM_RESTART': '1', 04:46:16 INFO - 'PAGER': '/bin/cat', 04:46:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:16 INFO - 'PWD': '/builds/slave/test', 04:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:16 INFO - 'SHELL': '/bin/bash', 04:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:16 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:16 INFO - 'USER': 'cltbld', 04:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:16 INFO - 'XPC_FLAGS': '0x0', 04:46:16 INFO - 'XPC_SERVICE_NAME': '0', 04:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-6Dc2yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-B2AcuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-Bl9nwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-yMcc4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-kfQde1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-HMCmdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-7deFR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:16 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-xllFs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-CbPmD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-UlQHJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-PItY8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-xtmdWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-M4B5_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-FfJSYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-S4I_3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-5_ft7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:17 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-QiJLt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:18 INFO - Running setup.py install for manifestparser 04:46:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:18 INFO - Running setup.py install for mozcrash 04:46:18 INFO - Running setup.py install for mozdebug 04:46:18 INFO - Running setup.py install for mozdevice 04:46:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:46:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:18 INFO - Running setup.py install for mozfile 04:46:18 INFO - Running setup.py install for mozhttpd 04:46:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:18 INFO - Running setup.py install for mozinfo 04:46:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Running setup.py install for mozInstall 04:46:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Running setup.py install for mozleak 04:46:19 INFO - Running setup.py install for mozlog 04:46:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Running setup.py install for moznetwork 04:46:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Running setup.py install for mozprocess 04:46:19 INFO - Running setup.py install for mozprofile 04:46:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:19 INFO - Running setup.py install for mozrunner 04:46:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:20 INFO - Running setup.py install for mozscreenshot 04:46:20 INFO - Running setup.py install for moztest 04:46:20 INFO - Running setup.py install for mozversion 04:46:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:20 INFO - Cleaning up... 04:46:20 INFO - Return code: 0 04:46:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:20 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')]} 04:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:20 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')]} 04:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:20 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:20 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 04:46:20 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 04:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:20 INFO - 'HOME': '/Users/cltbld', 04:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:20 INFO - 'LOGNAME': 'cltbld', 04:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:20 INFO - 'MOZ_NO_REMOTE': '1', 04:46:20 INFO - 'NO_EM_RESTART': '1', 04:46:20 INFO - 'PAGER': '/bin/cat', 04:46:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:20 INFO - 'PWD': '/builds/slave/test', 04:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:20 INFO - 'SHELL': '/bin/bash', 04:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:20 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:20 INFO - 'USER': 'cltbld', 04:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:20 INFO - 'XPC_FLAGS': '0x0', 04:46:20 INFO - 'XPC_SERVICE_NAME': '0', 04:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:20 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-cVQ0aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:20 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)) 04:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:20 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-ZFMxym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-daV8yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-uPi0iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-1XaUJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-WfKG0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-ULJMjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-5DAw7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-9T32gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-vm0ise-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:21 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)) 04:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:21 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-QyOrG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:22 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)) 04:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-TsVUCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:22 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)) 04:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-j0QajK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:22 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)) 04:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-yKewHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:22 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)) 04:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-EoYsQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:22 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)) 04:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-wohVd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:22 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)) 04:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:22 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-jtW0ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:22 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)) 04:46:22 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)) 04:46:22 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)) 04:46:22 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)) 04:46:22 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)) 04:46:22 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)) 04:46:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:22 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 04:46:22 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 04:46:22 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 04:46:22 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 04:46:22 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 04:46:22 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 04:46:24 INFO - Downloading blessings-1.6.tar.gz 04:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:25 INFO - Installing collected packages: blessings 04:46:25 INFO - Running setup.py install for blessings 04:46:25 INFO - Successfully installed blessings 04:46:25 INFO - Cleaning up... 04:46:25 INFO - Return code: 0 04:46:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:25 INFO - Reading from file tmpfile_stdout 04:46:25 INFO - Current package versions: 04:46:25 INFO - blessings == 1.6 04:46:25 INFO - blobuploader == 1.2.4 04:46:25 INFO - docopt == 0.6.1 04:46:25 INFO - manifestparser == 1.1 04:46:25 INFO - mozInstall == 1.12 04:46:25 INFO - mozcrash == 0.17 04:46:25 INFO - mozdebug == 0.1 04:46:25 INFO - mozdevice == 0.48 04:46:25 INFO - mozfile == 1.2 04:46:25 INFO - mozhttpd == 0.7 04:46:25 INFO - mozinfo == 0.9 04:46:25 INFO - mozleak == 0.1 04:46:25 INFO - mozlog == 3.1 04:46:25 INFO - moznetwork == 0.27 04:46:25 INFO - mozprocess == 0.22 04:46:25 INFO - mozprofile == 0.28 04:46:25 INFO - mozrunner == 6.11 04:46:25 INFO - mozscreenshot == 0.1 04:46:25 INFO - mozsystemmonitor == 0.0 04:46:25 INFO - moztest == 0.7 04:46:25 INFO - mozversion == 1.4 04:46:25 INFO - psutil == 3.1.1 04:46:25 INFO - requests == 1.2.3 04:46:25 INFO - wsgiref == 0.1.2 04:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:25 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')]} 04:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:25 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')]} 04:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:25 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:25 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 04:46:25 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 04:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:25 INFO - 'HOME': '/Users/cltbld', 04:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:25 INFO - 'LOGNAME': 'cltbld', 04:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:25 INFO - 'MOZ_NO_REMOTE': '1', 04:46:25 INFO - 'NO_EM_RESTART': '1', 04:46:25 INFO - 'PAGER': '/bin/cat', 04:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:25 INFO - 'PWD': '/builds/slave/test', 04:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:25 INFO - 'SHELL': '/bin/bash', 04:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:25 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:25 INFO - 'USER': 'cltbld', 04:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:25 INFO - 'XPC_FLAGS': '0x0', 04:46:25 INFO - 'XPC_SERVICE_NAME': '0', 04:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 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)) 04:46:25 INFO - Cleaning up... 04:46:25 INFO - Return code: 0 04:46:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:25 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')]} 04:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:25 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')]} 04:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:25 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:25 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 04:46:25 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 04:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:25 INFO - 'HOME': '/Users/cltbld', 04:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:25 INFO - 'LOGNAME': 'cltbld', 04:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:25 INFO - 'MOZ_NO_REMOTE': '1', 04:46:25 INFO - 'NO_EM_RESTART': '1', 04:46:25 INFO - 'PAGER': '/bin/cat', 04:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:25 INFO - 'PWD': '/builds/slave/test', 04:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:25 INFO - 'SHELL': '/bin/bash', 04:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:25 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:25 INFO - 'USER': 'cltbld', 04:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:25 INFO - 'XPC_FLAGS': '0x0', 04:46:25 INFO - 'XPC_SERVICE_NAME': '0', 04:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:26 INFO - Downloading/unpacking jsonschema 04:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:28 INFO - Downloading/unpacking functools32 (from jsonschema) 04:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:28 INFO - warning: no files found matching '*.txt' 04:46:28 INFO - no previously-included directories found matching 'build' 04:46:28 INFO - no previously-included directories found matching 'dist' 04:46:28 INFO - no previously-included directories found matching '.git*' 04:46:28 INFO - Installing collected packages: jsonschema, functools32 04:46:29 INFO - Running setup.py install for functools32 04:46:29 INFO - warning: no files found matching '*.txt' 04:46:29 INFO - no previously-included directories found matching 'build' 04:46:29 INFO - no previously-included directories found matching 'dist' 04:46:29 INFO - no previously-included directories found matching '.git*' 04:46:29 INFO - Successfully installed jsonschema functools32 04:46:29 INFO - Cleaning up... 04:46:29 INFO - Return code: 0 04:46:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:46:29 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')]} 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:29 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')]} 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:29 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 0x1035e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035f5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f889ad94ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, '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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 04:46:29 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 04:46:29 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 04:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:29 INFO - 'HOME': '/Users/cltbld', 04:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:29 INFO - 'LOGNAME': 'cltbld', 04:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:29 INFO - 'MOZ_NO_REMOTE': '1', 04:46:29 INFO - 'NO_EM_RESTART': '1', 04:46:29 INFO - 'PAGER': '/bin/cat', 04:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:29 INFO - 'PWD': '/builds/slave/test', 04:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:29 INFO - 'SHELL': '/bin/bash', 04:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:46:29 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:29 INFO - 'USER': 'cltbld', 04:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:29 INFO - 'XPC_FLAGS': '0x0', 04:46:29 INFO - 'XPC_SERVICE_NAME': '0', 04:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:29 INFO - Downloading/unpacking flake8 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:46:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:46:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:46:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:33 INFO - no previously-included directories found matching 'docs/_build' 04:46:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:46:33 INFO - Running setup.py install for pep8 04:46:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:33 INFO - no previously-included directories found matching 'docs/_build' 04:46:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:46:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:46:33 INFO - Cleaning up... 04:46:33 INFO - Return code: 0 04:46:33 INFO - Running post-action listener: _resource_record_post_action 04:46:33 INFO - Running post-action listener: _start_resource_monitoring 04:46:33 INFO - Starting resource monitoring. 04:46:33 INFO - ##### 04:46:33 INFO - ##### Running install step. 04:46:33 INFO - ##### 04:46:33 INFO - Running pre-action listener: _resource_record_pre_action 04:46:33 INFO - Running main action method: install 04:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:33 INFO - Reading from file tmpfile_stdout 04:46:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:33 INFO - Reading from file tmpfile_stdout 04:46:33 INFO - Output received: 04:46:33 INFO - Usage: mozinstall [options] installer 04:46:33 INFO - Options: 04:46:33 INFO - -h, --help show this help message and exit 04:46:33 INFO - -d DEST, --destination=DEST 04:46:33 INFO - Directory to install application into. [default: 04:46:33 INFO - "/builds/slave/test"] 04:46:33 INFO - --app=APP Application being installed. [default: firefox] 04:46:33 INFO - mkdir: /builds/slave/test/build/application 04:46:33 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'] 04:46:33 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 04:47:07 INFO - Reading from file tmpfile_stdout 04:47:07 INFO - Output received: 04:47:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:47:07 INFO - Running post-action listener: _resource_record_post_action 04:47:07 INFO - ##### 04:47:07 INFO - ##### Running run-tests step. 04:47:07 INFO - ##### 04:47:07 INFO - Running pre-action listener: _resource_record_pre_action 04:47:07 INFO - Running main action method: run_tests 04:47:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:07 INFO - 2016-03-17 04:47:07.636 screenresolution[1643:7677] starting screenresolution argv=screenresolution get 04:47:07 INFO - 2016-03-17 04:47:07.639 screenresolution[1643:7677] Display 0: 1600x1200x32@60 04:47:07 INFO - 2016-03-17 04:47:07.645 screenresolution[1644:7679] starting screenresolution argv=screenresolution list 04:47:07 INFO - Available Modes on Display 0 04:47:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:07 INFO - Intel Iris: 04:47:07 INFO - Chipset Model: Intel Iris 04:47:07 INFO - Type: GPU 04:47:07 INFO - Bus: Built-In 04:47:07 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:07 INFO - Vendor: Intel (0x8086) 04:47:07 INFO - Device ID: 0x0a2e 04:47:07 INFO - Revision ID: 0x0009 04:47:07 INFO - Displays: 04:47:07 INFO - Display: 04:47:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:07 INFO - Display Serial Number: 1600x1200 60 04:47:07 INFO - Main Display: Yes 04:47:07 INFO - Mirror: Off 04:47:07 INFO - Online: Yes 04:47:07 INFO - Rotation: Supported 04:47:07 INFO - Return code: 0 04:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:07 INFO - Python 2.7.3 04:47:07 INFO - Return code: 0 04:47:07 INFO - grabbing minidump binary from tooltool 04:47:07 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')]} 04:47:07 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 0x103484e00>, '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 0x1032eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10347fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:07 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 04:47:07 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 04:47:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:07 INFO - Return code: 0 04:47:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:47:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:47:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:47:09 INFO - Return code: 0 04:47:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--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 04:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0110 --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 04:47:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AUXOtDh2o/Render', 04:47:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:09 INFO - 'HOME': '/Users/cltbld', 04:47:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:09 INFO - 'LOGNAME': 'cltbld', 04:47:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:09 INFO - 'MOZ_NO_REMOTE': '1', 04:47:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:09 INFO - 'NO_EM_RESTART': '1', 04:47:09 INFO - 'PAGER': '/bin/cat', 04:47:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:09 INFO - 'PWD': '/builds/slave/test', 04:47:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:09 INFO - 'SHELL': '/bin/bash', 04:47:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qfu3y4AhR6/Listeners', 04:47:09 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 04:47:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:09 INFO - 'USER': 'cltbld', 04:47:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:09 INFO - 'XPC_FLAGS': '0x0', 04:47:09 INFO - 'XPC_SERVICE_NAME': '0', 04:47:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--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 04:47:09 INFO - mozversion application_buildid: 20160317030120 04:47:09 INFO - mozversion application_changeset: fefe2bc3e54fa101dc12e2858546ab5df2ee6d20 04:47:09 INFO - mozversion application_display_name: Nightly 04:47:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:09 INFO - mozversion application_name: Firefox 04:47:09 INFO - mozversion application_remotingname: firefox 04:47:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:09 INFO - mozversion application_vendor: Mozilla 04:47:09 INFO - mozversion application_version: 48.0a1 04:47:09 INFO - mozversion platform_buildid: 20160317030120 04:47:09 INFO - mozversion platform_changeset: fefe2bc3e54fa101dc12e2858546ab5df2ee6d20 04:47:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:09 INFO - mozversion platform_version: 48.0a1 04:47:09 INFO - using testdate: 1458215229 04:47:09 INFO - actual date: 1458215229 04:47:09 INFO - starting webserver on 'localhost:49270' 04:47:09 INFO - SUITE-START | Running 2 tests 04:47:09 INFO - TEST-START | dromaeo_css 04:47:09 INFO - operating with platform_type : mac_ 04:47:09 INFO - Initialising browser for dromaeo_css test... 04:47:09 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpLkhFWG/profile http://localhost:49270/getInfo.html) 04:47:11 INFO - PROCESS | 1662 | 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] 04:47:12 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 04:47:12 INFO - PROCESS | 1662 | colorDepth:24 04:47:12 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 04:47:12 INFO - PROCESS | 1662 | __metrics 04:47:12 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 04:47:13 INFO - TEST-INFO | 1662: exit 0 04:47:13 INFO - Browser initialized. 04:47:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:13 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpLkhFWG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:25 INFO - PROCESS | 1666 | RSS: Main: 256835584 04:47:25 INFO - PROCESS | 1666 | 04:48:14 INFO - PROCESS | 1666 | 1458215294884 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:50:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 04:50:27 INFO - PROCESS | 1666 | RSS: Main: 268627968 04:50:27 INFO - PROCESS | 1666 | 04:53:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 04:53:29 INFO - PROCESS | 1666 | RSS: Main: 281649152 04:53:29 INFO - PROCESS | 1666 | 04:56:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 04:56:32 INFO - PROCESS | 1666 | RSS: Main: 283713536 04:56:32 INFO - PROCESS | 1666 | 04:59:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 04:59:34 INFO - PROCESS | 1666 | RSS: Main: 283680768 04:59:34 INFO - PROCESS | 1666 | 05:02:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:02:37 INFO - PROCESS | 1666 | RSS: Main: 287096832 05:02:37 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:05:40 INFO - PROCESS | 1666 | RSS: Main: 289689600 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | __start_tp_report 05:05:40 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:05:40 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:05:40 INFO - PROCESS | 1666 | |i|pagename|runs| 05:05:40 INFO - PROCESS | 1666 | |0;dojo.html;3373.9831300843493;3475.096474916521;3535.1338921964125;3549.840257188425;3567.9108022299424;4619.284010978296;5421.024215641183;5729.255196824407;5753;5788.6816225107605;5681.375048744635;5694.886102277952;5721.885562288762;5861.413858614136;5914.112883067542;5175.456577059411;5183.455737147611;5205.37535495741;5239.816606418776;5296.602754793386;5288.735563221842;5362.785488580452;5375.650582712131;5400.432954539776;5405.567554595643;5140.94610604827;5249.42256351801;5258.868528286824;5275.472452754732;5311.415744268127;5230.633855630107;5242.817340243891;5250.212468129773;5268.736563171864;5276.34045744282;5101.82143624975;5202.037623039712;5220.895582088375;5256.579473642138;5289.44460831611;5645.887082258373;5700.714964251771;5751;5763.567732420085;5770.365259821417;6205.87588248237;6236.220472440945;6242.906356404657;6249.843753906143;6302.653354065525;6132.63086471492;6183.258009038944;6248.343923888017;6252.155958945529;6257.749690012394;5970.223870896755;5979.431953964367;5993.550483713739;6004.759809607567;6046.667433291167;6364.586301890362;6403.583767055126;6404.103425520431;6416.839579010562;6427.550071495044;6081.27024757032;6143.723532441051;6165.907511387333;6244.875102498016;6266.060090986389;6217.378262173836;6252.843678908063;6255.218097737783;6275.780347687809;6309.747610095545;6131.386861313922;6155.169052177898;6182.103594978703;6257.09272155544;6266.624002559861;4880.41435027799;5031.949680503149;5463.48096930791;6141.792871882774;6198.349173336825;4969.577585905238;4970.030843985461;4988.925166122511;4997.525235102659;5003;3540.3981323174607;3734.3651579231055;4448.688591798543;4462.174497717932;4464.419625448671;4914.287428322873;5728.968785618546;5762.827115186551;5929.436703513159;5946.167536544887;6169.893307082685;6200.720967556471;6223.159873417121;6230.563860529719;6250;5051.848444546669;5639.407862174413;5864.44287792659;5871.94128058714;5939.0136229180525;5350.903064871692;5436.836894893159;5474.534664553478;5489.39616642169;5527.640703354269;6443.130177426175;6471.320511346335;6489.545731798728;6510.967445162839;6511.967440162769;6090.482309003607;6230.15892854477;6236.719347629277;6237.844053898689;6254.655993920378;5906.557008224487;6050.576459647782;6468.320826313357;6496.090547323473;6499.935000649933;6182.474489668429;6223.657698826608;6245.313015568375;6253.906191407042;6263.311035785969;6134.038624681977;6155.953487907156;6160.599561028519;6243.96878015607;6273.341299163522;5088.923666144937;6108.053251745987;6146.631202127886;6187.597806142587;6273.717682704198;6006.101657799584;6153.784617538365;6200.3179650239335;6211.503079753518;6223.471004964629;5587.854489829494;5872.677002764889;6073.544484163794;6133.3866613338305;6144.815655530341;6146.692665366624;6187.907181392193;6208.72060757258;6209.472194863487;6221.688915554295;6076.726547305293;6138.723757430837;6141.477974372228;6160.568760186923;6167.753289868355 05:05:40 INFO - PROCESS | 1666 | |1;ext.html;449.9347594598783;591.9847461603349;601.9616162120341;640.9230892292924;641.7144370755013;37146.81426592867;37654.62345376549;37859;37968.43047354288;38008;39469.605303946955;39619.40570891439;39628;39949.800250998705;39950.200995980136;9382.343235973502;9472.62109515622;9534;9567.66513172039;9600.903990960105;8048.5975701215;8102.5543595102245;9399.24806015517;9640.228781697448;9709.563069661883;8039.839203215962;8476.957615211946;8868.113188681145;9664.855027174597;9711.805763884753;9651;9657.22742180624;9710.805783884283;9722.319437639404;9745.756356091119;9529.857052144223;9675.758106047335;9679.854802177973;9696.951515242448;9756.07317304855;32210.677893221004;38494;38540.61459385426;38807.61192388096;38819;3159.2575744699975;3186.123815950609;3224.6775322467565;3292.901212963615;3481.669241422061;27908.720912790814;28328.716712832815;28470.430591388264;28905.710942890513;29175.70824291751;2662.7071022187542;2706.5669492881243;2744.9588256176175;2788.358677504165;2864.0262310814423;388568;391887;392821;392984;539510.3024484891;63552;64268;64352.03471947925;64474.67762661157;64505.35494644994;68369.3163068373;68474.65762671155;68707.96938045933;68762.65618671874;73649;16993;17130.828691712923;17137.971721696736;17161.399351022905;17185.570360741083;12755.553555625509;13007.674808129872;13136.540221092217;13230.206187628773;13244.53644122451;21628;22008.339749807532;22160.56233814279;22392.664110038364;22519.549609008056;7795.3373963212625;9193.95403022994;9455;9495.667651632299;9530.189264039811;1015.5125539740966;1026.594495174402;1053.489057806963;1104.6244276945877;1143.3768596115137;29020.564691529646;29395.706042939724;29520.704792951794;29759;29896.402071958873;1075.8977897099762;1114.9777004459866;1120.5797825815318;1152.7291086594644;1170.1984140863535;11560.942195289137;14800.333984970703;14862.777058344134;15206.467773628092;15254.847451525342;516677;522517;522985.3850730722;523827;524334;58092;58163;58245.417545824;58742.70628646915;58921;1173.929564226149;1263.4882872436679;1384.5084994826893;1411.8376386715454;1483.2435457916324;29143.271418214714;29277.975270865416;29349.26626834346;29762.255943601584;29862.013798619962;42291.57708422876;51088.23367649563;51263.231051535004;51363;51742;473779;474936;475824;488113.55943220056;488736;26910.32724181911;32749.67250327466;33421;33605.32789344248;34000.82999584986;34882.825585872924;44766.55233447754;44847;45614.77192614016;45946;37327.626723732414;38172.80913595414;40276.993075173355;40498.59501405066;41358.37962430506;36214.27571448609;36796.60822046558;36819.447708283864;36990.44514332234;37575.24849503049;36232.456513151796;36532;36843.447348290334;37149;37470.43794343142;31544.36911261716;32131.518027229144;32141.392930352922;32308.83845580757;32480.350392991535;21455.14179432805;22953.426164346023;24422.26733198007;24683.01267949262;24965.625515616917 05:05:40 INFO - PROCESS | 1666 | |2;jquery.html;350.35184907920336;359.8093010704327;363.7126669930754;364.73738907986274;366.13591923061585;19017;19581.216751329946;21292.8935355323;21347.57304853902;21477.67783483249;11879.406029698524;12301;12339.012878969683;12342.950849177809;12383.938080309608;4522.3216517522305;5144.948550514503;5162.148245539491;5397.3523177218785;5459.071957767169;5278.445763194867;5280.234366016925;5299.655522391052;5326.334208223972;5368.382635996872;4602.2636378179495;5247.47525247476;5356.491133342326;5473.616846820724;5931.911021334662;5793.826185214451;5823.941760582404;5863.560232982522;5911.733971971272;5922.555808314372;5113.923291150636;5161.793528258865;5166.276721259027;5227.712475813829;5240.895182096375;13274.070815042951;13302.268375239359;13573.049886507948;13575.253361065137;13586.11690240141;2092.4664210626192;2096.549241912981;2133.136079887648;2166.306781829815;2187.737471503414;9521.190698790611;9883.209343252522;10036.29745917786;10139.138173255282;10213.642522511676;1667.8999260044436;1739.721644536868;1762.0925223509776;1796.5598428385128;1817.7182536706832;74217.25782742212;93235.53382233113;93949.12101757927;96296;101797.4910125452;10933.56265749377;11141.832872506919;11181.273217240854;11268.492917818718;11323.830142547868;13400.463981440827;13428.865711342956;13480.056396052378;13484.325783710776;13559.796603050961;8438.945131858518;8608.827823443497;8637.784055398666;8660.220580147818;8712.69505567302;7851.960740196377;8141;8798.12018798115;8957.14907083839;9064.093590640883;4362.389265502832;4383.49589797171;4412.360207769855;4432.911341773147;4506;1863.4595967169369;1929.3150931419425;1953;1956.432634535997;1958.4320547041484;661.3584822721951;751.9849603007909;872.3065163195275;961.0965692249264;975.3465178330536;18175.272989080553;20025.39923802288;20239.79760202379;20255.84437631693;20477;933.6778811310087;936.6487567162314;943.7499062748377;967.8935317115112;983.439439519467;9265.39774914642;10666.839997400046;10918.344899306067;10930;11014.118870490342;535255;586592.067039662;622994;632737;642474;76068;103296.48351758193;112838;114573.42713286547;115547;930.6463543853292;995.5370752600076;1017.7557386227252;1034.79821434821;1043.6347278452633;16023;17918.0145092016;17946.37187698424;17991.460256192335;18027.459176224733;33275.83362083174;48016.519834801205;48618;48806.75596621994;49937.75031124821;62809;62950.68524657348;67308.6634566824;67442;67450;7527.585982771;7756.263155000266;7782.416318776001;7920.207979202034;7945.562994035384;11306.756256811908;12283.754324913272;12561.43473543711;12624.74750505003;12670.176438531465;9956.55195516218;10400.739981500523;10508.42203678805;10629.202809789142;10824.188185885932;8640.56797160152;9877;10580.4709764513;10831.620893268699;10937.83593246118;10352.741181470523;10493.422861742678;10978.396188209725;11167.944160279147;11204.647024124699;7719.922800772145;7877.566733829465;7892;7990.400719945911;8169.673213071411;9407.43555386679;10777;10876.91230876906;10996.450177490933;11137.276077054965 05:05:40 INFO - PROCESS | 1666 | |3;mootools.html;1615.9919200404;1628.9266982985769;1929.151173483667;1994.062790488471;2001.379572332578;7866.095399029114;8527.038781080355;8677.435966662162;8868.512231827246;8882.333824963129;8600.182982616641;8600.526971016592;8639.481631102139;8719;8742.562871856413;2446.9632955505635;2454.6931633545805;2464.2853572463964;2470.518248941457;2477.2939712182033;2410.831241813065;2492.8379655322346;2494.9875250623722;2497.400623850281;2497.475530138673;2462.8029757619347;2476.6780318558563;2500.1499490173337;2501.112105202654;2506.4736405354897;2455.791257743094;2457.8893949772214;2495.3262619092834;2496.4133428644254;2508.3227528567186;2448.43685952232;2466.90132394704;2478.120267305099;2480.937976550583;2502.399424138212;8864.689735859278;8873.645054197825;8898.021217666052;8910.242629376511;8918.94864181242;5316.521513063843;5372.7045012524295;5388.892222155535;5431.375391829911;5441.673499590037;3635.291118231946;3710.109573702319;3758.229562939591;3779.433085037239;3781.716371272166;893.8927328720595;1047.1361127070122;1071.8231491803842;1088.1729885287239;1107.900288973996;11747.118966077493;11748.647540573711;11935.761284774342;11949.522019119226;11978.041756659446;4832.226843704991;4870.6103511718975;4943.579795717333;4947.356843610308;4961.231009193581;10168.593256269814;10169.135623472088;10172.898271017195;10179.389236645677;10194.490275486345;5480.177973304037;5488.1767734839295;5498.395176530578;5504;5558.583106267046;3834.5812049541846;4733.455652599926;4955.677880937799;4967.726775027409;4997.375328083989;3827.5406951165482;3910.7262491625884;3919.8824035278985;3922.1763429679518;3925.7448265862627;1310.9541166059141;1321.3987635625958;1325.6752095736606;1328.7807511760645;1341.3092257487401;1296.9740605187844;1325.8674132586664;1347.4879545772544;1350.9054366194468;1358.7282543491342;8115.066767321716;8163.38774591908;8183.71357002502;8252.628631711588;8288.668453261922;503.44369471733205;512.6129772022099;515.0420218393784;516.6822404221452;518.693970557373;6048.909266361008;6242.313345531988;6290.245170579468;6303.117563541108;6310.9368906311265;10396.324238924446;10693.304935179189;10708.250422470508;10774.299670521392;10826.783464330669;8927.821443571092;10065.345752526062;10316.948415258026;10364.378137311785;10632.096271816983;8152.510849349058;8181.550014749246;8321.833563328699;8322.375821813388;8324.750257492406;8050.919490805251;8059.597020149086;8064.314533264738;8084.39367047462;8097.190280971856;9332.72001839946;9506.952465237906;9548.42709437436;9599.520023998912;9609;9340.299477539347;9642.084002019797;9660.275479338938;9939.503024848584;9986.450745209084;6802.591844489149;7247.275272472711;7462.328390444886;7466.402687785073;7593.278638529331;8216.014078310642;8222.424430290062;8253.504789712637;8283.29591984688;8301.252887240178;7223.386012189023;7239.601821899846;7397.889031664422;7481.027466429329;7586.3930885527925;7288.854222915406;7308.488405811542;7324.340809327186;7403.888941665987;7456.7762967111075;7681.42389320792;7730.226977302224;7773.028371453568;7773.261540153676;7774.844503110019;6957.547759395623;6976.162860456778;7031.507794454339;7036.683349249399;7056.188538317954;7124.216336203117;7149.106361704787;7244.203137654748;7250.782476525713;7255.274472552703 05:05:40 INFO - PROCESS | 1666 | |4;prototype.html;322.34242146022115;325.9462188738858;328.75343492380716;331.61863856564946;332.1016649961853;6766.729330826767;6806.094293597795;6829.975503674451;6847.794566163011;6902;6740.629265390402;6760.188777346725;6769.120014398133;6787.830304242397;6800.421964133042;4764.023375208074;4850.126977144113;4979.526944940225;5006.524380183877;5027.723475208872;4958.281049247857;4960.131976904046;4965.42897566779;4967.056259310738;4981.153203955337;4906.803727850882;4912.680675756064;4939.678920870132;4953.182724850395;4965.255211718235;4111.958880411187;4919.040787046527;4941.3329200558;4944.406671199461;4953.702777833306;3835.3671644178676;3942.211557688474;4250.574942505725;4278.935815962763;4285.721428107163;6276.529260305495;6455.8063258101865;6519.674016299214;6555.573887697332;6566.212054553484;5960.552958528127;5970.925233457976;6008.918394688954;6079.0273556230795;6136.69316534176;7189.928100718978;7224.410629661466;7225.710971561131;7254.347108760184;7266.382357499619;4816.084943860656;4817.614590832725;4817.735024573647;4824.541668541518;4826.95173048272;7685.961570192113;7701.191374905667;7709.922900770976;7723.420743444208;7746.728864489773;4695.694779839299;4885.902281954341;4898.779554920037;4923.75381230937;4925.13810083234;4962.131626965267;4993.1262029144755;5015.3480047593575;5019.548240658358;5021.548060674557;4847.345608342828;5849.502792262705;5910.143029260819;5913.822585322361;5930.673812940244;7282.635868206568;7287.089113860768;7288.927110728825;7312.341889229995;7318.670659820321;1711.9657606847793;1738.7044202485608;1740.1821144062271;1741.703910335246;1743.0064863027953;873.8383399071065;1105.5854054729477;1123.3596849795701;1125.4935279124427;1129.6215767717742;6760.7633732820095;6814.182298124257;6832.726690932406;6871.278515755874;6877.243503214642;6068.514518838482;7530;7535.660895259726;7555.0178476798765;7568.356689681329;6600.900986485207;6664.266930637626;6854.2117656469145;6902.723891044402;6908.965455172692;3957.1887763008513;4017.4978127734034;4019.4774679291504;4030.9798451008146;4042.8180731867137;7042.647867606702;7460.1047874254355;8019.839603207904;8029.759107226792;8052.919470805217;7396.4452666050265;7871.212878712197;7875.133735289113;7880;7912.248336408032;6381.298057213703;7869.055713314325;7893.526388416713;7916.762497125095;7972.681092756225;6596.571222870498;7521.210272921265;7528.096628404626;7535.020447341811;7596.164421913696;7438.776836694691;7443.292887175709;7452;7462.179160292472;7509.9249007509225;7695.4997925134685;7945.880811787712;7952.204779522001;7955.2840244378285;7960.084590272193;4675.3220782986955;4687.624990000723;4716.858494245178;4733.408323959505;4759.976200118977;7525.548467091992;7527.021487206628;7569;7572.4699271050495;7588.544687318778;6118.510519158545;7133.82165445868;7294.088238970129;7303.963480182565;7311.122665280201;6917.23910369869;7259.782206533812;7282.198958114497;7297.781066568012;7321.450891183076;7106.076210092655;7109.360157585842;7118.715251389886;7121.252268511732;7156.355927966508;6690;7279.235680253709;7296.817579560554;7298.817529561803;7356.521826081502;7124.287571242834;7126.109236345457;7136.643167841691;7138.64306784669;7148.785536433916 05:05:40 INFO - PROCESS | 1666 | |5;yui.html;692.7817737412714;730.349988510226;748.0948052856044;753.220416868541;769.299937057278;14844.257787110642;14965.25173741314;15073.472428464993;15110.39558417662;15134;13981.300934953262;14014.78977815331;14037.50868719595;14061.367238474268;14069.859301406983;905.597009330848;932.9673461428852;934.2666007184362;935.4247138010143;938.9014153513886;620.3083561828552;925.7639301977986;931.1247427418239;942.4109931292942;958.8465845464727;986.2800155886207;989.2185173712759;989.4014121456523;990.1979396688669;991.9553620087113;971.9951400242988;975.8487434447673;980.1717548671361;982.5578489679673;982.832918403873;702.9402500787439;703.4513079797766;725.2964624314459;728.8469421421507;731.016782427634;15047.699046019019;15131.924340378227;15134.697306053928;15256;15365.615859603487;12736.23582585048;13040.478380864753;13224.801627975588;13326.267055311953;13334.399952002183;9663;10175.898241017569;10285.125764309967;10525.684229473129;10526.78946421075;3511.473279008144;3561.0919215599856;3569.196930690574;3607.9098022549383;3664.8350824212976;72152.63923680349;72630.63684681595;73035.63482182608;73145.6342718283;73464.26535734627;9175.862362064574;9422.387544809566;9481.146696797321;9516.999999999862;9621;22008.559828803656;22024.11903523873;22058.117675293128;22072.88963555172;22134.003969821075;6638.468922486286;7324.157721862054;7476.252374762589;7543.493249927584;7615.352695020874;3605.675489205984;3631.455281707765;3692.9261414771554;3718.795466249382;3746.344389731786;3586.7130629549574;3595.442706380463;3609.9819500902854;3615.475756015363;3620.800855952948;630.0266088892672;633.1389310537666;636.7389370358131;650.6876699184418;651.1762620285343;568.6076607141059;574.9252597162342;589.1483632288104;590.4095904095905;611.4222060153113;6478.708458119396;7962.522248665098;8049.758507244792;8214.63034163464;8251.95874020638;454.4660024471233;464.4821024557594;498.30486471372234;596.1862058290488;617.3116974573319;3309.933801324008;3698.853355459816;3852.2295540891932;3881.708871834567;3899.5710471848074;56113.719431402584;68906.9663955041;88230;88549;88595.55702221447;61126;74953.62523187349;77698.22301777023;79010.20989790029;80760;69402.9589556157;69775.3022469779;69921;70378;73862.63068684623;7727.381809455343;7762.146163922077;7787.727429539939;7815.804604884924;7826.265109608605;33720.662793371754;48923.776905577644;49123;49185;50104.749476252386;50422.74788626033;68765.31234687589;69080.30919690739;70667.64666176842;70679.64660176667;9965.302428829913;10137.391756494633;10157.9492102539;10243.43661098617;10397.32417392867;9537.475438850652;10581.259311848096;10788.406637635006;10867.836982445111;11095.527349501574;10049.246306526893;10067.345622534513;10184.694459166238;10208.438535880598;10632.096271816983;10245.948770256102;10276.126529245097;10311;10520.526576304237;10559.736006599589;10054.447005414773;10233.795324093626;10393.012663796928;10428.634997775041;10474.319169253975;8621.180987806149;8663.783405414662;8838.646454141763;8936.061713519986;9239.538023098683;8247.587620619064;8448.324134069382;8894.199522043047;8969.416987895765;9000.864987025068 05:05:40 INFO - PROCESS | 1666 | __end_tp_report 05:05:40 INFO - PROCESS | 1666 | __start_cc_report 05:05:40 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,365 05:05:40 INFO - PROCESS | 1666 | __end_cc_report 05:05:40 INFO - PROCESS | 1666 | __startTimestamp1458216340320__endTimestamp 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:05:40 INFO - PROCESS | 1666 | Number of tests: 6 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5750.06 Median:6046.67 stddev:673.46 (11.1%) stddev-sans-first:649.22 05:05:40 INFO - PROCESS | 1666 | Values: 3374.0 3475.1 3535.1 3549.8 3567.9 4619.3 5421.0 5729.3 5753.0 5788.7 5681.4 5694.9 5721.9 5861.4 5914.1 5175.5 5183.5 5205.4 5239.8 5296.6 5288.7 5362.8 5375.7 5400.4 5405.6 5140.9 5249.4 5258.9 5275.5 5311.4 5230.6 5242.8 5250.2 5268.7 5276.3 5101.8 5202.0 5220.9 5256.6 5289.4 5645.9 5700.7 5751.0 5763.6 5770.4 6205.9 6236.2 6242.9 6249.8 6302.7 6132.6 6183.3 6248.3 6252.2 6257.7 5970.2 5979.4 5993.6 6004.8 6046.7 6364.6 6403.6 6404.1 6416.8 6427.6 6081.3 6143.7 6165.9 6244.9 6266.1 6217.4 6252.8 6255.2 6275.8 6309.7 6131.4 6155.2 6182.1 6257.1 6266.6 4880.4 5031.9 5463.5 6141.8 6198.3 4969.6 4970.0 4988.9 4997.5 5003.0 3540.4 3734.4 4448.7 4462.2 4464.4 4914.3 5729.0 5762.8 5929.4 5946.2 6169.9 6200.7 6223.2 6230.6 6250.0 5051.8 5639.4 5864.4 5871.9 5939.0 5350.9 5436.8 5474.5 5489.4 5527.6 6443.1 6471.3 6489.5 6511.0 6512.0 6090.5 6230.2 6236.7 6237.8 6254.7 5906.6 6050.6 6468.3 6496.1 6499.9 6182.5 6223.7 6245.3 6253.9 6263.3 6134.0 6156.0 6160.6 6244.0 6273.3 5088.9 6108.1 6146.6 6187.6 6273.7 6006.1 6153.8 6200.3 6211.5 6223.5 5587.9 5872.7 6073.5 6133.4 6144.8 6146.7 6187.9 6208.7 6209.5 6221.7 6076.7 6138.7 6141.5 6160.6 6167.8 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:62356.35 Median:37913.72 stddev:126898.70 (334.7%) stddev-sans-first:127169.56 05:05:40 INFO - PROCESS | 1666 | Values: 449.9 592.0 602.0 640.9 641.7 37146.8 37654.6 37859.0 37968.4 38008.0 39469.6 39619.4 39628.0 39949.8 39950.2 9382.3 9472.6 9534.0 9567.7 9600.9 8048.6 8102.6 9399.2 9640.2 9709.6 8039.8 8477.0 8868.1 9664.9 9711.8 9651.0 9657.2 9710.8 9722.3 9745.8 9529.9 9675.8 9679.9 9697.0 9756.1 32210.7 38494.0 38540.6 38807.6 38819.0 3159.3 3186.1 3224.7 3292.9 3481.7 27908.7 28328.7 28470.4 28905.7 29175.7 2662.7 2706.6 2745.0 2788.4 2864.0 388568.0 391887.0 392821.0 392984.0 539510.3 63552.0 64268.0 64352.0 64474.7 64505.4 68369.3 68474.7 68708.0 68762.7 73649.0 16993.0 17130.8 17138.0 17161.4 17185.6 12755.6 13007.7 13136.5 13230.2 13244.5 21628.0 22008.3 22160.6 22392.7 22519.5 7795.3 9194.0 9455.0 9495.7 9530.2 1015.5 1026.6 1053.5 1104.6 1143.4 29020.6 29395.7 29520.7 29759.0 29896.4 1075.9 1115.0 1120.6 1152.7 1170.2 11560.9 14800.3 14862.8 15206.5 15254.8 516677.0 522517.0 522985.4 523827.0 524334.0 58092.0 58163.0 58245.4 58742.7 58921.0 1173.9 1263.5 1384.5 1411.8 1483.2 29143.3 29278.0 29349.3 29762.3 29862.0 42291.6 51088.2 51263.2 51363.0 51742.0 473779.0 474936.0 475824.0 488113.6 488736.0 26910.3 32749.7 33421.0 33605.3 34000.8 34882.8 44766.6 44847.0 45614.8 45946.0 37327.6 38172.8 40277.0 40498.6 41358.4 36214.3 36796.6 36819.4 36990.4 37575.2 36232.5 36532.0 36843.4 37149.0 37470.4 31544.4 32131.5 32141.4 32308.8 32480.4 21455.1 22953.4 24422.3 24683.0 24965.6 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:32445.65 Median:365.44 stddev:99943.41 (27349.0%) stddev-sans-first:100194.72 05:05:40 INFO - PROCESS | 1666 | Values: 350.4 359.8 363.7 364.7 366.1 19017.0 19581.2 21292.9 21347.6 21477.7 11879.4 12301.0 12339.0 12343.0 12383.9 4522.3 5144.9 5162.1 5397.4 5459.1 5278.4 5280.2 5299.7 5326.3 5368.4 4602.3 5247.5 5356.5 5473.6 5931.9 5793.8 5823.9 5863.6 5911.7 5922.6 5113.9 5161.8 5166.3 5227.7 5240.9 13274.1 13302.3 13573.0 13575.3 13586.1 2092.5 2096.5 2133.1 2166.3 2187.7 9521.2 9883.2 10036.3 10139.1 10213.6 1667.9 1739.7 1762.1 1796.6 1817.7 74217.3 93235.5 93949.1 96296.0 101797.5 10933.6 11141.8 11181.3 11268.5 11323.8 13400.5 13428.9 13480.1 13484.3 13559.8 8438.9 8608.8 8637.8 8660.2 8712.7 7852.0 8141.0 8798.1 8957.1 9064.1 4362.4 4383.5 4412.4 4432.9 4506.0 1863.5 1929.3 1953.0 1956.4 1958.4 661.4 752.0 872.3 961.1 975.3 18175.3 20025.4 20239.8 20255.8 20477.0 933.7 936.6 943.7 967.9 983.4 9265.4 10666.8 10918.3 10930.0 11014.1 535255.0 586592.1 622994.0 632737.0 642474.0 76068.0 103296.5 112838.0 114573.4 115547.0 930.6 995.5 1017.8 1034.8 1043.6 16023.0 17918.0 17946.4 17991.5 18027.5 33275.8 48016.5 48618.0 48806.8 49937.8 62809.0 62950.7 67308.7 67442.0 67450.0 7527.6 7756.3 7782.4 7920.2 7945.6 11306.8 12283.8 12561.4 12624.7 12670.2 9956.6 10400.7 10508.4 10629.2 10824.2 8640.6 9877.0 10580.5 10831.6 10937.8 10352.7 10493.4 10978.4 11167.9 11204.6 7719.9 7877.6 7892.0 7990.4 8169.7 9407.4 10777.0 10876.9 10996.5 11137.3 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6049.05 Median:5410.13 stddev:3173.38 (58.7%) stddev-sans-first:3164.79 05:05:40 INFO - PROCESS | 1666 | Values: 1616.0 1628.9 1929.2 1994.1 2001.4 7866.1 8527.0 8677.4 8868.5 8882.3 8600.2 8600.5 8639.5 8719.0 8742.6 2447.0 2454.7 2464.3 2470.5 2477.3 2410.8 2492.8 2495.0 2497.4 2497.5 2462.8 2476.7 2500.1 2501.1 2506.5 2455.8 2457.9 2495.3 2496.4 2508.3 2448.4 2466.9 2478.1 2480.9 2502.4 8864.7 8873.6 8898.0 8910.2 8918.9 5316.5 5372.7 5388.9 5431.4 5441.7 3635.3 3710.1 3758.2 3779.4 3781.7 893.9 1047.1 1071.8 1088.2 1107.9 11747.1 11748.6 11935.8 11949.5 11978.0 4832.2 4870.6 4943.6 4947.4 4961.2 10168.6 10169.1 10172.9 10179.4 10194.5 5480.2 5488.2 5498.4 5504.0 5558.6 3834.6 4733.5 4955.7 4967.7 4997.4 3827.5 3910.7 3919.9 3922.2 3925.7 1311.0 1321.4 1325.7 1328.8 1341.3 1297.0 1325.9 1347.5 1350.9 1358.7 8115.1 8163.4 8183.7 8252.6 8288.7 503.4 512.6 515.0 516.7 518.7 6048.9 6242.3 6290.2 6303.1 6310.9 10396.3 10693.3 10708.3 10774.3 10826.8 8927.8 10065.3 10316.9 10364.4 10632.1 8152.5 8181.6 8321.8 8322.4 8324.8 8050.9 8059.6 8064.3 8084.4 8097.2 9332.7 9507.0 9548.4 9599.5 9609.0 9340.3 9642.1 9660.3 9939.5 9986.5 6802.6 7247.3 7462.3 7466.4 7593.3 8216.0 8222.4 8253.5 8283.3 8301.3 7223.4 7239.6 7397.9 7481.0 7586.4 7288.9 7308.5 7324.3 7403.9 7456.8 7681.4 7730.2 7773.0 7773.3 7774.8 6957.5 6976.2 7031.5 7036.7 7056.2 7124.2 7149.1 7244.2 7250.8 7255.3 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5951.73 Median:6778.48 stddev:1904.68 (28.1%) stddev-sans-first:1862.56 05:05:40 INFO - PROCESS | 1666 | Values: 322.3 325.9 328.8 331.6 332.1 6766.7 6806.1 6830.0 6847.8 6902.0 6740.6 6760.2 6769.1 6787.8 6800.4 4764.0 4850.1 4979.5 5006.5 5027.7 4958.3 4960.1 4965.4 4967.1 4981.2 4906.8 4912.7 4939.7 4953.2 4965.3 4112.0 4919.0 4941.3 4944.4 4953.7 3835.4 3942.2 4250.6 4278.9 4285.7 6276.5 6455.8 6519.7 6555.6 6566.2 5960.6 5970.9 6008.9 6079.0 6136.7 7189.9 7224.4 7225.7 7254.3 7266.4 4816.1 4817.6 4817.7 4824.5 4827.0 7686.0 7701.2 7709.9 7723.4 7746.7 4695.7 4885.9 4898.8 4923.8 4925.1 4962.1 4993.1 5015.3 5019.5 5021.5 4847.3 5849.5 5910.1 5913.8 5930.7 7282.6 7287.1 7288.9 7312.3 7318.7 1712.0 1738.7 1740.2 1741.7 1743.0 873.8 1105.6 1123.4 1125.5 1129.6 6760.8 6814.2 6832.7 6871.3 6877.2 6068.5 7530.0 7535.7 7555.0 7568.4 6600.9 6664.3 6854.2 6902.7 6909.0 3957.2 4017.5 4019.5 4031.0 4042.8 7042.6 7460.1 8019.8 8029.8 8052.9 7396.4 7871.2 7875.1 7880.0 7912.2 6381.3 7869.1 7893.5 7916.8 7972.7 6596.6 7521.2 7528.1 7535.0 7596.2 7438.8 7443.3 7452.0 7462.2 7509.9 7695.5 7945.9 7952.2 7955.3 7960.1 4675.3 4687.6 4716.9 4733.4 4760.0 7525.5 7527.0 7569.0 7572.5 7588.5 6118.5 7133.8 7294.1 7304.0 7311.1 6917.2 7259.8 7282.2 7297.8 7321.5 7106.1 7109.4 7118.7 7121.3 7156.4 6690.0 7279.2 7296.8 7298.8 7356.5 7124.3 7126.1 7136.6 7138.6 7148.8 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:17258.95 Median:625.17 stddev:23931.24 (3828.0%) stddev-sans-first:23966.05 05:05:40 INFO - PROCESS | 1666 | Values: 692.8 730.3 748.1 753.2 769.3 14844.3 14965.3 15073.5 15110.4 15134.0 13981.3 14014.8 14037.5 14061.4 14069.9 905.6 933.0 934.3 935.4 938.9 620.3 925.8 931.1 942.4 958.8 986.3 989.2 989.4 990.2 992.0 972.0 975.8 980.2 982.6 982.8 702.9 703.5 725.3 728.8 731.0 15047.7 15131.9 15134.7 15256.0 15365.6 12736.2 13040.5 13224.8 13326.3 13334.4 9663.0 10175.9 10285.1 10525.7 10526.8 3511.5 3561.1 3569.2 3607.9 3664.8 72152.6 72630.6 73035.6 73145.6 73464.3 9175.9 9422.4 9481.1 9517.0 9621.0 22008.6 22024.1 22058.1 22072.9 22134.0 6638.5 7324.2 7476.3 7543.5 7615.4 3605.7 3631.5 3692.9 3718.8 3746.3 3586.7 3595.4 3610.0 3615.5 3620.8 630.0 633.1 636.7 650.7 651.2 568.6 574.9 589.1 590.4 611.4 6478.7 7962.5 8049.8 8214.6 8252.0 454.5 464.5 498.3 596.2 617.3 3309.9 3698.9 3852.2 3881.7 3899.6 56113.7 68907.0 88230.0 88549.0 88595.6 61126.0 74953.6 77698.2 79010.2 80760.0 69403.0 69775.3 69921.0 70378.0 73862.6 7727.4 7762.1 7787.7 7815.8 7826.3 33720.7 48923.8 49123.0 49185.0 50104.7 50422.7 68765.3 69080.3 70667.6 70679.6 9965.3 10137.4 10157.9 10243.4 10397.3 9537.5 10581.3 10788.4 10867.8 11095.5 10049.2 10067.3 10184.7 10208.4 10632.1 10245.9 10276.1 10311.0 10520.5 10559.7 10054.4 10233.8 10393.0 10428.6 10474.3 8621.2 8663.8 8838.6 8936.1 9239.5 8247.6 8448.3 8894.2 8969.4 9000.9 05:05:40 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:05:40 INFO - PROCESS | 1666 | 05:05:40 INFO - TEST-INFO | 1666: exit 0 05:05:40 INFO - TEST-OK | dromaeo_css | took 1111602ms 05:05:40 INFO - TEST-START | kraken 05:05:40 INFO - operating with platform_type : mac_ 05:05:40 INFO - Initialising browser for kraken test... 05:05:40 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpyOLsjb/profile http://localhost:49270/getInfo.html) 05:05:43 INFO - PROCESS | 1677 | 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] 05:05:43 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 05:05:43 INFO - PROCESS | 1677 | colorDepth:24 05:05:43 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 05:05:43 INFO - PROCESS | 1677 | __metrics 05:05:43 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:05:44 INFO - TEST-INFO | 1677: exit 0 05:05:44 INFO - Browser initialized. 05:05:44 INFO - Running cycle 1/1 for kraken test... 05:05:44 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmpyOLsjb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:56 INFO - PROCESS | 1680 | RSS: Main: 255926272 05:05:56 INFO - PROCESS | 1680 | 05:05:59 INFO - PROCESS | 1680 | 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) 05:05:59 INFO - PROCESS | 1680 | RSS: Main: 269176832 05:05:59 INFO - PROCESS | 1680 | 05:06:02 INFO - PROCESS | 1680 | 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) 05:06:02 INFO - PROCESS | 1680 | RSS: Main: 276852736 05:06:02 INFO - PROCESS | 1680 | 05:06:06 INFO - PROCESS | 1680 | 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) 05:06:06 INFO - PROCESS | 1680 | RSS: Main: 281681920 05:06:06 INFO - PROCESS | 1680 | 05:06:08 INFO - PROCESS | 1680 | 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) 05:06:09 INFO - PROCESS | 1680 | RSS: Main: 282374144 05:06:09 INFO - PROCESS | 1680 | 05:06:11 INFO - PROCESS | 1680 | 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) 05:06:12 INFO - PROCESS | 1680 | RSS: Main: 282763264 05:06:12 INFO - PROCESS | 1680 | 05:06:14 INFO - PROCESS | 1680 | 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) 05:06:15 INFO - PROCESS | 1680 | RSS: Main: 282525696 05:06:15 INFO - PROCESS | 1680 | 05:06:18 INFO - PROCESS | 1680 | 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) 05:06:18 INFO - PROCESS | 1680 | RSS: Main: 282812416 05:06:18 INFO - PROCESS | 1680 | 05:06:21 INFO - PROCESS | 1680 | 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) 05:06:22 INFO - PROCESS | 1680 | RSS: Main: 282439680 05:06:22 INFO - PROCESS | 1680 | 05:06:23 INFO - PROCESS | 1680 | 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) 05:06:24 INFO - PROCESS | 1680 | RSS: Main: 283467776 05:06:24 INFO - PROCESS | 1680 | 05:06:26 INFO - PROCESS | 1680 | 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) 05:06:27 INFO - PROCESS | 1680 | RSS: Main: 284889088 05:06:27 INFO - PROCESS | 1680 | 05:06:29 INFO - PROCESS | 1680 | 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) 05:06:30 INFO - PROCESS | 1680 | RSS: Main: 284930048 05:06:30 INFO - PROCESS | 1680 | 05:06:32 INFO - PROCESS | 1680 | 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) 05:06:33 INFO - PROCESS | 1680 | RSS: Main: 284909568 05:06:33 INFO - PROCESS | 1680 | 05:06:35 INFO - PROCESS | 1680 | 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) 05:06:36 INFO - PROCESS | 1680 | RSS: Main: 283398144 05:06:36 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | 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) 05:06:38 INFO - PROCESS | 1680 | RSS: Main: 284590080 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | __start_tp_report 05:06:38 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 05:06:38 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 05:06:38 INFO - PROCESS | 1680 | |i|pagename|runs| 05:06:38 INFO - PROCESS | 1680 | |0;ai-astar;114;106;117;115;115;131;120;116;115;115 05:06:38 INFO - PROCESS | 1680 | |1;audio-beat-detection;157;126;144;155;118;157;171;117;156;124 05:06:38 INFO - PROCESS | 1680 | |2;audio-dft;192;198;207;202;202;228;196;197;225;205 05:06:38 INFO - PROCESS | 1680 | |3;audio-fft;68;77;60;48;76;83;87;147;83;86 05:06:38 INFO - PROCESS | 1680 | |4;audio-oscillator;81;89;123;79;81;79;116;79;80;120 05:06:38 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;96;88;100;113;89;86;90;96;134;86 05:06:38 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;96;95;95;116;96;95;97;95;95 05:06:38 INFO - PROCESS | 1680 | |7;imaging-desaturate;83;147;146;91;91;90;93;92;94;94 05:06:38 INFO - PROCESS | 1680 | |8;json-parse-financial;56;58;57;54;58;58;57;67;59;55 05:06:38 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;69;98;74;81;107;58;87;104;103;90 05:06:38 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;84;84;86;85;85;91;92;105;105;114 05:06:38 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;134;134;124;122;124;129;134;123;106;145 05:06:38 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;157;192;132;186;186;166;144;146;143;134 05:06:38 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;69;67;66;67;69;67;73;88;105;99 05:06:38 INFO - PROCESS | 1680 | __end_tp_report 05:06:38 INFO - PROCESS | 1680 | __start_cc_report 05:06:38 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,927 05:06:38 INFO - PROCESS | 1680 | __end_cc_report 05:06:38 INFO - PROCESS | 1680 | __startTimestamp1458216398567__endTimestamp 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | ------- Summary: start ------- 05:06:38 INFO - PROCESS | 1680 | Number of tests: 14 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:116.40 Median:115.50 stddev:6.22 (5.4%) stddev-sans-first:6.54 05:06:38 INFO - PROCESS | 1680 | Values: 114.0 106.0 117.0 115.0 115.0 131.0 120.0 116.0 115.0 115.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:155.50 stddev:19.55 (12.6%) stddev-sans-first:20.02 05:06:38 INFO - PROCESS | 1680 | Values: 157.0 126.0 144.0 155.0 118.0 157.0 171.0 117.0 156.0 124.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:205.20 Median:203.50 stddev:12.08 (5.9%) stddev-sans-first:11.83 05:06:38 INFO - PROCESS | 1680 | Values: 192.0 198.0 207.0 202.0 202.0 228.0 196.0 197.0 225.0 205.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:81.50 Median:80.00 stddev:26.17 (32.7%) stddev-sans-first:27.29 05:06:38 INFO - PROCESS | 1680 | Values: 68.0 77.0 60.0 48.0 76.0 83.0 87.0 147.0 83.0 86.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:79.50 stddev:18.91 (23.8%) stddev-sans-first:19.58 05:06:38 INFO - PROCESS | 1680 | Values: 81.0 89.0 123.0 79.0 81.0 79.0 116.0 79.0 80.0 120.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:88.50 stddev:15.15 (17.1%) stddev-sans-first:16.05 05:06:38 INFO - PROCESS | 1680 | Values: 96.0 88.0 100.0 113.0 89.0 86.0 90.0 96.0 134.0 86.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:95.00 stddev:6.59 (6.9%) stddev-sans-first:6.87 05:06:38 INFO - PROCESS | 1680 | Values: 94.0 96.0 95.0 95.0 116.0 96.0 95.0 97.0 95.0 95.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:91.50 stddev:23.61 (25.8%) stddev-sans-first:24.01 05:06:38 INFO - PROCESS | 1680 | Values: 83.0 147.0 146.0 91.0 91.0 90.0 93.0 92.0 94.0 94.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:3.54 (6.1%) stddev-sans-first:3.69 05:06:38 INFO - PROCESS | 1680 | Values: 56.0 58.0 57.0 54.0 58.0 58.0 57.0 67.0 59.0 55.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:87.10 Median:77.50 stddev:16.48 (21.3%) stddev-sans-first:16.13 05:06:38 INFO - PROCESS | 1680 | Values: 69.0 98.0 74.0 81.0 107.0 58.0 87.0 104.0 103.0 90.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:85.00 stddev:10.92 (12.8%) stddev-sans-first:11.07 05:06:38 INFO - PROCESS | 1680 | Values: 84.0 84.0 86.0 85.0 85.0 91.0 92.0 105.0 105.0 114.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:131.50 stddev:10.39 (7.9%) stddev-sans-first:10.76 05:06:38 INFO - PROCESS | 1680 | Values: 134.0 134.0 124.0 122.0 124.0 129.0 134.0 123.0 106.0 145.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:161.50 stddev:22.61 (14.0%) stddev-sans-first:23.98 05:06:38 INFO - PROCESS | 1680 | Values: 157.0 192.0 132.0 186.0 186.0 166.0 144.0 146.0 143.0 134.0 05:06:38 INFO - PROCESS | 1680 | 05:06:38 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:69.00 stddev:14.73 (21.4%) stddev-sans-first:15.34 05:06:38 INFO - PROCESS | 1680 | Values: 69.0 67.0 66.0 67.0 69.0 67.0 73.0 88.0 105.0 99.0 05:06:38 INFO - PROCESS | 1680 | -------- Summary: end -------- 05:06:38 INFO - PROCESS | 1680 | 05:06:39 INFO - TEST-INFO | 1680: exit 0 05:06:39 INFO - TEST-OK | kraken | took 58504ms 05:06:39 INFO - SUITE-END | took 1170s 05:06:39 INFO - Completed test suite (00:19:30) 05:06:39 INFO - javascript benchmark 05:06:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3373.9831300843493, 3475.096474916521, 3535.1338921964125, 3549.840257188425, 3567.9108022299424, 4619.284010978296, 5421.024215641183, 5729.255196824407, 5753.0, 5788.6816225107605, 5681.375048744635, 5694.886102277952, 5721.885562288762, 5861.413858614136, 5914.112883067542, 5175.456577059411, 5183.455737147611, 5205.37535495741, 5239.816606418776, 5296.602754793386, 5288.735563221842, 5362.785488580452, 5375.650582712131, 5400.432954539776, 5405.567554595643, 5140.94610604827, 5249.42256351801, 5258.868528286824, 5275.472452754732, 5311.415744268127, 5230.633855630107, 5242.817340243891, 5250.212468129773, 5268.736563171864, 5276.34045744282, 5101.82143624975, 5202.037623039712, 5220.895582088375, 5256.579473642138, 5289.44460831611, 5645.887082258373, 5700.714964251771, 5751.0, 5763.567732420085, 5770.365259821417, 6205.87588248237, 6236.220472440945, 6242.906356404657, 6249.843753906143, 6302.653354065525, 6132.63086471492, 6183.258009038944, 6248.343923888017, 6252.155958945529, 6257.749690012394, 5970.223870896755, 5979.431953964367, 5993.550483713739, 6004.759809607567, 6046.667433291167, 6364.586301890362, 6403.583767055126, 6404.103425520431, 6416.839579010562, 6427.550071495044, 6081.27024757032, 6143.723532441051, 6165.907511387333, 6244.875102498016, 6266.060090986389, 6217.378262173836, 6252.843678908063, 6255.218097737783, 6275.780347687809, 6309.747610095545, 6131.386861313922, 6155.169052177898, 6182.103594978703, 6257.09272155544, 6266.624002559861, 4880.41435027799, 5031.949680503149, 5463.48096930791, 6141.792871882774, 6198.349173336825, 4969.577585905238, 4970.030843985461, 4988.925166122511, 4997.525235102659, 5003.0, 3540.3981323174607, 3734.3651579231055, 4448.688591798543, 4462.174497717932, 4464.419625448671, 4914.287428322873, 5728.968785618546, 5762.827115186551, 5929.436703513159, 5946.167536544887, 6169.893307082685, 6200.720967556471, 6223.159873417121, 6230.563860529719, 6250.0, 5051.848444546669, 5639.407862174413, 5864.44287792659, 5871.94128058714, 5939.0136229180525, 5350.903064871692, 5436.836894893159, 5474.534664553478, 5489.39616642169, 5527.640703354269, 6443.130177426175, 6471.320511346335, 6489.545731798728, 6510.967445162839, 6511.967440162769, 6090.482309003607, 6230.15892854477, 6236.719347629277, 6237.844053898689, 6254.655993920378, 5906.557008224487, 6050.576459647782, 6468.320826313357, 6496.090547323473, 6499.935000649933, 6182.474489668429, 6223.657698826608, 6245.313015568375, 6253.906191407042, 6263.311035785969, 6134.038624681977, 6155.953487907156, 6160.599561028519, 6243.96878015607, 6273.341299163522, 5088.923666144937, 6108.053251745987, 6146.631202127886, 6187.597806142587, 6273.717682704198, 6006.101657799584, 6153.784617538365, 6200.3179650239335, 6211.503079753518, 6223.471004964629, 5587.854489829494, 5872.677002764889, 6073.544484163794, 6133.3866613338305, 6144.815655530341, 6146.692665366624, 6187.907181392193, 6208.72060757258, 6209.472194863487, 6221.688915554295, 6076.726547305293, 6138.723757430837, 6141.477974372228, 6160.568760186923, 6167.753289868355], "unit": "score", "name": "dojo.html", "value": 5707.956909794647}, {"lowerIsBetter": false, "replicates": [449.9347594598783, 591.9847461603349, 601.9616162120341, 640.9230892292924, 641.7144370755013, 37146.81426592867, 37654.62345376549, 37859.0, 37968.43047354288, 38008.0, 39469.605303946955, 39619.40570891439, 39628.0, 39949.800250998705, 39950.200995980136, 9382.343235973502, 9472.62109515622, 9534.0, 9567.66513172039, 9600.903990960105, 8048.5975701215, 8102.5543595102245, 9399.24806015517, 9640.228781697448, 9709.563069661883, 8039.839203215962, 8476.957615211946, 8868.113188681145, 9664.855027174597, 9711.805763884753, 9651.0, 9657.22742180624, 9710.805783884283, 9722.319437639404, 9745.756356091119, 9529.857052144223, 9675.758106047335, 9679.854802177973, 9696.951515242448, 9756.07317304855, 32210.677893221004, 38494.0, 38540.61459385426, 38807.61192388096, 38819.0, 3159.2575744699975, 3186.123815950609, 3224.6775322467565, 3292.901212963615, 3481.669241422061, 27908.720912790814, 28328.716712832815, 28470.430591388264, 28905.710942890513, 29175.70824291751, 2662.7071022187542, 2706.5669492881243, 2744.9588256176175, 2788.358677504165, 2864.0262310814423, 388568.0, 391887.0, 392821.0, 392984.0, 539510.3024484891, 63552.0, 64268.0, 64352.03471947925, 64474.67762661157, 64505.35494644994, 68369.3163068373, 68474.65762671155, 68707.96938045933, 68762.65618671874, 73649.0, 16993.0, 17130.828691712923, 17137.971721696736, 17161.399351022905, 17185.570360741083, 12755.553555625509, 13007.674808129872, 13136.540221092217, 13230.206187628773, 13244.53644122451, 21628.0, 22008.339749807532, 22160.56233814279, 22392.664110038364, 22519.549609008056, 7795.3373963212625, 9193.95403022994, 9455.0, 9495.667651632299, 9530.189264039811, 1015.5125539740966, 1026.594495174402, 1053.489057806963, 1104.6244276945877, 1143.3768596115137, 29020.564691529646, 29395.706042939724, 29520.704792951794, 29759.0, 29896.402071958873, 1075.8977897099762, 1114.9777004459866, 1120.5797825815318, 1152.7291086594644, 1170.1984140863535, 11560.942195289137, 14800.333984970703, 14862.777058344134, 15206.467773628092, 15254.847451525342, 516677.0, 522517.0, 522985.3850730722, 523827.0, 524334.0, 58092.0, 58163.0, 58245.417545824, 58742.70628646915, 58921.0, 1173.929564226149, 1263.4882872436679, 1384.5084994826893, 1411.8376386715454, 1483.2435457916324, 29143.271418214714, 29277.975270865416, 29349.26626834346, 29762.255943601584, 29862.013798619962, 42291.57708422876, 51088.23367649563, 51263.231051535004, 51363.0, 51742.0, 473779.0, 474936.0, 475824.0, 488113.55943220056, 488736.0, 26910.32724181911, 32749.67250327466, 33421.0, 33605.32789344248, 34000.82999584986, 34882.825585872924, 44766.55233447754, 44847.0, 45614.77192614016, 45946.0, 37327.626723732414, 38172.80913595414, 40276.993075173355, 40498.59501405066, 41358.37962430506, 36214.27571448609, 36796.60822046558, 36819.447708283864, 36990.44514332234, 37575.24849503049, 36232.456513151796, 36532.0, 36843.447348290334, 37149.0, 37470.43794343142, 31544.36911261716, 32131.518027229144, 32141.392930352922, 32308.83845580757, 32480.350392991535, 21455.14179432805, 22953.426164346023, 24422.26733198007, 24683.01267949262, 24965.625515616917], "unit": "score", "name": "ext.html", "value": 19739.116084023644}, {"lowerIsBetter": false, "replicates": [350.35184907920336, 359.8093010704327, 363.7126669930754, 364.73738907986274, 366.13591923061585, 19017.0, 19581.216751329946, 21292.8935355323, 21347.57304853902, 21477.67783483249, 11879.406029698524, 12301.0, 12339.012878969683, 12342.950849177809, 12383.938080309608, 4522.3216517522305, 5144.948550514503, 5162.148245539491, 5397.3523177218785, 5459.071957767169, 5278.445763194867, 5280.234366016925, 5299.655522391052, 5326.334208223972, 5368.382635996872, 4602.2636378179495, 5247.47525247476, 5356.491133342326, 5473.616846820724, 5931.911021334662, 5793.826185214451, 5823.941760582404, 5863.560232982522, 5911.733971971272, 5922.555808314372, 5113.923291150636, 5161.793528258865, 5166.276721259027, 5227.712475813829, 5240.895182096375, 13274.070815042951, 13302.268375239359, 13573.049886507948, 13575.253361065137, 13586.11690240141, 2092.4664210626192, 2096.549241912981, 2133.136079887648, 2166.306781829815, 2187.737471503414, 9521.190698790611, 9883.209343252522, 10036.29745917786, 10139.138173255282, 10213.642522511676, 1667.8999260044436, 1739.721644536868, 1762.0925223509776, 1796.5598428385128, 1817.7182536706832, 74217.25782742212, 93235.53382233113, 93949.12101757927, 96296.0, 101797.4910125452, 10933.56265749377, 11141.832872506919, 11181.273217240854, 11268.492917818718, 11323.830142547868, 13400.463981440827, 13428.865711342956, 13480.056396052378, 13484.325783710776, 13559.796603050961, 8438.945131858518, 8608.827823443497, 8637.784055398666, 8660.220580147818, 8712.69505567302, 7851.960740196377, 8141.0, 8798.12018798115, 8957.14907083839, 9064.093590640883, 4362.389265502832, 4383.49589797171, 4412.360207769855, 4432.911341773147, 4506.0, 1863.4595967169369, 1929.3150931419425, 1953.0, 1956.432634535997, 1958.4320547041484, 661.3584822721951, 751.9849603007909, 872.3065163195275, 961.0965692249264, 975.3465178330536, 18175.272989080553, 20025.39923802288, 20239.79760202379, 20255.84437631693, 20477.0, 933.6778811310087, 936.6487567162314, 943.7499062748377, 967.8935317115112, 983.439439519467, 9265.39774914642, 10666.839997400046, 10918.344899306067, 10930.0, 11014.118870490342, 535255.0, 586592.067039662, 622994.0, 632737.0, 642474.0, 76068.0, 103296.48351758193, 112838.0, 114573.42713286547, 115547.0, 930.6463543853292, 995.5370752600076, 1017.7557386227252, 1034.79821434821, 1043.6347278452633, 16023.0, 17918.0145092016, 17946.37187698424, 17991.460256192335, 18027.459176224733, 33275.83362083174, 48016.519834801205, 48618.0, 48806.75596621994, 49937.75031124821, 62809.0, 62950.68524657348, 67308.6634566824, 67442.0, 67450.0, 7527.585982771, 7756.263155000266, 7782.416318776001, 7920.207979202034, 7945.562994035384, 11306.756256811908, 12283.754324913272, 12561.43473543711, 12624.74750505003, 12670.176438531465, 9956.55195516218, 10400.739981500523, 10508.42203678805, 10629.202809789142, 10824.188185885932, 8640.56797160152, 9877.0, 10580.4709764513, 10831.620893268699, 10937.83593246118, 10352.741181470523, 10493.422861742678, 10978.396188209725, 11167.944160279147, 11204.647024124699, 7719.922800772145, 7877.566733829465, 7892.0, 7990.400719945911, 8169.673213071411, 9407.43555386679, 10777.0, 10876.91230876906, 10996.450177490933, 11137.276077054965], "unit": "score", "name": "jquery.html", "value": 8780.609666300907}, {"lowerIsBetter": false, "replicates": [1615.9919200404, 1628.9266982985769, 1929.151173483667, 1994.062790488471, 2001.379572332578, 7866.095399029114, 8527.038781080355, 8677.435966662162, 8868.512231827246, 8882.333824963129, 8600.182982616641, 8600.526971016592, 8639.481631102139, 8719.0, 8742.562871856413, 2446.9632955505635, 2454.6931633545805, 2464.2853572463964, 2470.518248941457, 2477.2939712182033, 2410.831241813065, 2492.8379655322346, 2494.9875250623722, 2497.400623850281, 2497.475530138673, 2462.8029757619347, 2476.6780318558563, 2500.1499490173337, 2501.112105202654, 2506.4736405354897, 2455.791257743094, 2457.8893949772214, 2495.3262619092834, 2496.4133428644254, 2508.3227528567186, 2448.43685952232, 2466.90132394704, 2478.120267305099, 2480.937976550583, 2502.399424138212, 8864.689735859278, 8873.645054197825, 8898.021217666052, 8910.242629376511, 8918.94864181242, 5316.521513063843, 5372.7045012524295, 5388.892222155535, 5431.375391829911, 5441.673499590037, 3635.291118231946, 3710.109573702319, 3758.229562939591, 3779.433085037239, 3781.716371272166, 893.8927328720595, 1047.1361127070122, 1071.8231491803842, 1088.1729885287239, 1107.900288973996, 11747.118966077493, 11748.647540573711, 11935.761284774342, 11949.522019119226, 11978.041756659446, 4832.226843704991, 4870.6103511718975, 4943.579795717333, 4947.356843610308, 4961.231009193581, 10168.593256269814, 10169.135623472088, 10172.898271017195, 10179.389236645677, 10194.490275486345, 5480.177973304037, 5488.1767734839295, 5498.395176530578, 5504.0, 5558.583106267046, 3834.5812049541846, 4733.455652599926, 4955.677880937799, 4967.726775027409, 4997.375328083989, 3827.5406951165482, 3910.7262491625884, 3919.8824035278985, 3922.1763429679518, 3925.7448265862627, 1310.9541166059141, 1321.3987635625958, 1325.6752095736606, 1328.7807511760645, 1341.3092257487401, 1296.9740605187844, 1325.8674132586664, 1347.4879545772544, 1350.9054366194468, 1358.7282543491342, 8115.066767321716, 8163.38774591908, 8183.71357002502, 8252.628631711588, 8288.668453261922, 503.44369471733205, 512.6129772022099, 515.0420218393784, 516.6822404221452, 518.693970557373, 6048.909266361008, 6242.313345531988, 6290.245170579468, 6303.117563541108, 6310.9368906311265, 10396.324238924446, 10693.304935179189, 10708.250422470508, 10774.299670521392, 10826.783464330669, 8927.821443571092, 10065.345752526062, 10316.948415258026, 10364.378137311785, 10632.096271816983, 8152.510849349058, 8181.550014749246, 8321.833563328699, 8322.375821813388, 8324.750257492406, 8050.919490805251, 8059.597020149086, 8064.314533264738, 8084.39367047462, 8097.190280971856, 9332.72001839946, 9506.952465237906, 9548.42709437436, 9599.520023998912, 9609.0, 9340.299477539347, 9642.084002019797, 9660.275479338938, 9939.503024848584, 9986.450745209084, 6802.591844489149, 7247.275272472711, 7462.328390444886, 7466.402687785073, 7593.278638529331, 8216.014078310642, 8222.424430290062, 8253.504789712637, 8283.29591984688, 8301.252887240178, 7223.386012189023, 7239.601821899846, 7397.889031664422, 7481.027466429329, 7586.3930885527925, 7288.854222915406, 7308.488405811542, 7324.340809327186, 7403.888941665987, 7456.7762967111075, 7681.42389320792, 7730.226977302224, 7773.028371453568, 7773.261540153676, 7774.844503110019, 6957.547759395623, 6976.162860456778, 7031.507794454339, 7036.683349249399, 7056.188538317954, 7124.216336203117, 7149.106361704787, 7244.203137654748, 7250.782476525713, 7255.274472552703], "unit": "score", "name": "mootools.html", "value": 4869.768367027626}, {"lowerIsBetter": false, "replicates": [322.34242146022115, 325.9462188738858, 328.75343492380716, 331.61863856564946, 332.1016649961853, 6766.729330826767, 6806.094293597795, 6829.975503674451, 6847.794566163011, 6902.0, 6740.629265390402, 6760.188777346725, 6769.120014398133, 6787.830304242397, 6800.421964133042, 4764.023375208074, 4850.126977144113, 4979.526944940225, 5006.524380183877, 5027.723475208872, 4958.281049247857, 4960.131976904046, 4965.42897566779, 4967.056259310738, 4981.153203955337, 4906.803727850882, 4912.680675756064, 4939.678920870132, 4953.182724850395, 4965.255211718235, 4111.958880411187, 4919.040787046527, 4941.3329200558, 4944.406671199461, 4953.702777833306, 3835.3671644178676, 3942.211557688474, 4250.574942505725, 4278.935815962763, 4285.721428107163, 6276.529260305495, 6455.8063258101865, 6519.674016299214, 6555.573887697332, 6566.212054553484, 5960.552958528127, 5970.925233457976, 6008.918394688954, 6079.0273556230795, 6136.69316534176, 7189.928100718978, 7224.410629661466, 7225.710971561131, 7254.347108760184, 7266.382357499619, 4816.084943860656, 4817.614590832725, 4817.735024573647, 4824.541668541518, 4826.95173048272, 7685.961570192113, 7701.191374905667, 7709.922900770976, 7723.420743444208, 7746.728864489773, 4695.694779839299, 4885.902281954341, 4898.779554920037, 4923.75381230937, 4925.13810083234, 4962.131626965267, 4993.1262029144755, 5015.3480047593575, 5019.548240658358, 5021.548060674557, 4847.345608342828, 5849.502792262705, 5910.143029260819, 5913.822585322361, 5930.673812940244, 7282.635868206568, 7287.089113860768, 7288.927110728825, 7312.341889229995, 7318.670659820321, 1711.9657606847793, 1738.7044202485608, 1740.1821144062271, 1741.703910335246, 1743.0064863027953, 873.8383399071065, 1105.5854054729477, 1123.3596849795701, 1125.4935279124427, 1129.6215767717742, 6760.7633732820095, 6814.182298124257, 6832.726690932406, 6871.278515755874, 6877.243503214642, 6068.514518838482, 7530.0, 7535.660895259726, 7555.0178476798765, 7568.356689681329, 6600.900986485207, 6664.266930637626, 6854.2117656469145, 6902.723891044402, 6908.965455172692, 3957.1887763008513, 4017.4978127734034, 4019.4774679291504, 4030.9798451008146, 4042.8180731867137, 7042.647867606702, 7460.1047874254355, 8019.839603207904, 8029.759107226792, 8052.919470805217, 7396.4452666050265, 7871.212878712197, 7875.133735289113, 7880.0, 7912.248336408032, 6381.298057213703, 7869.055713314325, 7893.526388416713, 7916.762497125095, 7972.681092756225, 6596.571222870498, 7521.210272921265, 7528.096628404626, 7535.020447341811, 7596.164421913696, 7438.776836694691, 7443.292887175709, 7452.0, 7462.179160292472, 7509.9249007509225, 7695.4997925134685, 7945.880811787712, 7952.204779522001, 7955.2840244378285, 7960.084590272193, 4675.3220782986955, 4687.624990000723, 4716.858494245178, 4733.408323959505, 4759.976200118977, 7525.548467091992, 7527.021487206628, 7569.0, 7572.4699271050495, 7588.544687318778, 6118.510519158545, 7133.82165445868, 7294.088238970129, 7303.963480182565, 7311.122665280201, 6917.23910369869, 7259.782206533812, 7282.198958114497, 7297.781066568012, 7321.450891183076, 7106.076210092655, 7109.360157585842, 7118.715251389886, 7121.252268511732, 7156.355927966508, 6690.0, 7279.235680253709, 7296.817579560554, 7298.817529561803, 7356.521826081502, 7124.287571242834, 7126.109236345457, 7136.643167841691, 7138.64306784669, 7148.785536433916], "unit": "score", "name": "prototype.html", "value": 5308.959104011833}, {"lowerIsBetter": false, "replicates": [692.7817737412714, 730.349988510226, 748.0948052856044, 753.220416868541, 769.299937057278, 14844.257787110642, 14965.25173741314, 15073.472428464993, 15110.39558417662, 15134.0, 13981.300934953262, 14014.78977815331, 14037.50868719595, 14061.367238474268, 14069.859301406983, 905.597009330848, 932.9673461428852, 934.2666007184362, 935.4247138010143, 938.9014153513886, 620.3083561828552, 925.7639301977986, 931.1247427418239, 942.4109931292942, 958.8465845464727, 986.2800155886207, 989.2185173712759, 989.4014121456523, 990.1979396688669, 991.9553620087113, 971.9951400242988, 975.8487434447673, 980.1717548671361, 982.5578489679673, 982.832918403873, 702.9402500787439, 703.4513079797766, 725.2964624314459, 728.8469421421507, 731.016782427634, 15047.699046019019, 15131.924340378227, 15134.697306053928, 15256.0, 15365.615859603487, 12736.23582585048, 13040.478380864753, 13224.801627975588, 13326.267055311953, 13334.399952002183, 9663.0, 10175.898241017569, 10285.125764309967, 10525.684229473129, 10526.78946421075, 3511.473279008144, 3561.0919215599856, 3569.196930690574, 3607.9098022549383, 3664.8350824212976, 72152.63923680349, 72630.63684681595, 73035.63482182608, 73145.6342718283, 73464.26535734627, 9175.862362064574, 9422.387544809566, 9481.146696797321, 9516.999999999862, 9621.0, 22008.559828803656, 22024.11903523873, 22058.117675293128, 22072.88963555172, 22134.003969821075, 6638.468922486286, 7324.157721862054, 7476.252374762589, 7543.493249927584, 7615.352695020874, 3605.675489205984, 3631.455281707765, 3692.9261414771554, 3718.795466249382, 3746.344389731786, 3586.7130629549574, 3595.442706380463, 3609.9819500902854, 3615.475756015363, 3620.800855952948, 630.0266088892672, 633.1389310537666, 636.7389370358131, 650.6876699184418, 651.1762620285343, 568.6076607141059, 574.9252597162342, 589.1483632288104, 590.4095904095905, 611.4222060153113, 6478.708458119396, 7962.522248665098, 8049.758507244792, 8214.63034163464, 8251.95874020638, 454.4660024471233, 464.4821024557594, 498.30486471372234, 596.1862058290488, 617.3116974573319, 3309.933801324008, 3698.853355459816, 3852.2295540891932, 3881.708871834567, 3899.5710471848074, 56113.719431402584, 68906.9663955041, 88230.0, 88549.0, 88595.55702221447, 61126.0, 74953.62523187349, 77698.22301777023, 79010.20989790029, 80760.0, 69402.9589556157, 69775.3022469779, 69921.0, 70378.0, 73862.63068684623, 7727.381809455343, 7762.146163922077, 7787.727429539939, 7815.804604884924, 7826.265109608605, 33720.662793371754, 48923.776905577644, 49123.0, 49185.0, 50104.749476252386, 50422.74788626033, 68765.31234687589, 69080.30919690739, 70667.64666176842, 70679.64660176667, 9965.302428829913, 10137.391756494633, 10157.9492102539, 10243.43661098617, 10397.32417392867, 9537.475438850652, 10581.259311848096, 10788.406637635006, 10867.836982445111, 11095.527349501574, 10049.246306526893, 10067.345622534513, 10184.694459166238, 10208.438535880598, 10632.096271816983, 10245.948770256102, 10276.126529245097, 10311.0, 10520.526576304237, 10559.736006599589, 10054.447005414773, 10233.795324093626, 10393.012663796928, 10428.634997775041, 10474.319169253975, 8621.180987806149, 8663.783405414662, 8838.646454141763, 8936.061713519986, 9239.538023098683, 8247.587620619064, 8448.324134069382, 8894.199522043047, 8969.416987895765, 9000.864987025068], "unit": "score", "name": "yui.html", "value": 6679.527722620636}], "name": "dromaeo_css", "value": 7449.121177944421}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 117.0, 115.0, 115.0, 131.0, 120.0, 116.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 144.0, 155.0, 118.0, 157.0, 171.0, 117.0, 156.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [192.0, 198.0, 207.0, 202.0, 202.0, 228.0, 196.0, 197.0, 225.0, 205.0], "unit": "score", "name": "audio-dft", "value": 205.2}, {"lowerIsBetter": true, "replicates": [68.0, 77.0, 60.0, 48.0, 76.0, 83.0, 87.0, 147.0, 83.0, 86.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [81.0, 89.0, 123.0, 79.0, 81.0, 79.0, 116.0, 79.0, 80.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [96.0, 88.0, 100.0, 113.0, 89.0, 86.0, 90.0, 96.0, 134.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.8}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 95.0, 95.0, 116.0, 96.0, 95.0, 97.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 97.4}, {"lowerIsBetter": true, "replicates": [83.0, 147.0, 146.0, 91.0, 91.0, 90.0, 93.0, 92.0, 94.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 102.1}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 54.0, 58.0, 58.0, 57.0, 67.0, 59.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [69.0, 98.0, 74.0, 81.0, 107.0, 58.0, 87.0, 104.0, 103.0, 90.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 87.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 85.0, 85.0, 91.0, 92.0, 105.0, 105.0, 114.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.1}, {"lowerIsBetter": true, "replicates": [134.0, 134.0, 124.0, 122.0, 124.0, 129.0, 134.0, 123.0, 106.0, 145.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.5}, {"lowerIsBetter": true, "replicates": [157.0, 192.0, 132.0, 186.0, 186.0, 166.0, 144.0, 146.0, 143.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 158.6}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 66.0, 67.0, 69.0, 67.0, 73.0, 88.0, 105.0, 99.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.0}], "name": "kraken", "value": 1536.7999999999997}]} 05:06:39 INFO - Return code: 0 05:06:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:06:39 ERROR - # TBPL SUCCESS # 05:06:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:39 INFO - 2016-03-17 05:06:39.864 screenresolution[1685:10771] starting screenresolution argv=screenresolution get 05:06:39 INFO - 2016-03-17 05:06:39.866 screenresolution[1685:10771] Display 0: 1600x1200x32@60 05:06:39 INFO - 2016-03-17 05:06:39.873 screenresolution[1686:10774] starting screenresolution argv=screenresolution list 05:06:39 INFO - Available Modes on Display 0 05:06:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:40 INFO - Intel Iris: 05:06:40 INFO - Chipset Model: Intel Iris 05:06:40 INFO - Type: GPU 05:06:40 INFO - Bus: Built-In 05:06:40 INFO - VRAM (Dynamic, Max): 1536 MB 05:06:40 INFO - Vendor: Intel (0x8086) 05:06:40 INFO - Device ID: 0x0a2e 05:06:40 INFO - Revision ID: 0x0009 05:06:40 INFO - Displays: 05:06:40 INFO - Display: 05:06:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:40 INFO - Display Serial Number: 1600x1200 60 05:06:40 INFO - Main Display: Yes 05:06:40 INFO - Mirror: Off 05:06:40 INFO - Online: Yes 05:06:40 INFO - Rotation: Supported 05:06:40 INFO - Return code: 0 05:06:40 INFO - Running post-action listener: _resource_record_post_action 05:06:40 INFO - Running post-run listener: _resource_record_post_run 05:06:41 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39372288; Write bytes: 710020608; Read time: 429; Write time: 2521 05:06:41 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402594304; Write bytes: 405308928; Read time: 30289; Write time: 873 05:06:41 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37586432; Write bytes: 303863808; Read time: 410; Write time: 1646 05:06:41 INFO - Running post-run listener: _upload_blobber_files 05:06:41 INFO - Blob upload gear active. 05:06:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:41 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 05:06:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:06:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:06:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:06:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:06:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:42 INFO - (blobuploader) - INFO - Done attempting. 05:06:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:06:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:06:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:43 INFO - (blobuploader) - INFO - Done attempting. 05:06:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:43 INFO - Return code: 0 05:06:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58f40784f63d5bba9deb93a0faf5d5cfb38e123f3a49a173b39033f2989a2638c5e2e05a51066bedec0b6b225451db6ae36d206881c54c999833ce7c24bb2e53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017cf58b94be383a3705177bd1013ee4ecf2f9a2616f41d00a63377a2aaba8fd9d36d0b11010cae95b5067d60d11f665f54664e1d5b693eca161566b011fd2a8"} 05:06:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:43 INFO - Contents: 05:06:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58f40784f63d5bba9deb93a0faf5d5cfb38e123f3a49a173b39033f2989a2638c5e2e05a51066bedec0b6b225451db6ae36d206881c54c999833ce7c24bb2e53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017cf58b94be383a3705177bd1013ee4ecf2f9a2616f41d00a63377a2aaba8fd9d36d0b11010cae95b5067d60d11f665f54664e1d5b693eca161566b011fd2a8"} 05:06:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:43 INFO - Copying logs to upload dir... 05:06:43 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.564940 ========= master_lag: 74.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2016-03-17 05:07:58.333250) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 20 secs) (at 2016-03-17 05:07:58.341177) ========= 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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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/Firefox/sha512/58f40784f63d5bba9deb93a0faf5d5cfb38e123f3a49a173b39033f2989a2638c5e2e05a51066bedec0b6b225451db6ae36d206881c54c999833ce7c24bb2e53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017cf58b94be383a3705177bd1013ee4ecf2f9a2616f41d00a63377a2aaba8fd9d36d0b11010cae95b5067d60d11f665f54664e1d5b693eca161566b011fd2a8"} build_url:https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011049 build_url: 'https://queue.taskcluster.net/v1/task/fwghgXLHT6O1Fi3uQMEkug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58f40784f63d5bba9deb93a0faf5d5cfb38e123f3a49a173b39033f2989a2638c5e2e05a51066bedec0b6b225451db6ae36d206881c54c999833ce7c24bb2e53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017cf58b94be383a3705177bd1013ee4ecf2f9a2616f41d00a63377a2aaba8fd9d36d0b11010cae95b5067d60d11f665f54664e1d5b693eca161566b011fd2a8"}' ========= master_lag: 20.60 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 20 secs) (at 2016-03-17 05:08:18.947278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 19 secs) (at 2016-03-17 05:08:18.947706) ========= 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.5AUXOtDh2o/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.Qfu3y4AhR6/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.005398 ========= master_lag: 19.56 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 19 secs) (at 2016-03-17 05:08:38.517621) ========= ========= Started reboot skipped (results: 3, elapsed: 11 secs) (at 2016-03-17 05:08:38.520926) ========= ========= Finished reboot skipped (results: 3, elapsed: 11 secs) (at 2016-03-17 05:08:49.533886) ========= ========= Total master_lag: 126.04 =========