builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0081 starttime: 1460028942.91 results: success (0) buildid: 20160407043449 builduid: b48e03a80b41432ebbc1b334adf957a7 revision: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:35:42.906831) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:35:42.907214) ========= ========= Started set props: basedir (results: 0, elapsed: 17 secs) (at 2016-04-07 04:35:42.907523) ========= 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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005516 basedir: '/builds/slave/test' ========= master_lag: 17.59 ========= ========= Finished set props: basedir (results: 0, elapsed: 17 secs) (at 2016-04-07 04:36:00.501330) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 40 secs) (at 2016-04-07 04:36:00.501635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 40 secs) (at 2016-04-07 04:36:41.349147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 04:36:41.349446) ========= 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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005393 ========= master_lag: 1.93 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 04:36:43.288847) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:36:43.289118) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:36:43.289467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-07 04:36:43.289759) ========= 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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-07 04:36:46-- 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% 5.61M=0.002s 2016-04-07 04:36:47 (5.61 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.850815 ========= master_lag: 6.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-07 04:36:50.978256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-07 04:36:50.978574) ========= 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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.020235 ========= master_lag: 5.83 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-07 04:36:56.832875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-04-07 04:36:56.833213) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-07 04:36:57,545 truncating revision to first 12 chars 2016-04-07 04:36:57,545 Setting DEBUG logging. 2016-04-07 04:36:57,545 attempt 1/10 2016-04-07 04:36:57,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68c0b7d6f16c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 04:36:59,330 unpacking tar archive at: mozilla-central-68c0b7d6f16c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.036113 ========= master_lag: 6.00 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-04-07 04:37:04.868069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 2 secs) (at 2016-04-07 04:37:04.868377) ========= echo 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 program finished with exit code 0 elapsedTime=0.004838 script_repo_revision: '68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8' ========= master_lag: 2.15 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 2 secs) (at 2016-04-07 04:37:07.025952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-04-07 04:37:07.026237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-04-07 04:37:10.350432) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-04-07 04:37:10.350716) ========= /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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:37:11 INFO - MultiFileLogger online at 20160407 04:37:11 in /builds/slave/test 04:37:11 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:37:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:11 INFO - {'append_to_log': False, 04:37:11 INFO - 'base_work_dir': '/builds/slave/test', 04:37:11 INFO - 'blob_upload_branch': 'Firefox', 04:37:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:11 INFO - 'branch': 'Firefox', 04:37:11 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:11 INFO - 'config_files': ('talos/mac_config.py',), 04:37:11 INFO - 'default_actions': ('clobber', 04:37:11 INFO - 'read-buildbot-config', 04:37:11 INFO - 'download-and-extract', 04:37:11 INFO - 'populate-webroot', 04:37:11 INFO - 'create-virtualenv', 04:37:11 INFO - 'install', 04:37:11 INFO - 'run-tests'), 04:37:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:11 INFO - 'download_minidump_stackwalk': True, 04:37:11 INFO - 'download_symbols': 'ondemand', 04:37:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:11 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:11 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:11 INFO - 'installer_path': 'installer.exe', 04:37:11 INFO - 'log_level': 'info', 04:37:11 INFO - 'log_name': 'talos', 04:37:11 INFO - 'log_to_console': True, 04:37:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:37:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:37:11 INFO - 'opt_config_files': (), 04:37:11 INFO - 'pip_index': False, 04:37:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:11 INFO - 'cmd': ('bash', 04:37:11 INFO - '-c', 04:37:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:11 INFO - 'enabled': True, 04:37:11 INFO - 'halt_on_failure': False, 04:37:11 INFO - 'name': 'check_screen_resolution'},), 04:37:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:11 INFO - 'cmd': ('bash', 04:37:11 INFO - '-c', 04:37:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:11 INFO - 'enabled': True, 04:37:11 INFO - 'halt_on_failure': False, 04:37:11 INFO - 'name': 'check_screen_resolution'},), 04:37:11 INFO - 'run_cmd_checks_enabled': True, 04:37:11 INFO - 'sps_profile': False, 04:37:11 INFO - 'sps_profile_interval': 0, 04:37:11 INFO - 'suite': 'dromaeojs-e10s', 04:37:11 INFO - 'system_bits': '32', 04:37:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:11 INFO - 'title': 't-yosemite-r7-0081', 04:37:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:11 INFO - 'use_talos_json': True, 04:37:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:11 INFO - 'work_dir': 'build'} 04:37:11 INFO - ##### 04:37:11 INFO - ##### Running clobber step. 04:37:11 INFO - ##### 04:37:11 INFO - Running pre-action listener: _resource_record_pre_action 04:37:11 INFO - Running main action method: clobber 04:37:11 INFO - rmtree: /builds/slave/test/build 04:37:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:12 INFO - Running post-action listener: _resource_record_post_action 04:37:12 INFO - ##### 04:37:12 INFO - ##### Running read-buildbot-config step. 04:37:12 INFO - ##### 04:37:12 INFO - Running pre-action listener: _resource_record_pre_action 04:37:12 INFO - Running main action method: read_buildbot_config 04:37:12 INFO - Using buildbot properties: 04:37:12 INFO - { 04:37:12 INFO - "project": "", 04:37:12 INFO - "product": "firefox", 04:37:12 INFO - "script_repo_revision": "production", 04:37:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:37:12 INFO - "repository": "", 04:37:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:37:12 INFO - "buildid": "20160407043449", 04:37:12 INFO - "stage_platform": "macosx64", 04:37:12 INFO - "basedir": "/builds/slave/test", 04:37:12 INFO - "buildnumber": 12, 04:37:12 INFO - "platform": "yosemite_r7", 04:37:12 INFO - "mozci_request": { 04:37:12 INFO - "priority": -1, 04:37:12 INFO - "type": "trigger_all_talos_jobs", 04:37:12 INFO - "times": 6 04:37:12 INFO - }, 04:37:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:37:12 INFO - "slavebuilddir": "test", 04:37:12 INFO - "branch": "mozilla-central", 04:37:12 INFO - "revision": "68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8", 04:37:12 INFO - "slavename": "t-yosemite-r7-0081", 04:37:12 INFO - "builduid": "b48e03a80b41432ebbc1b334adf957a7", 04:37:12 INFO - "repo_path": "mozilla-central" 04:37:12 INFO - } 04:37:12 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg. 04:37:12 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json. 04:37:12 INFO - Running post-action listener: _resource_record_post_action 04:37:12 INFO - ##### 04:37:12 INFO - ##### Running download-and-extract step. 04:37:12 INFO - ##### 04:37:12 INFO - Running pre-action listener: _resource_record_pre_action 04:37:12 INFO - Running main action method: download_and_extract 04:37:12 INFO - mkdir: /builds/slave/test/build/tests 04:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json 04:37:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/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:37:12 INFO - Downloaded 1199 bytes. 04:37:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:12 INFO - Using the following test package requirements: 04:37:12 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:37:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:37:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:37:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'jsshell-mac.zip'], 04:37:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:37:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:37:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:37:12 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:37:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:37:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:37:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/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:37:15 INFO - Downloaded 17964225 bytes. 04:37:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:37:18 INFO - Return code: 0 04:37:18 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:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/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:37:21 INFO - Downloaded 17964225 bytes. 04:37:21 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:37:21 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:37:24 INFO - Return code: 0 04:37:24 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:37:24 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip 04:37:24 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/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:37:25 INFO - Downloaded 10847617 bytes. 04:37:25 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:37:25 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:37:25 INFO - Return code: 0 04:37: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:37:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:37:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:37:45 INFO - Downloaded 108925595 bytes. 04:37:45 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:37:45 INFO - mkdir: /builds/slave/test/properties 04:37:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:45 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:45 INFO - Contents: 04:37:45 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - Running post-action listener: set_extra_try_arguments 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running populate-webroot step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: populate_webroot 04:37:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:45 INFO - '--tppagecycles', 04:37:45 INFO - '7'], 04:37:45 INFO - 'tests': ['tsvgm']}}, 04:37:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['damp', 'tps']}, 04:37:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['damp', 'tps']}, 04:37:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['dromaeo_dom']}, 04:37:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tsvgx', 04:37:45 INFO - 'tsvgr_opacity', 04:37:45 INFO - 'tart', 04:37:45 INFO - 'tscrollx', 04:37:45 INFO - 'cart']}, 04:37:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:45 INFO - 'tsvgr_opacity', 04:37:45 INFO - 'tart', 04:37:45 INFO - 'tscrollx', 04:37:45 INFO - 'cart']}, 04:37:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tp5o']}, 04:37:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['tp5o']}, 04:37:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s', 04:37:45 INFO - '--xperf_path', 04:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:45 INFO - 'tests': ['tp5n']}, 04:37:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--xperf_path', 04:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:45 INFO - 'tests': ['tp5n']}}, 04:37:45 INFO - 'talos.zip': {'path': '', 04:37:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running create-virtualenv step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: create_virtualenv 04:37:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:45 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:37:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:46 INFO - Using real prefix '/tools/python27' 04:37:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:49 INFO - Installing pip.................done. 04:37:49 INFO - Return code: 0 04:37:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 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 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:37:49 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:37:49 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:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:49 INFO - 'HOME': '/Users/cltbld', 04:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:49 INFO - 'LOGNAME': 'cltbld', 04:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:49 INFO - 'MOZ_NO_REMOTE': '1', 04:37:49 INFO - 'NO_EM_RESTART': '1', 04:37:49 INFO - 'PAGER': '/bin/cat', 04:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:49 INFO - 'PWD': '/builds/slave/test', 04:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:49 INFO - 'SHELL': '/bin/bash', 04:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:37:49 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:49 INFO - 'USER': 'cltbld', 04:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:49 INFO - 'XPC_FLAGS': '0x0', 04:37:49 INFO - 'XPC_SERVICE_NAME': '0', 04:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:49 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:37:49 INFO - Cleaning up... 04:37:49 INFO - Return code: 0 04:37:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 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 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:37:49 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:37:49 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:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:49 INFO - 'HOME': '/Users/cltbld', 04:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:49 INFO - 'LOGNAME': 'cltbld', 04:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:49 INFO - 'MOZ_NO_REMOTE': '1', 04:37:49 INFO - 'NO_EM_RESTART': '1', 04:37:49 INFO - 'PAGER': '/bin/cat', 04:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:49 INFO - 'PWD': '/builds/slave/test', 04:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:49 INFO - 'SHELL': '/bin/bash', 04:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:37:49 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:49 INFO - 'USER': 'cltbld', 04:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:49 INFO - 'XPC_FLAGS': '0x0', 04:37:49 INFO - 'XPC_SERVICE_NAME': '0', 04:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:50 INFO - Downloading/unpacking psutil>=0.7.1 04:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:53 INFO - Installing collected packages: psutil 04:37:53 INFO - Running setup.py install for psutil 04:37:53 INFO - building 'psutil._psutil_osx' extension 04:37:53 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:37:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:37:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:37:54 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:37:54 INFO - building 'psutil._psutil_posix' extension 04:37:54 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:37:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:37:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:37:54 INFO - ^ 04:37:54 INFO - 1 warning generated. 04:37:54 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:37:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:54 INFO - Successfully installed psutil 04:37:54 INFO - Cleaning up... 04:37:54 INFO - Return code: 0 04:37:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:54 INFO - 'HOME': '/Users/cltbld', 04:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:54 INFO - 'LOGNAME': 'cltbld', 04:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:54 INFO - 'MOZ_NO_REMOTE': '1', 04:37:54 INFO - 'NO_EM_RESTART': '1', 04:37:54 INFO - 'PAGER': '/bin/cat', 04:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:54 INFO - 'PWD': '/builds/slave/test', 04:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:54 INFO - 'SHELL': '/bin/bash', 04:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:37:54 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:54 INFO - 'USER': 'cltbld', 04:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:54 INFO - 'XPC_FLAGS': '0x0', 04:37:54 INFO - 'XPC_SERVICE_NAME': '0', 04:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:57 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:37:57 INFO - Installing collected packages: mozsystemmonitor 04:37:57 INFO - Running setup.py install for mozsystemmonitor 04:37:57 INFO - Successfully installed mozsystemmonitor 04:37:57 INFO - Cleaning up... 04:37:57 INFO - Return code: 0 04:37:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:57 INFO - 'HOME': '/Users/cltbld', 04:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:57 INFO - 'LOGNAME': 'cltbld', 04:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:57 INFO - 'MOZ_NO_REMOTE': '1', 04:37:57 INFO - 'NO_EM_RESTART': '1', 04:37:57 INFO - 'PAGER': '/bin/cat', 04:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:57 INFO - 'PWD': '/builds/slave/test', 04:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:57 INFO - 'SHELL': '/bin/bash', 04:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:37:57 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:57 INFO - 'USER': 'cltbld', 04:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:57 INFO - 'XPC_FLAGS': '0x0', 04:37:57 INFO - 'XPC_SERVICE_NAME': '0', 04:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:57 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:38:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:38:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:01 INFO - Downloading docopt-0.6.1.tar.gz 04:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:38:01 INFO - Installing collected packages: blobuploader, requests, docopt 04:38:01 INFO - Running setup.py install for blobuploader 04:38:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:38:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:38:01 INFO - Running setup.py install for requests 04:38:02 INFO - Running setup.py install for docopt 04:38:02 INFO - Successfully installed blobuploader requests docopt 04:38:02 INFO - Cleaning up... 04:38:02 INFO - Return code: 0 04:38:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:02 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 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:38:02 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:38:02 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:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:02 INFO - 'HOME': '/Users/cltbld', 04:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:02 INFO - 'LOGNAME': 'cltbld', 04:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:02 INFO - 'MOZ_NO_REMOTE': '1', 04:38:02 INFO - 'NO_EM_RESTART': '1', 04:38:02 INFO - 'PAGER': '/bin/cat', 04:38:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:02 INFO - 'PWD': '/builds/slave/test', 04:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:02 INFO - 'SHELL': '/bin/bash', 04:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:38:02 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:02 INFO - 'USER': 'cltbld', 04:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:02 INFO - 'XPC_FLAGS': '0x0', 04:38:02 INFO - 'XPC_SERVICE_NAME': '0', 04:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:02 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-pGgXv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:02 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-8a4VwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:02 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-UHlm4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-o1VOlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-btgEey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-2nYwX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-dKcQ7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-bQV6S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-l3DwSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-wg12LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-evwCQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-YWMDUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:03 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-U0s_Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:04 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-LL5BaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:04 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-hfH7hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:04 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-goXQxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:04 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-DBWiuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:38:04 INFO - Running setup.py install for manifestparser 04:38:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Running setup.py install for mozcrash 04:38:04 INFO - Running setup.py install for mozdebug 04:38:04 INFO - Running setup.py install for mozdevice 04:38:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozfile 04:38:05 INFO - Running setup.py install for mozhttpd 04:38:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozinfo 04:38:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozInstall 04:38:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozleak 04:38:05 INFO - Running setup.py install for mozlog 04:38:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for moznetwork 04:38:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozprocess 04:38:06 INFO - Running setup.py install for mozprofile 04:38:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozrunner 04:38:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozscreenshot 04:38:06 INFO - Running setup.py install for moztest 04:38:06 INFO - Running setup.py install for mozversion 04:38:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:38:07 INFO - Cleaning up... 04:38:07 INFO - Return code: 0 04:38:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38: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:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:07 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 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:38:07 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:38:07 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:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:07 INFO - 'HOME': '/Users/cltbld', 04:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:07 INFO - 'LOGNAME': 'cltbld', 04:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:07 INFO - 'MOZ_NO_REMOTE': '1', 04:38:07 INFO - 'NO_EM_RESTART': '1', 04:38:07 INFO - 'PAGER': '/bin/cat', 04:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:07 INFO - 'PWD': '/builds/slave/test', 04:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:07 INFO - 'SHELL': '/bin/bash', 04:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:38:07 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:07 INFO - 'USER': 'cltbld', 04:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:07 INFO - 'XPC_FLAGS': '0x0', 04:38:07 INFO - 'XPC_SERVICE_NAME': '0', 04:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:07 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-oyz6gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:07 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:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:07 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-sZuDDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:07 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:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:07 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-hNEIV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:07 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:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:07 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-p7wj25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:07 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:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:07 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-tc8I19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:07 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:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:07 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-WPBLFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-jjVkA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-jWbHTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-zabRcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-8_B5b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-IAS7jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-fRttGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-JdAnUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-W1C9pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:08 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-PXxyHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:09 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-qBkQWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:09 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-p70noT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:11 INFO - Downloading blessings-1.6.tar.gz 04:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:11 INFO - Installing collected packages: blessings 04:38:11 INFO - Running setup.py install for blessings 04:38:11 INFO - Successfully installed blessings 04:38:11 INFO - Cleaning up... 04:38:12 INFO - Return code: 0 04:38:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:12 INFO - Reading from file tmpfile_stdout 04:38:12 INFO - Current package versions: 04:38:12 INFO - blessings == 1.6 04:38:12 INFO - blobuploader == 1.2.4 04:38:12 INFO - docopt == 0.6.1 04:38:12 INFO - manifestparser == 1.1 04:38:12 INFO - mozInstall == 1.12 04:38:12 INFO - mozcrash == 0.17 04:38:12 INFO - mozdebug == 0.1 04:38:12 INFO - mozdevice == 0.48 04:38:12 INFO - mozfile == 1.2 04:38:12 INFO - mozhttpd == 0.7 04:38:12 INFO - mozinfo == 0.9 04:38:12 INFO - mozleak == 0.1 04:38:12 INFO - mozlog == 3.1 04:38:12 INFO - moznetwork == 0.27 04:38:12 INFO - mozprocess == 0.22 04:38:12 INFO - mozprofile == 0.28 04:38:12 INFO - mozrunner == 6.11 04:38:12 INFO - mozscreenshot == 0.1 04:38:12 INFO - mozsystemmonitor == 0.0 04:38:12 INFO - moztest == 0.7 04:38:12 INFO - mozversion == 1.4 04:38:12 INFO - psutil == 3.1.1 04:38:12 INFO - requests == 1.2.3 04:38:12 INFO - wsgiref == 0.1.2 04:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 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 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:38:12 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:38:12 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:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:12 INFO - 'HOME': '/Users/cltbld', 04:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:12 INFO - 'LOGNAME': 'cltbld', 04:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:12 INFO - 'MOZ_NO_REMOTE': '1', 04:38:12 INFO - 'NO_EM_RESTART': '1', 04:38:12 INFO - 'PAGER': '/bin/cat', 04:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:12 INFO - 'PWD': '/builds/slave/test', 04:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:12 INFO - 'SHELL': '/bin/bash', 04:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:38:12 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:12 INFO - 'USER': 'cltbld', 04:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:12 INFO - 'XPC_FLAGS': '0x0', 04:38:12 INFO - 'XPC_SERVICE_NAME': '0', 04:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 INFO - Cleaning up... 04:38:12 INFO - Return code: 0 04:38:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 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 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:38:12 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:38:12 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:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:12 INFO - 'HOME': '/Users/cltbld', 04:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:12 INFO - 'LOGNAME': 'cltbld', 04:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:12 INFO - 'MOZ_NO_REMOTE': '1', 04:38:12 INFO - 'NO_EM_RESTART': '1', 04:38:12 INFO - 'PAGER': '/bin/cat', 04:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:12 INFO - 'PWD': '/builds/slave/test', 04:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:12 INFO - 'SHELL': '/bin/bash', 04:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:38:12 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:12 INFO - 'USER': 'cltbld', 04:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:12 INFO - 'XPC_FLAGS': '0x0', 04:38:12 INFO - 'XPC_SERVICE_NAME': '0', 04:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:12 INFO - Downloading/unpacking jsonschema 04:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:15 INFO - Downloading/unpacking functools32 (from jsonschema) 04:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 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:38:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:15 INFO - warning: no files found matching '*.txt' 04:38:15 INFO - no previously-included directories found matching 'build' 04:38:15 INFO - no previously-included directories found matching 'dist' 04:38:15 INFO - no previously-included directories found matching '.git*' 04:38:15 INFO - Installing collected packages: jsonschema, functools32 04:38:15 INFO - Running setup.py install for functools32 04:38:15 INFO - warning: no files found matching '*.txt' 04:38:15 INFO - no previously-included directories found matching 'build' 04:38:15 INFO - no previously-included directories found matching 'dist' 04:38:15 INFO - no previously-included directories found matching '.git*' 04:38:15 INFO - Successfully installed jsonschema functools32 04:38:15 INFO - Cleaning up... 04:38:15 INFO - Return code: 0 04:38:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039f4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa914a5fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, '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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:15 INFO - 'HOME': '/Users/cltbld', 04:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:15 INFO - 'LOGNAME': 'cltbld', 04:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:15 INFO - 'MOZ_NO_REMOTE': '1', 04:38:15 INFO - 'NO_EM_RESTART': '1', 04:38:15 INFO - 'PAGER': '/bin/cat', 04:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:15 INFO - 'PWD': '/builds/slave/test', 04:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:15 INFO - 'SHELL': '/bin/bash', 04:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:38:15 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:15 INFO - 'USER': 'cltbld', 04:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:15 INFO - 'XPC_FLAGS': '0x0', 04:38:15 INFO - 'XPC_SERVICE_NAME': '0', 04:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:16 INFO - Downloading/unpacking flake8 04:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:38:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:38:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:19 INFO - no previously-included directories found matching 'docs/_build' 04:38:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:38:20 INFO - Running setup.py install for pep8 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:20 INFO - no previously-included directories found matching 'docs/_build' 04:38:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:38:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:38:20 INFO - Cleaning up... 04:38:20 INFO - Return code: 0 04:38:20 INFO - Running post-action listener: _resource_record_post_action 04:38:20 INFO - Running post-action listener: _start_resource_monitoring 04:38:20 INFO - Starting resource monitoring. 04:38:20 INFO - ##### 04:38:20 INFO - ##### Running install step. 04:38:20 INFO - ##### 04:38:20 INFO - Running pre-action listener: _resource_record_pre_action 04:38:20 INFO - Running main action method: install 04:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:20 INFO - Reading from file tmpfile_stdout 04:38:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:20 INFO - Reading from file tmpfile_stdout 04:38:20 INFO - Output received: 04:38:20 INFO - Usage: mozinstall [options] installer 04:38:20 INFO - Options: 04:38:20 INFO - -h, --help show this help message and exit 04:38:20 INFO - -d DEST, --destination=DEST 04:38:20 INFO - Directory to install application into. [default: 04:38:20 INFO - "/builds/slave/test"] 04:38:20 INFO - --app=APP Application being installed. [default: firefox] 04:38:20 INFO - mkdir: /builds/slave/test/build/application 04:38:20 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:38:20 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:38:53 INFO - Reading from file tmpfile_stdout 04:38:53 INFO - Output received: 04:38:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:38:53 INFO - Running post-action listener: _resource_record_post_action 04:38:53 INFO - ##### 04:38:53 INFO - ##### Running run-tests step. 04:38:53 INFO - ##### 04:38:53 INFO - Running pre-action listener: _resource_record_pre_action 04:38:53 INFO - Running main action method: run_tests 04:38:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:38:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:38:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:38:53 INFO - 2016-04-07 04:38:53.659 screenresolution[1967:11502] starting screenresolution argv=screenresolution get 04:38:53 INFO - 2016-04-07 04:38:53.662 screenresolution[1967:11502] Display 0: 1600x1200x32@60 04:38:53 INFO - 2016-04-07 04:38:53.668 screenresolution[1968:11504] starting screenresolution argv=screenresolution list 04:38:53 INFO - Available Modes on Display 0 04:38:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:38:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:38:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:38:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:38:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:38:53 INFO - Intel Iris: 04:38:53 INFO - Chipset Model: Intel Iris 04:38:53 INFO - Type: GPU 04:38:53 INFO - Bus: Built-In 04:38:53 INFO - VRAM (Dynamic, Max): 1536 MB 04:38:53 INFO - Vendor: Intel (0x8086) 04:38:53 INFO - Device ID: 0x0a2e 04:38:53 INFO - Revision ID: 0x0009 04:38:53 INFO - Displays: 04:38:53 INFO - Display: 04:38:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:38:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:38:53 INFO - Display Serial Number: 1600x1200 60 04:38:53 INFO - Main Display: Yes 04:38:53 INFO - Mirror: Off 04:38:53 INFO - Online: Yes 04:38:53 INFO - Rotation: Supported 04:38:53 INFO - Return code: 0 04:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:53 INFO - Python 2.7.3 04:38:53 INFO - Return code: 0 04:38:53 INFO - grabbing minidump binary from tooltool 04:38: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:38:53 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 0x103893e00>, '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 0x1036fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10388eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:53 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:38:53 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:38:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:53 INFO - Return code: 0 04:38:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:38:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:38:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:38:55 INFO - Return code: 0 04:38:55 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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:38:55 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0081 --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:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmKAW6g9Dv/Render', 04:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:55 INFO - 'HOME': '/Users/cltbld', 04:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:55 INFO - 'LOGNAME': 'cltbld', 04:38:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:55 INFO - 'MOZ_NO_REMOTE': '1', 04:38:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:55 INFO - 'NO_EM_RESTART': '1', 04:38:55 INFO - 'PAGER': '/bin/cat', 04:38:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:55 INFO - 'PWD': '/builds/slave/test', 04:38:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:55 INFO - 'SHELL': '/bin/bash', 04:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hqUxf7DPJN/Listeners', 04:38:55 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 04:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:55 INFO - 'USER': 'cltbld', 04:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:55 INFO - 'XPC_FLAGS': '0x0', 04:38:55 INFO - 'XPC_SERVICE_NAME': '0', 04:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:55 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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:38:55 INFO - mozversion application_buildid: 20160406030021 04:38:55 INFO - mozversion application_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:38:55 INFO - mozversion application_display_name: Nightly 04:38:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:55 INFO - mozversion application_name: Firefox 04:38:55 INFO - mozversion application_remotingname: firefox 04:38:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:38:55 INFO - mozversion application_vendor: Mozilla 04:38:55 INFO - mozversion application_version: 48.0a1 04:38:55 INFO - mozversion platform_buildid: 20160406030021 04:38:55 INFO - mozversion platform_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:38:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:38:55 INFO - mozversion platform_version: 48.0a1 04:38:55 INFO - using testdate: 1460029135 04:38:55 INFO - actual date: 1460029135 04:38:55 INFO - starting webserver on 'localhost:49648' 04:38:55 INFO - SUITE-START | Running 2 tests 04:38:55 INFO - TEST-START | dromaeo_css 04:38:55 INFO - operating with platform_type : mac_ 04:38:55 INFO - Initialising browser for dromaeo_css test... 04:38:55 INFO - TEST-INFO | started process 1986 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpwdzcyz/profile http://localhost:49648/getInfo.html) 04:38:57 INFO - PROCESS | 1986 | 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:38:58 INFO - PROCESS | 1986 | __metrics Screen width/height:1600/1200 04:38:58 INFO - PROCESS | 1986 | colorDepth:24 04:38:58 INFO - PROCESS | 1986 | Browser inner width/height: 1024/689 04:38:58 INFO - PROCESS | 1986 | __metrics 04:38:58 ERROR - PROCESS | 1986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 04:38:58 INFO - TEST-INFO | 1986: exit 0 04:38:58 INFO - Browser initialized. 04:38:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:58 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpwdzcyz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:10 INFO - PROCESS | 1989 | RSS: Main: 246964224 04:39:10 INFO - PROCESS | 1989 | 04:40:00 INFO - PROCESS | 1989 | 1460029200445 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:42:11 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49648/tests/dromaeo/cssquery-ext.html) 04:42:13 INFO - PROCESS | 1989 | RSS: Main: 260009984 04:42:13 INFO - PROCESS | 1989 | 04:45:15 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-ext.html (next: http://localhost:49648/tests/dromaeo/cssquery-jquery.html) 04:45:15 INFO - PROCESS | 1989 | RSS: Main: 272588800 04:45:15 INFO - PROCESS | 1989 | 04:48:17 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49648/tests/dromaeo/cssquery-mootools.html) 04:48:18 INFO - PROCESS | 1989 | RSS: Main: 274223104 04:48:18 INFO - PROCESS | 1989 | 04:51:19 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49648/tests/dromaeo/cssquery-prototype.html) 04:51:20 INFO - PROCESS | 1989 | RSS: Main: 278278144 04:51:20 INFO - PROCESS | 1989 | 04:54:22 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49648/tests/dromaeo/cssquery-yui.html) 04:54:23 INFO - PROCESS | 1989 | RSS: Main: 277446656 04:54:23 INFO - PROCESS | 1989 | 04:57:25 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-yui.html (next: http://localhost:49648/tests/dromaeo/cssquery-dojo.html) 04:57:26 INFO - PROCESS | 1989 | RSS: Main: 281522176 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - PROCESS | 1989 | __start_tp_report 04:57:26 INFO - PROCESS | 1989 | _x_x_mozilla_page_load 04:57:26 INFO - PROCESS | 1989 | _x_x_mozilla_page_load_details 04:57:26 INFO - PROCESS | 1989 | |i|pagename|runs| 04:57:26 INFO - PROCESS | 1989 | |0;dojo.html;3409.659034096591;3465.688088072073;3493.1092571394292;3511.29774045191;3535.7701749386306;4474.955250447494;4758.500357462469;5688.658680479169;5724.34170070442;5786.768529258829;5643.435656434354;5695.686737229451;5763.250777398932;5789.536837053036;5951.6726580038085;5140.2546630738525;5176.378834539851;5196.662216955886;5216.7913283468615;5277.604179686519;5308.389535203443;5356.303680521527;5383.596230282745;5399.055165346068;5409.83770486886;4665.836695715668;5259.0796610593;5285.8942821143555;5286.3392075990505;5290.153575427951;5240.449752775941;5256.553192978601;5268.130758424855;5281.471852814726;5283.86790330241;4316.676249281317;5113.565346945514;5179.19722443022;5214.139666954948;5259.47405259471;5608.887822243532;5634.4365563443325;5659.40576239493;5683.090705487102;5686.687232202227;6134.877302453926;6148.569600127993;6195.907061394083;6197.101420294077;6214.192155019864;6096.466212027279;6157.722902469355;6209.3790620938;6231.501479881598;6245.0320200369015;5940.287165540163;5960.821175364746;5970.970145149333;5972.193753843262;6025.457708806184;6286.937130628727;6320.494360451153;6322.399372059647;6328.335524769925;6331.778387756406;6011.068284415923;6124.724387402578;6128.503123582198;6151.938480615226;6161.907571386433;6198.6280823149855;6212.751489940351;6244.500439964792;6247.75008999644;6252.093446450239;6087.634741915499;6145;6166.660833654102;6169.444749972524;6177.938220617736;5443.455654434604;6147.477464415575;6217.191765070512;6246.129876355824;6273.560850740496;4815.879603009883;4872.196087645499;4937.530934561211;4949.430815456197;4975.90048199034;4078.938815917764;4302.644666929907;4406.20688276107;4414.404055452537;4466.330050492452;5858.56060795442;5878.441548053013;5886.175935369051;5894.616849904743;5905.409459054146;5371.006363822706;6172.22847144107;6189.473894718999;6247.96876015617;6285.654289014148;5807.651540907559;5840.153177789197;5879.823605291848;5892.204552385459;5899.67551784656;5421.403645598981;5461.563074953994;5467.726613669301;5469.15228139639;5476.7535460904355;6210.441060304594;6309.08518264849;6343.651099189497;6368.42684158428;6381.904271436025;6268.874622507616;6273.686315684106;6279.686015699105;6283.5287353449585;6289.182406287154;6140.995089002448;6369.681515924092;6377.489800815831;6389.744410223725;6398;6147.108669243024;6213.2233470816145;6261.74953001893;6262.342454042442;6273.560850740404;6115.571909966259;6177.382261773787;6237.345078766664;6252.249730032243;6254.781082662085;4554.681172317906;6085.3306136325855;6105.065535583987;6205.720742566505;6256.655883926428;5793.826185214451;6100.793122958854;6131.254333328352;6178.41305076017;6189.628622282497;6007.158997740233;6068.315759135816;6068.393160683896;6096.973848131493;6124.564025909317;5153.742312884416;5787.2187254720075;5814.04068328721;6216.564840461125;6281.811545653638;6083.330833608211;6104.245243171002;6109.1010297800785;6110.498006581597;6132.023677617016 04:57:26 INFO - PROCESS | 1989 | |1;ext.html;532.9173978033406;579.6811753535554;597.5697497801582;637.8277864976457;646.9583969808609;36904.446433303485;37670.246595068114;37687.62312376875;37699.43450848233;37967.05082372938;32844.67155328452;40205;40255.59744402555;40291.395629065584;41161;9391.154796068335;9620.807583848318;9635.759106022335;9636.566354514063;9650.855237171449;9477.763055923588;9530.952345238264;9560.043995600454;9658.75853103671;9661.806763864719;9554.904450955506;9573.994730553297;9586.952065239664;9612.231021518262;9693.806123877519;9539.952300238489;9639.132478076972;9649.372790768577;9662.613495460173;9675.274354423447;9458.33791634586;9460.053994600554;9557.378770379903;9594.6641867535;9630.27772917034;31839;38185.42721859174;38290.80854595737;38761.61238387608;38934.415983760264;3044.4824379855477;3071.769617278713;3159.6840315968448;3199.904002879894;3306.2560923792194;26698;27288.72711272882;27809.72190278112;28070.719292807218;28377.86488540456;2641.537730897085;2699.325168707823;2720.8231464954715;2849.153642582518;2932.2522756697117;249685.50314496804;278602;283213;286264;292562;45069.774651126536;45690.54309456929;55732.16401753977;63341;63383.6830815843;43936.681899543066;43966.56033439624;44065.559344406145;44772.77613611911;45262.868428289556;14426.711465770835;14434.773044291353;15440.845591544165;15486.612834679223;15878.888477806673;12444.502219911283;12808.80786788199;12875.935620321838;12876;12883.42024608876;14234.359453824603;14280.357383917748;14399.064060836012;14657.633559161106;14890.851091489163;5348;6274.455211228431;6322.9051564226575;6340.524460665469;6367.267764207083;901.7970956534728;928.3594319919234;993.2153598657125;1013.0426746724274;1019.6991887393236;28908.277293067422;29386.412271754874;29550.556741648892;29671.406571868443;29830.40339193204;1100.2023532938715;1113.8551988241638;1165.5046605192929;1182.2256422043574;1208.2025862930423;15030.624234394008;15074.0201886877;15083.170425626697;15089.54731358061;15286.923565382325;510284.4485777547;513108;514634;515628;516879;56831;57789.4221057784;58502.41497584969;58632.41367586355;58742.41257587369;1466.1203278033095;1467.7431449496296;1479.5783201787654;1484.8366679665228;1602.3190144188907;25956.35109122287;28997.855010725656;29328.97348592789;29664.703352966193;29734.405311894072;50173.74913125411;50689;51183.48816511787;51186.720331992;51412.48587514077;481603;483046;483551.58224208653;487314;487433;32617;32792;33165.507552159725;33204.0465432449;33855.830720846236;44774;45367.09265814731;45459.86350341268;45629.54370456386;46506;32782;35818.462723058656;36510;37478;38082.428763568016;31050.602722877975;35441.46837797487;36733.816330919246;37423.43864841975;37714.057148571505;36049.459258110626;36550.26899462049;36608.633913661586;36758.26483470262;37253.62746372502;32435.35129297448;33247.66752332446;33255;33451.49822752612;33590.83204583961;23779.051193994255;24604.507909841344;24710.50578988446;25259.62110568306;25373.238802835946 04:57:26 INFO - PROCESS | 1989 | |2;jquery.html;353.6516531216751;361.4379639660329;363.8599139331358;366.32047551791425;371.329749801608;19416.8349899006;19511.512212194702;20205.494862628442;20446.795532044674;20464.693029604532;19916.900415497938;20039.499012524695;20335.28826491073;20468.795312046874;20643.896780516116;5672.602917795756;5975.282966044059;5986.700664966756;5998.610090344136;6006.519478441714;4204.138151678899;5873.8825223495505;6264.091706702526;6524.608523488582;6537.64042977636;5393.541548968323;5857.619254748428;6033.969830150865;6394.392532709408;6474.546781725281;6129.754809807602;6269.0909818076125;6381.106645069717;6387.2654644715985;6390.840228994266;5377.166539186433;5473.75368108436;5529.834104976857;5535.335759708821;5555.972220138914;12670;13166.86833131666;24831.00675972959;25136.12023579166;25362.74637253622;2019.9091040903195;2048.8258498027535;2054.679055561615;2145.710329105582;2158.2554018863466;9591.808163836755;9737.65918192867;10115.645952391631;12686.36568171597;14355.138691678532;1678.1022153148128;1686.6963946489627;1692.9080742920871;1710.9657806843793;1748.2220411916703;94333.0566694331;97984.51007744987;98416;98725;100881.49559252156;10800.837987430195;11033.172512061628;11150.442477876073;11212.046976006968;11237.21339506243;13531;13643.658908527168;13836.723265534632;13842.515511957034;13861.653458663412;7322.524035937647;7986.801979703091;8345.582720863933;8453.915460845436;8546.829063418696;8498.830023399498;8561.015483219386;8609;8688.087750786202;8696.347773916981;4005.379166229239;4042.6159514846045;4338.501072376717;4445.688801783844;4527.818887244539;1614.8142963559342;1623.415570394657;1659.7012537743321;1838.6782313095155;1867.2997625890291;821.3675469888153;903.575319599787;979.7893452907659;989.8812142542942;1035.5598870480017;18058.006809625596;19709.507262318555;20066.498337541678;20650.89674551648;20761.480962975744;909.6361455417886;946.8816397950256;963.1331801378815;981.2297346582898;1003.9247056470793;10821.67534973952;11014.39420831862;11049.28179668319;11084.889151108548;11140.220184587;563383;577195;577401;586584;596639;81667.5916620413;96734;100805.49597251967;107051.46474267579;108757;985.9704208873745;996.9501524923725;999.2605471950704;1021.2851004297022;1090.1605763562172;17506;17657.470275891745;17698.672599554826;18027.459176224733;18056.548586285448;40487.78536643906;46421.535784641725;46994.76502617465;47577.52422475731;49873.750631246614;59889.401105990124;65250;69453.65273173602;69658.82047077191;70304.64847675728;7215.71137154508;7771.261730135628;7961.243681850215;7983.560904150328;7995.520268783892;10421.895781042092;11973.521059157885;12108.455119519467;12523.499060037497;12886.871131288943;10686.038256556947;10972.506237219184;11104.167187461135;11139.554417823196;11386.146039047271;10765.3540787553;10907.345559266469;10985.121190304917;11033.779324413626;11110.666679999613;10518.474076296308;10997.450127493434;11102.555897764321;11363.659090227306;11530.76938461243;7842.725504607311;7926.603669816602;7982.241687039722;8035.799105022187;8229.218224268685;9512.809743804946;10875.891241087804;11034.117270618492;11214.215004949901;11467.139964502529 04:57:26 INFO - PROCESS | 1989 | |3;mootools.html;1538.6922615476901;1543.8842086843488;1839.9356022539214;1989.7313862628541;2014.4359579317795;7906.644201010954;8592.441491303061;8647.308215342773;8813.250873675745;8821.33839962003;8531.91468085319;8550.973883134016;8594.011688655806;8600.569971501416;8691.043985161627;2440.5606990741658;2449.2774631483667;2449.6325551167333;2452.141750387368;2473.678421805163;2112.225730386475;2423.4789520253144;2468.136152346682;2490.86300253486;2509.82431229814;2036.5519585691125;2470.147799009348;2476.306634142443;2498.475320182755;2514.182890560566;2467.0880067947305;2470.4441500662388;2487.1543675150447;2494.4262819551514;2497.5379554782335;2463.224084413404;2464.4208610976407;2469.0494159748628;2471.0733474946896;2487.315988103286;8737.7815554611;8800.251978581828;8839.116088391174;8845.4250473719;8862.645494180226;5343.973280133574;5386.245925570423;5417.83746487606;5472.50747432733;5589.692566908819;3573.1424458130123;3622.945655815165;3655.6161603031833;3701.7223708221723;3730.682891954187;1020.117598277492;1035.2080658296409;1039.2828948025913;1041.6718733598968;1042.6246551241622;10105.797884042351;11821.527138914518;12011.579594714143;12028.458719357563;12132.908038276597;4772.976135119302;4787.880302992453;4800.5199480052415;4884.145274576935;4893.168161412497;10022.899771002343;10134.442605656759;10150.441725705157;10180;10207.336523125972;5321.122014867504;5343.839684809462;5344.251804747339;5382.596305277119;5448.237246785453;4426.579474949875;4807.78364973577;4848.442429120696;4859.271109333628;4956.182229932093;3847.2305538892333;3894.201688653819;3940.862069827542;3942.8817135485983;3967.7222594418113;1170.9707257318635;1334.0728193905143;1335.5859683497952;1347.3802051056427;1353.8916886649044;1330.6872884872048;1342.7717288061053;1364.2292104960666;1377.669359353748;1417.4755340524073;7966;8092.028956525254;8162.979627546557;8172.060213075453;8185.549794761345;489.49826427910966;504.94950504949946;506.6149726208108;511.10046318479743;513.3249776543832;6001.729922153513;6093.903097442414;6159.476444502178;6229.283632382243;6234.220722409699;10233.94883025595;10448;10461.895381046244;10470.685879423629;10491.580336786596;8500.27747641445;10130.392176469435;10131.848022279672;10372.792544149226;10455.372677639367;8173.019237691515;8289.544075075808;8307.750767476986;8317.792055198548;8389.622466989;7833.686652534063;8014.559199244098;8057.395695322992;8082.919170808216;8237.423380363556;9422.387544809566;9458.290628202774;9578.563215517728;9667.371620844622;9711;9780.608775648894;9787;9883.258755593215;10008.499575021075;10018.998100189923;6768.390844823989;7209.134903811576;7459.328660420588;7495.812604684927;7635.618219088912;8076.434649574473;8203.876941845996;8245.051819040647;8305.127961563949;8340.165983401854;6892.586444813327;7268.055152830098;7291.161516425679;7371.631418429164;7529.0212272406425;6098.847528811815;7205.855882882418;7241.91371294289;7273.836186210181;7439.99560059385;7679.654415551202;7706.422018348534;7751.534907905544;7775.727849525466;7805.687772489036;6941.3058694132205;6942.271061538466;6969.860602787814;7013.8246543834775;7043.225245223124;5727.31272247333;7060.1880783708475;7212.963935180291;7249;7250.9637451812405 04:57:26 INFO - PROCESS | 1989 | |4;prototype.html;300.7248367743515;326.76309675485277;328.90297362278125;329.67414887965396;335.88653613272004;5295.867603309909;6616.908210145326;6669.966650166754;6685.0640910272605;6704.161979752531;5640.717964101799;6433.035044743279;6602.2737498875085;6639.136912201419;6666.266710661824;4626.4910859805395;4753.572178503934;4840.709557426548;4855.5387238212315;4866.51334866514;4085.8569950051756;4714.656322947943;4848.830290939818;4855.732934688591;4871.464138944713;4163.521195062576;4651.255799072149;4779.856604301876;4791.2094504406905;4813.205821039524;4366.388705581221;4883.877903052435;4896.779644915988;4901.289313049606;4904.141775189363;3857.305684976703;4186.35111557709;4191.538930717618;4205.5794420557695;4208.3687446882905;6028.728707208186;6437.420632143129;6456.999165129366;6458.160439142928;6480.963045912678;4334.371516130143;5614.157876318544;5675.914861277084;5687.544996400319;5776.393478684719;7068.18715847679;7114.537555058904;7126.429885609139;7127.679254433563;7135.143782746104;4571.6114130298965;4584.220682483986;4586.4266966629175;4593.63250939924;4599.931001034987;6525.82535143674;7098.148222213315;7442;7538.698452061966;7541.77374678755;4487.169873573399;4626.74552899587;4633.443986721548;4638.930416043762;4673.649476289292;4712.69367491112;4741.905161896742;4760.404949381327;4766.142094423037;4770;5663.716814159276;5664.575156863251;5669.837683274919;5677.659340439587;5683.829485115453;7130.3939165170505;7172.28277172289;7173.390261827803;7179.138503379628;7189.1013623297085;1616.870650347993;1649.2001379331016;1653.925573349202;1654.8427899349542;1655.7433597792362;773.7137259214127;997.3417544420647;998.940063596172;1044.300318786415;1061.8301071828625;6572.244191917991;6642.83392915181;6644.169478815148;6651.135352404156;6706.161729783777;7380.077490313711;7416.480846340704;7428.702851885864;7434.925650743531;7448.664810083451;6459.192600924885;6499;6708.362705542965;6739.157605299338;6759.459243260528;3905.2189562087697;3945.921081578352;3951.7628942263555;3954.9011274717786;3957.248122856648;7768.184340644264;7782.883256751154;7807.68769249235;7815.53106813593;7828.452008359474;7414.480986330905;7677.692892284358;7689.346405555479;7694.230576942373;7739.071311442551;7764.495307804975;7776.92223077762;7795.727149549852;7807.68769249235;7816.716978868889;6485.735281620227;6626.933730662631;7447.143578488326;7449.0316258886;7489.363404110712;7323.048003759477;7329.083864516935;7337.669804858688;7347.632618369167;7354.889676654748;7471.17817040136;7785.961070194613;7813.921860781319;7824.139344672195;7826.373890088666;4341.848035318749;4421.845235416745;4663.137319595886;4663.323818046297;4673.369095172108;6021.488173505126;7415.1101867776215;7441.590712510864;7449.329560339595;7450.739224127129;7179.03083083777;7182.748603798842;7216.927830721836;7224.494285400182;7226.458015648742;5711.400302968294;6041.486473649789;6916.792496225121;7190.568565886064;7241.746538871114;6966.5471744336455;7025.367716905503;7025.613591252326;7030.578165310098;7037.1555413350725;7173.246809084971;7191.460640451883;7198.028266183998;7209.927900721135;7261.164966028974;5069.797208111634;6413.839654008687;7020.333068358498;7037.824054398477;7053.224145343906 04:57:26 INFO - PROCESS | 1989 | |5;yui.html;681.8397676546011;727.1891840597729;746.1046743907311;762.2034973452742;794.217695569864;14392.208428536427;14460.638484037905;14559.126452412862;14582.708345833076;14670.04644698094;13647.45410183594;15437.845621543782;15847.445339413123;15869.92065039676;15878.603034924132;904.8099899021213;908.6683360573393;911.1071150272737;912.0788004115824;915.9908400916006;743.5167141358106;886.4149661223562;891.4873947480193;912.2975309012056;921.4379228670506;938.1087966431883;938.7183844846519;972.8443449048153;974.142754376148;978.0854900667863;932.3520153493325;943.4339396362196;957.9329446938717;966.3284017607765;967.5307475874231;696.5611664651288;697.0276464332279;697.3166297028889;697.553565717941;715.7172916697928;14831.332590033475;14891.553253402415;14893.553193404216;15056;15134.243287835674;12170.756584868253;12405.255684658949;12439.75120497585;12598.748025039447;12700.555480558229;9855.90144098557;9879.506024698736;9913.454759988197;10248.38509689421;10636;3338.098713347407;3402.727781777452;3455.6026057003514;3558.2705545363137;3578.731595130376;84570;84953.57523212345;85552.57223713842;86291;86311.56844215738;9060.909390906007;9133.77165570866;9239.399439036575;9298.814023719622;9338.299627527962;16960.57598560046;18840.905795470935;20519.17923283052;20857.68713469299;20857.791422085887;6459.708058388341;7130.572165670076;7241.674124664402;7263.709451621981;7562.205968373351;3986.461827653288;4024.657904078186;4030.5364883038824;4031.274370613259;4033.153037862082;2967.3768508613;3563.768355056913;3622.1487950331652;3626.0934766308424;3632.164602141522;654.6268626882727;660.4848218389664;660.5079215984123;670.2727540618483;675.0212192321154;538.6014349381429;595.4521839907296;616.1558664629487;618.4557589321458;619.3465893482329;7964.840703185904;8154.2253485918745;8273.420860539705;8368.288695460955;8464.703735369232;459.90571932753704;560.2240896358572;594.560025581067;606.0245385385942;614.5680564285204;2976.427094927636;3829.7702137871815;3850.0374906273432;3855.9228815423535;3881.2819628368843;84321;89014;89562.55218723865;93474;93630;74148;75503.48993020218;76129;76879;77659;62783;64001;64736.02895956564;66649;68204.6589767048;6854.725810967506;7369.8526029478035;7525.17223105447;7558.962205188939;7623.504472209289;48442.5155748438;49006.754966224944;49580.00839983252;50320.74839625925;51686.48313516967;59249;63064;65653.67173164104;68550.28624284433;69765.30234697588;10649.094826939798;10799.67600971972;10894;11171.273867198606;11560;9963.551640176065;12095.274283543016;12199;12444.020299320813;12486.063545233963;11239.325640461599;11411.885881141414;11578.36319002463;11799.705007374885;11960.46177922013;10043.899561004297;10666.89333106659;11674.357910314675;11713.062954963752;12000.459979301128;11078.169137314895;11206.439678015904;11244.26912250701;11259.042981346678;11403.486843091914;9122.251906687834;9231.399959002643;9406.81186376255;9625.663101791684;9718.12536871685;9076.636934522545;9633.277504187354;9671.951640241754;9674.951625241829;9684.903150968681 04:57:26 INFO - PROCESS | 1989 | __end_tp_report 04:57:26 INFO - PROCESS | 1989 | __start_cc_report 04:57:26 INFO - PROCESS | 1989 | _x_x_mozilla_cycle_collect,356 04:57:26 INFO - PROCESS | 1989 | __end_cc_report 04:57:26 INFO - PROCESS | 1989 | __startTimestamp1460030246157__endTimestamp 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - PROCESS | 1989 | ------- Summary: start ------- 04:57:26 INFO - PROCESS | 1989 | Number of tests: 6 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - PROCESS | 1989 | [#0] dojo.html Cycles:165 Average:5735.11 Median:6011.07 stddev:661.37 (11.0%) stddev-sans-first:637.74 04:57:26 INFO - PROCESS | 1989 | Values: 3409.7 3465.7 3493.1 3511.3 3535.8 4475.0 4758.5 5688.7 5724.3 5786.8 5643.4 5695.7 5763.3 5789.5 5951.7 5140.3 5176.4 5196.7 5216.8 5277.6 5308.4 5356.3 5383.6 5399.1 5409.8 4665.8 5259.1 5285.9 5286.3 5290.2 5240.4 5256.6 5268.1 5281.5 5283.9 4316.7 5113.6 5179.2 5214.1 5259.5 5608.9 5634.4 5659.4 5683.1 5686.7 6134.9 6148.6 6195.9 6197.1 6214.2 6096.5 6157.7 6209.4 6231.5 6245.0 5940.3 5960.8 5971.0 5972.2 6025.5 6286.9 6320.5 6322.4 6328.3 6331.8 6011.1 6124.7 6128.5 6151.9 6161.9 6198.6 6212.8 6244.5 6247.8 6252.1 6087.6 6145.0 6166.7 6169.4 6177.9 5443.5 6147.5 6217.2 6246.1 6273.6 4815.9 4872.2 4937.5 4949.4 4975.9 4078.9 4302.6 4406.2 4414.4 4466.3 5858.6 5878.4 5886.2 5894.6 5905.4 5371.0 6172.2 6189.5 6248.0 6285.7 5807.7 5840.2 5879.8 5892.2 5899.7 5421.4 5461.6 5467.7 5469.2 5476.8 6210.4 6309.1 6343.7 6368.4 6381.9 6268.9 6273.7 6279.7 6283.5 6289.2 6141.0 6369.7 6377.5 6389.7 6398.0 6147.1 6213.2 6261.7 6262.3 6273.6 6115.6 6177.4 6237.3 6252.2 6254.8 4554.7 6085.3 6105.1 6205.7 6256.7 5793.8 6100.8 6131.3 6178.4 6189.6 6007.2 6068.3 6068.4 6097.0 6124.6 5153.7 5787.2 5814.0 6216.6 6281.8 6083.3 6104.2 6109.1 6110.5 6132.0 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - PROCESS | 1989 | [#1] ext.html Cycles:180 Average:56978.74 Median:37338.53 stddev:116724.67 (312.6%) stddev-sans-first:116975.18 04:57:26 INFO - PROCESS | 1989 | Values: 532.9 579.7 597.6 637.8 647.0 36904.4 37670.2 37687.6 37699.4 37967.1 32844.7 40205.0 40255.6 40291.4 41161.0 9391.2 9620.8 9635.8 9636.6 9650.9 9477.8 9531.0 9560.0 9658.8 9661.8 9554.9 9574.0 9587.0 9612.2 9693.8 9540.0 9639.1 9649.4 9662.6 9675.3 9458.3 9460.1 9557.4 9594.7 9630.3 31839.0 38185.4 38290.8 38761.6 38934.4 3044.5 3071.8 3159.7 3199.9 3306.3 26698.0 27288.7 27809.7 28070.7 28377.9 2641.5 2699.3 2720.8 2849.2 2932.3 249685.5 278602.0 283213.0 286264.0 292562.0 45069.8 45690.5 55732.2 63341.0 63383.7 43936.7 43966.6 44065.6 44772.8 45262.9 14426.7 14434.8 15440.8 15486.6 15878.9 12444.5 12808.8 12875.9 12876.0 12883.4 14234.4 14280.4 14399.1 14657.6 14890.9 5348.0 6274.5 6322.9 6340.5 6367.3 901.8 928.4 993.2 1013.0 1019.7 28908.3 29386.4 29550.6 29671.4 29830.4 1100.2 1113.9 1165.5 1182.2 1208.2 15030.6 15074.0 15083.2 15089.5 15286.9 510284.4 513108.0 514634.0 515628.0 516879.0 56831.0 57789.4 58502.4 58632.4 58742.4 1466.1 1467.7 1479.6 1484.8 1602.3 25956.4 28997.9 29329.0 29664.7 29734.4 50173.7 50689.0 51183.5 51186.7 51412.5 481603.0 483046.0 483551.6 487314.0 487433.0 32617.0 32792.0 33165.5 33204.0 33855.8 44774.0 45367.1 45459.9 45629.5 46506.0 32782.0 35818.5 36510.0 37478.0 38082.4 31050.6 35441.5 36733.8 37423.4 37714.1 36049.5 36550.3 36608.6 36758.3 37253.6 32435.4 33247.7 33255.0 33451.5 33590.8 23779.1 24604.5 24710.5 25259.6 25373.2 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - PROCESS | 1989 | [#2] jquery.html Cycles:180 Average:32416.01 Median:357.54 stddev:95830.32 (26802.3%) stddev-sans-first:96068.91 04:57:26 INFO - PROCESS | 1989 | Values: 353.7 361.4 363.9 366.3 371.3 19416.8 19511.5 20205.5 20446.8 20464.7 19916.9 20039.5 20335.3 20468.8 20643.9 5672.6 5975.3 5986.7 5998.6 6006.5 4204.1 5873.9 6264.1 6524.6 6537.6 5393.5 5857.6 6034.0 6394.4 6474.5 6129.8 6269.1 6381.1 6387.3 6390.8 5377.2 5473.8 5529.8 5535.3 5556.0 12670.0 13166.9 24831.0 25136.1 25362.7 2019.9 2048.8 2054.7 2145.7 2158.3 9591.8 9737.7 10115.6 12686.4 14355.1 1678.1 1686.7 1692.9 1711.0 1748.2 94333.1 97984.5 98416.0 98725.0 100881.5 10800.8 11033.2 11150.4 11212.0 11237.2 13531.0 13643.7 13836.7 13842.5 13861.7 7322.5 7986.8 8345.6 8453.9 8546.8 8498.8 8561.0 8609.0 8688.1 8696.3 4005.4 4042.6 4338.5 4445.7 4527.8 1614.8 1623.4 1659.7 1838.7 1867.3 821.4 903.6 979.8 989.9 1035.6 18058.0 19709.5 20066.5 20650.9 20761.5 909.6 946.9 963.1 981.2 1003.9 10821.7 11014.4 11049.3 11084.9 11140.2 563383.0 577195.0 577401.0 586584.0 596639.0 81667.6 96734.0 100805.5 107051.5 108757.0 986.0 997.0 999.3 1021.3 1090.2 17506.0 17657.5 17698.7 18027.5 18056.5 40487.8 46421.5 46994.8 47577.5 49873.8 59889.4 65250.0 69453.7 69658.8 70304.6 7215.7 7771.3 7961.2 7983.6 7995.5 10421.9 11973.5 12108.5 12523.5 12886.9 10686.0 10972.5 11104.2 11139.6 11386.1 10765.4 10907.3 10985.1 11033.8 11110.7 10518.5 10997.5 11102.6 11363.7 11530.8 7842.7 7926.6 7982.2 8035.8 8229.2 9512.8 10875.9 11034.1 11214.2 11467.1 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - PROCESS | 1989 | [#3] mootools.html Cycles:180 Average:5995.18 Median:2917.22 stddev:3152.98 (108.1%) stddev-sans-first:3144.03 04:57:26 INFO - PROCESS | 1989 | Values: 1538.7 1543.9 1839.9 1989.7 2014.4 7906.6 8592.4 8647.3 8813.3 8821.3 8531.9 8551.0 8594.0 8600.6 8691.0 2440.6 2449.3 2449.6 2452.1 2473.7 2112.2 2423.5 2468.1 2490.9 2509.8 2036.6 2470.1 2476.3 2498.5 2514.2 2467.1 2470.4 2487.2 2494.4 2497.5 2463.2 2464.4 2469.0 2471.1 2487.3 8737.8 8800.3 8839.1 8845.4 8862.6 5344.0 5386.2 5417.8 5472.5 5589.7 3573.1 3622.9 3655.6 3701.7 3730.7 1020.1 1035.2 1039.3 1041.7 1042.6 10105.8 11821.5 12011.6 12028.5 12132.9 4773.0 4787.9 4800.5 4884.1 4893.2 10022.9 10134.4 10150.4 10180.0 10207.3 5321.1 5343.8 5344.3 5382.6 5448.2 4426.6 4807.8 4848.4 4859.3 4956.2 3847.2 3894.2 3940.9 3942.9 3967.7 1171.0 1334.1 1335.6 1347.4 1353.9 1330.7 1342.8 1364.2 1377.7 1417.5 7966.0 8092.0 8163.0 8172.1 8185.5 489.5 504.9 506.6 511.1 513.3 6001.7 6093.9 6159.5 6229.3 6234.2 10233.9 10448.0 10461.9 10470.7 10491.6 8500.3 10130.4 10131.8 10372.8 10455.4 8173.0 8289.5 8307.8 8317.8 8389.6 7833.7 8014.6 8057.4 8082.9 8237.4 9422.4 9458.3 9578.6 9667.4 9711.0 9780.6 9787.0 9883.3 10008.5 10019.0 6768.4 7209.1 7459.3 7495.8 7635.6 8076.4 8203.9 8245.1 8305.1 8340.2 6892.6 7268.1 7291.2 7371.6 7529.0 6098.8 7205.9 7241.9 7273.8 7440.0 7679.7 7706.4 7751.5 7775.7 7805.7 6941.3 6942.3 6969.9 7013.8 7043.2 5727.3 7060.2 7213.0 7249.0 7251.0 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - PROCESS | 1989 | [#4] prototype.html Cycles:180 Average:5778.37 Median:6609.59 stddev:1892.46 (28.6%) stddev-sans-first:1852.57 04:57:26 INFO - PROCESS | 1989 | Values: 300.7 326.8 328.9 329.7 335.9 5295.9 6616.9 6670.0 6685.1 6704.2 5640.7 6433.0 6602.3 6639.1 6666.3 4626.5 4753.6 4840.7 4855.5 4866.5 4085.9 4714.7 4848.8 4855.7 4871.5 4163.5 4651.3 4779.9 4791.2 4813.2 4366.4 4883.9 4896.8 4901.3 4904.1 3857.3 4186.4 4191.5 4205.6 4208.4 6028.7 6437.4 6457.0 6458.2 6481.0 4334.4 5614.2 5675.9 5687.5 5776.4 7068.2 7114.5 7126.4 7127.7 7135.1 4571.6 4584.2 4586.4 4593.6 4599.9 6525.8 7098.1 7442.0 7538.7 7541.8 4487.2 4626.7 4633.4 4638.9 4673.6 4712.7 4741.9 4760.4 4766.1 4770.0 5663.7 5664.6 5669.8 5677.7 5683.8 7130.4 7172.3 7173.4 7179.1 7189.1 1616.9 1649.2 1653.9 1654.8 1655.7 773.7 997.3 998.9 1044.3 1061.8 6572.2 6642.8 6644.2 6651.1 6706.2 7380.1 7416.5 7428.7 7434.9 7448.7 6459.2 6499.0 6708.4 6739.2 6759.5 3905.2 3945.9 3951.8 3954.9 3957.2 7768.2 7782.9 7807.7 7815.5 7828.5 7414.5 7677.7 7689.3 7694.2 7739.1 7764.5 7776.9 7795.7 7807.7 7816.7 6485.7 6626.9 7447.1 7449.0 7489.4 7323.0 7329.1 7337.7 7347.6 7354.9 7471.2 7786.0 7813.9 7824.1 7826.4 4341.8 4421.8 4663.1 4663.3 4673.4 6021.5 7415.1 7441.6 7449.3 7450.7 7179.0 7182.7 7216.9 7224.5 7226.5 5711.4 6041.5 6916.8 7190.6 7241.7 6966.5 7025.4 7025.6 7030.6 7037.2 7173.2 7191.5 7198.0 7209.9 7261.2 5069.8 6413.8 7020.3 7037.8 7053.2 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - PROCESS | 1989 | [#5] yui.html Cycles:180 Average:18011.58 Median:35597.87 stddev:25357.51 (71.2%) stddev-sans-first:25395.25 04:57:26 INFO - PROCESS | 1989 | Values: 681.8 727.2 746.1 762.2 794.2 14392.2 14460.6 14559.1 14582.7 14670.0 13647.5 15437.8 15847.4 15869.9 15878.6 904.8 908.7 911.1 912.1 916.0 743.5 886.4 891.5 912.3 921.4 938.1 938.7 972.8 974.1 978.1 932.4 943.4 957.9 966.3 967.5 696.6 697.0 697.3 697.6 715.7 14831.3 14891.6 14893.6 15056.0 15134.2 12170.8 12405.3 12439.8 12598.7 12700.6 9855.9 9879.5 9913.5 10248.4 10636.0 3338.1 3402.7 3455.6 3558.3 3578.7 84570.0 84953.6 85552.6 86291.0 86311.6 9060.9 9133.8 9239.4 9298.8 9338.3 16960.6 18840.9 20519.2 20857.7 20857.8 6459.7 7130.6 7241.7 7263.7 7562.2 3986.5 4024.7 4030.5 4031.3 4033.2 2967.4 3563.8 3622.1 3626.1 3632.2 654.6 660.5 660.5 670.3 675.0 538.6 595.5 616.2 618.5 619.3 7964.8 8154.2 8273.4 8368.3 8464.7 459.9 560.2 594.6 606.0 614.6 2976.4 3829.8 3850.0 3855.9 3881.3 84321.0 89014.0 89562.6 93474.0 93630.0 74148.0 75503.5 76129.0 76879.0 77659.0 62783.0 64001.0 64736.0 66649.0 68204.7 6854.7 7369.9 7525.2 7559.0 7623.5 48442.5 49006.8 49580.0 50320.7 51686.5 59249.0 63064.0 65653.7 68550.3 69765.3 10649.1 10799.7 10894.0 11171.3 11560.0 9963.6 12095.3 12199.0 12444.0 12486.1 11239.3 11411.9 11578.4 11799.7 11960.5 10043.9 10666.9 11674.4 11713.1 12000.5 11078.2 11206.4 11244.3 11259.0 11403.5 9122.3 9231.4 9406.8 9625.7 9718.1 9076.6 9633.3 9672.0 9675.0 9684.9 04:57:26 INFO - PROCESS | 1989 | -------- Summary: end -------- 04:57:26 INFO - PROCESS | 1989 | 04:57:26 INFO - TEST-INFO | 1989: exit 0 04:57:26 INFO - TEST-OK | dromaeo_css | took 1111154ms 04:57:26 INFO - TEST-START | kraken 04:57:26 INFO - operating with platform_type : mac_ 04:57:26 INFO - Initialising browser for kraken test... 04:57:26 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpBFEGs4/profile http://localhost:49648/getInfo.html) 04:57:28 INFO - PROCESS | 1994 | 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:57:29 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 04:57:29 INFO - PROCESS | 1994 | colorDepth:24 04:57:29 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 04:57:29 INFO - PROCESS | 1994 | __metrics 04:57:29 ERROR - PROCESS | 1994 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 04:57:30 INFO - TEST-INFO | 1994: exit 0 04:57:30 INFO - Browser initialized. 04:57:30 INFO - Running cycle 1/1 for kraken test... 04:57:30 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpBFEGs4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:42 INFO - PROCESS | 1997 | RSS: Main: 246894592 04:57:42 INFO - PROCESS | 1997 | 04:57:44 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49648/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:45 INFO - PROCESS | 1997 | RSS: Main: 258899968 04:57:45 INFO - PROCESS | 1997 | 04:57:48 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49648/tests/kraken/driver.html?testName=audio-dft) 04:57:48 INFO - PROCESS | 1997 | RSS: Main: 268128256 04:57:48 INFO - PROCESS | 1997 | 04:57:52 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49648/tests/kraken/driver.html?testName=audio-fft) 04:57:52 INFO - PROCESS | 1997 | RSS: Main: 271319040 04:57:52 INFO - PROCESS | 1997 | 04:57:54 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49648/tests/kraken/driver.html?testName=audio-oscillator) 04:57:55 INFO - PROCESS | 1997 | RSS: Main: 272957440 04:57:55 INFO - PROCESS | 1997 | 04:57:57 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:58 INFO - PROCESS | 1997 | RSS: Main: 273399808 04:57:58 INFO - PROCESS | 1997 | 04:58:01 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49648/tests/kraken/driver.html?testName=imaging-darkroom) 04:58:01 INFO - PROCESS | 1997 | RSS: Main: 273887232 04:58:01 INFO - PROCESS | 1997 | 04:58:05 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49648/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:05 INFO - PROCESS | 1997 | RSS: Main: 274378752 04:58:05 INFO - PROCESS | 1997 | 04:58:08 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49648/tests/kraken/driver.html?testName=json-parse-financial) 04:58:09 INFO - PROCESS | 1997 | RSS: Main: 274276352 04:58:09 INFO - PROCESS | 1997 | 04:58:10 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:11 INFO - PROCESS | 1997 | RSS: Main: 273973248 04:58:11 INFO - PROCESS | 1997 | 04:58:13 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:14 INFO - PROCESS | 1997 | RSS: Main: 273723392 04:58:14 INFO - PROCESS | 1997 | 04:58:16 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:16 INFO - PROCESS | 1997 | RSS: Main: 274243584 04:58:16 INFO - PROCESS | 1997 | 04:58:19 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:20 INFO - PROCESS | 1997 | RSS: Main: 274440192 04:58:20 INFO - PROCESS | 1997 | 04:58:22 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:23 INFO - PROCESS | 1997 | RSS: Main: 274440192 04:58:23 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49648/tests/kraken/driver.html?testName=ai-astar) 04:58:25 INFO - PROCESS | 1997 | RSS: Main: 275623936 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | __start_tp_report 04:58:25 INFO - PROCESS | 1997 | _x_x_mozilla_page_load 04:58:25 INFO - PROCESS | 1997 | _x_x_mozilla_page_load_details 04:58:25 INFO - PROCESS | 1997 | |i|pagename|runs| 04:58:25 INFO - PROCESS | 1997 | |0;ai-astar;115;106;115;115;113;126;116;126;166;169 04:58:25 INFO - PROCESS | 1997 | |1;audio-beat-detection;162;126;146;157;126;146;138;196;189;121 04:58:25 INFO - PROCESS | 1997 | |2;audio-dft;196;194;224;267;265;211;195;278;252;205 04:58:25 INFO - PROCESS | 1997 | |3;audio-fft;66;77;76;115;67;82;86;79;124;57 04:58:25 INFO - PROCESS | 1997 | |4;audio-oscillator;76;108;106;81;117;65;149;120;116;145 04:58:25 INFO - PROCESS | 1997 | |5;imaging-gaussian-blur;110;86;76;76;79;114;133;107;90;88 04:58:25 INFO - PROCESS | 1997 | |6;imaging-darkroom;94;105;131;96;131;112;145;150;95;94 04:58:25 INFO - PROCESS | 1997 | |7;imaging-desaturate;116;140;149;94;153;145;117;92;132;88 04:58:25 INFO - PROCESS | 1997 | |8;json-parse-financial;58;58;55;58;58;58;57;66;58;56 04:58:25 INFO - PROCESS | 1997 | |9;json-stringify-tinderbox;67;92;110;67;82;73;72;70;69;72 04:58:25 INFO - PROCESS | 1997 | |10;stanford-crypto-aes;83;87;89;87;103;73;79;77;82;74 04:58:25 INFO - PROCESS | 1997 | |11;stanford-crypto-ccm;134;143;110;140;133;137;139;135;133;125 04:58:25 INFO - PROCESS | 1997 | |12;stanford-crypto-pbkdf2;145;145;150;143;145;146;182;157;139;142 04:58:25 INFO - PROCESS | 1997 | |13;stanford-crypto-sha256-iterative;67;70;66;67;67;89;91;92;94;74 04:58:25 INFO - PROCESS | 1997 | __end_tp_report 04:58:25 INFO - PROCESS | 1997 | __start_cc_report 04:58:25 INFO - PROCESS | 1997 | _x_x_mozilla_cycle_collect,985 04:58:25 INFO - PROCESS | 1997 | __end_cc_report 04:58:25 INFO - PROCESS | 1997 | __startTimestamp1460030305465__endTimestamp 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | ------- Summary: start ------- 04:58:25 INFO - PROCESS | 1997 | Number of tests: 14 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#0] ai-astar Cycles:10 Average:126.70 Median:121.00 stddev:22.30 (18.4%) stddev-sans-first:23.25 04:58:25 INFO - PROCESS | 1997 | Values: 115.0 106.0 115.0 115.0 113.0 126.0 116.0 126.0 166.0 169.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:151.50 stddev:25.81 (17.0%) stddev-sans-first:27.05 04:58:25 INFO - PROCESS | 1997 | Values: 162.0 126.0 146.0 157.0 126.0 146.0 138.0 196.0 189.0 121.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#2] audio-dft Cycles:10 Average:228.70 Median:238.00 stddev:33.44 (14.1%) stddev-sans-first:33.31 04:58:25 INFO - PROCESS | 1997 | Values: 196.0 194.0 224.0 267.0 265.0 211.0 195.0 278.0 252.0 205.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:21.18 (27.7%) stddev-sans-first:21.56 04:58:25 INFO - PROCESS | 1997 | Values: 66.0 77.0 76.0 115.0 67.0 82.0 86.0 79.0 124.0 57.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:147.00 stddev:27.78 (18.9%) stddev-sans-first:26.89 04:58:25 INFO - PROCESS | 1997 | Values: 76.0 108.0 106.0 81.0 117.0 65.0 149.0 120.0 116.0 145.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:77.50 stddev:19.15 (24.7%) stddev-sans-first:19.62 04:58:25 INFO - PROCESS | 1997 | Values: 110.0 86.0 76.0 76.0 79.0 114.0 133.0 107.0 90.0 88.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#6] imaging-darkroom Cycles:10 Average:115.30 Median:122.00 stddev:22.08 (18.1%) stddev-sans-first:22.03 04:58:25 INFO - PROCESS | 1997 | Values: 94.0 105.0 131.0 96.0 131.0 112.0 145.0 150.0 95.0 94.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#7] imaging-desaturate Cycles:10 Average:122.60 Median:151.00 stddev:24.81 (16.4%) stddev-sans-first:26.20 04:58:25 INFO - PROCESS | 1997 | Values: 116.0 140.0 149.0 94.0 153.0 145.0 117.0 92.0 132.0 88.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.94 (5.1%) stddev-sans-first:3.11 04:58:25 INFO - PROCESS | 1997 | Values: 58.0 58.0 55.0 58.0 58.0 58.0 57.0 66.0 58.0 56.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:72.00 stddev:13.81 (19.2%) stddev-sans-first:14.13 04:58:25 INFO - PROCESS | 1997 | Values: 67.0 92.0 110.0 67.0 82.0 73.0 72.0 70.0 69.0 72.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:8.82 (10.7%) stddev-sans-first:9.36 04:58:25 INFO - PROCESS | 1997 | Values: 83.0 87.0 89.0 87.0 103.0 73.0 79.0 77.0 82.0 74.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:136.00 stddev:9.42 (6.9%) stddev-sans-first:9.98 04:58:25 INFO - PROCESS | 1997 | Values: 134.0 143.0 110.0 140.0 133.0 137.0 139.0 135.0 133.0 125.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:145.50 stddev:12.45 (8.6%) stddev-sans-first:13.10 04:58:25 INFO - PROCESS | 1997 | Values: 145.0 145.0 150.0 143.0 145.0 146.0 182.0 157.0 139.0 142.0 04:58:25 INFO - PROCESS | 1997 | 04:58:25 INFO - PROCESS | 1997 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:81.50 stddev:12.15 (14.9%) stddev-sans-first:12.25 04:58:25 INFO - PROCESS | 1997 | Values: 67.0 70.0 66.0 67.0 67.0 89.0 91.0 92.0 94.0 74.0 04:58:25 INFO - PROCESS | 1997 | -------- Summary: end -------- 04:58:25 INFO - PROCESS | 1997 | 04:58:26 INFO - TEST-INFO | 1997: exit 0 04:58:26 INFO - TEST-OK | kraken | took 59504ms 04:58:26 INFO - SUITE-END | took 1170s 04:58:26 INFO - Completed test suite (00:19:30) 04:58:26 INFO - javascript benchmark 04:58:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3409.659034096591, 3465.688088072073, 3493.1092571394292, 3511.29774045191, 3535.7701749386306, 4474.955250447494, 4758.500357462469, 5688.658680479169, 5724.34170070442, 5786.768529258829, 5643.435656434354, 5695.686737229451, 5763.250777398932, 5789.536837053036, 5951.6726580038085, 5140.2546630738525, 5176.378834539851, 5196.662216955886, 5216.7913283468615, 5277.604179686519, 5308.389535203443, 5356.303680521527, 5383.596230282745, 5399.055165346068, 5409.83770486886, 4665.836695715668, 5259.0796610593, 5285.8942821143555, 5286.3392075990505, 5290.153575427951, 5240.449752775941, 5256.553192978601, 5268.130758424855, 5281.471852814726, 5283.86790330241, 4316.676249281317, 5113.565346945514, 5179.19722443022, 5214.139666954948, 5259.47405259471, 5608.887822243532, 5634.4365563443325, 5659.40576239493, 5683.090705487102, 5686.687232202227, 6134.877302453926, 6148.569600127993, 6195.907061394083, 6197.101420294077, 6214.192155019864, 6096.466212027279, 6157.722902469355, 6209.3790620938, 6231.501479881598, 6245.0320200369015, 5940.287165540163, 5960.821175364746, 5970.970145149333, 5972.193753843262, 6025.457708806184, 6286.937130628727, 6320.494360451153, 6322.399372059647, 6328.335524769925, 6331.778387756406, 6011.068284415923, 6124.724387402578, 6128.503123582198, 6151.938480615226, 6161.907571386433, 6198.6280823149855, 6212.751489940351, 6244.500439964792, 6247.75008999644, 6252.093446450239, 6087.634741915499, 6145.0, 6166.660833654102, 6169.444749972524, 6177.938220617736, 5443.455654434604, 6147.477464415575, 6217.191765070512, 6246.129876355824, 6273.560850740496, 4815.879603009883, 4872.196087645499, 4937.530934561211, 4949.430815456197, 4975.90048199034, 4078.938815917764, 4302.644666929907, 4406.20688276107, 4414.404055452537, 4466.330050492452, 5858.56060795442, 5878.441548053013, 5886.175935369051, 5894.616849904743, 5905.409459054146, 5371.006363822706, 6172.22847144107, 6189.473894718999, 6247.96876015617, 6285.654289014148, 5807.651540907559, 5840.153177789197, 5879.823605291848, 5892.204552385459, 5899.67551784656, 5421.403645598981, 5461.563074953994, 5467.726613669301, 5469.15228139639, 5476.7535460904355, 6210.441060304594, 6309.08518264849, 6343.651099189497, 6368.42684158428, 6381.904271436025, 6268.874622507616, 6273.686315684106, 6279.686015699105, 6283.5287353449585, 6289.182406287154, 6140.995089002448, 6369.681515924092, 6377.489800815831, 6389.744410223725, 6398.0, 6147.108669243024, 6213.2233470816145, 6261.74953001893, 6262.342454042442, 6273.560850740404, 6115.571909966259, 6177.382261773787, 6237.345078766664, 6252.249730032243, 6254.781082662085, 4554.681172317906, 6085.3306136325855, 6105.065535583987, 6205.720742566505, 6256.655883926428, 5793.826185214451, 6100.793122958854, 6131.254333328352, 6178.41305076017, 6189.628622282497, 6007.158997740233, 6068.315759135816, 6068.393160683896, 6096.973848131493, 6124.564025909317, 5153.742312884416, 5787.2187254720075, 5814.04068328721, 6216.564840461125, 6281.811545653638, 6083.330833608211, 6104.245243171002, 6109.1010297800785, 6110.498006581597, 6132.023677617016], "unit": "score", "name": "dojo.html", "value": 5694.906109014533}, {"lowerIsBetter": false, "replicates": [532.9173978033406, 579.6811753535554, 597.5697497801582, 637.8277864976457, 646.9583969808609, 36904.446433303485, 37670.246595068114, 37687.62312376875, 37699.43450848233, 37967.05082372938, 32844.67155328452, 40205.0, 40255.59744402555, 40291.395629065584, 41161.0, 9391.154796068335, 9620.807583848318, 9635.759106022335, 9636.566354514063, 9650.855237171449, 9477.763055923588, 9530.952345238264, 9560.043995600454, 9658.75853103671, 9661.806763864719, 9554.904450955506, 9573.994730553297, 9586.952065239664, 9612.231021518262, 9693.806123877519, 9539.952300238489, 9639.132478076972, 9649.372790768577, 9662.613495460173, 9675.274354423447, 9458.33791634586, 9460.053994600554, 9557.378770379903, 9594.6641867535, 9630.27772917034, 31839.0, 38185.42721859174, 38290.80854595737, 38761.61238387608, 38934.415983760264, 3044.4824379855477, 3071.769617278713, 3159.6840315968448, 3199.904002879894, 3306.2560923792194, 26698.0, 27288.72711272882, 27809.72190278112, 28070.719292807218, 28377.86488540456, 2641.537730897085, 2699.325168707823, 2720.8231464954715, 2849.153642582518, 2932.2522756697117, 249685.50314496804, 278602.0, 283213.0, 286264.0, 292562.0, 45069.774651126536, 45690.54309456929, 55732.16401753977, 63341.0, 63383.6830815843, 43936.681899543066, 43966.56033439624, 44065.559344406145, 44772.77613611911, 45262.868428289556, 14426.711465770835, 14434.773044291353, 15440.845591544165, 15486.612834679223, 15878.888477806673, 12444.502219911283, 12808.80786788199, 12875.935620321838, 12876.0, 12883.42024608876, 14234.359453824603, 14280.357383917748, 14399.064060836012, 14657.633559161106, 14890.851091489163, 5348.0, 6274.455211228431, 6322.9051564226575, 6340.524460665469, 6367.267764207083, 901.7970956534728, 928.3594319919234, 993.2153598657125, 1013.0426746724274, 1019.6991887393236, 28908.277293067422, 29386.412271754874, 29550.556741648892, 29671.406571868443, 29830.40339193204, 1100.2023532938715, 1113.8551988241638, 1165.5046605192929, 1182.2256422043574, 1208.2025862930423, 15030.624234394008, 15074.0201886877, 15083.170425626697, 15089.54731358061, 15286.923565382325, 510284.4485777547, 513108.0, 514634.0, 515628.0, 516879.0, 56831.0, 57789.4221057784, 58502.41497584969, 58632.41367586355, 58742.41257587369, 1466.1203278033095, 1467.7431449496296, 1479.5783201787654, 1484.8366679665228, 1602.3190144188907, 25956.35109122287, 28997.855010725656, 29328.97348592789, 29664.703352966193, 29734.405311894072, 50173.74913125411, 50689.0, 51183.48816511787, 51186.720331992, 51412.48587514077, 481603.0, 483046.0, 483551.58224208653, 487314.0, 487433.0, 32617.0, 32792.0, 33165.507552159725, 33204.0465432449, 33855.830720846236, 44774.0, 45367.09265814731, 45459.86350341268, 45629.54370456386, 46506.0, 32782.0, 35818.462723058656, 36510.0, 37478.0, 38082.428763568016, 31050.602722877975, 35441.46837797487, 36733.816330919246, 37423.43864841975, 37714.057148571505, 36049.459258110626, 36550.26899462049, 36608.633913661586, 36758.26483470262, 37253.62746372502, 32435.35129297448, 33247.66752332446, 33255.0, 33451.49822752612, 33590.83204583961, 23779.051193994255, 24604.507909841344, 24710.50578988446, 25259.62110568306, 25373.238802835946], "unit": "score", "name": "ext.html", "value": 18763.51976775348}, {"lowerIsBetter": false, "replicates": [353.6516531216751, 361.4379639660329, 363.8599139331358, 366.32047551791425, 371.329749801608, 19416.8349899006, 19511.512212194702, 20205.494862628442, 20446.795532044674, 20464.693029604532, 19916.900415497938, 20039.499012524695, 20335.28826491073, 20468.795312046874, 20643.896780516116, 5672.602917795756, 5975.282966044059, 5986.700664966756, 5998.610090344136, 6006.519478441714, 4204.138151678899, 5873.8825223495505, 6264.091706702526, 6524.608523488582, 6537.64042977636, 5393.541548968323, 5857.619254748428, 6033.969830150865, 6394.392532709408, 6474.546781725281, 6129.754809807602, 6269.0909818076125, 6381.106645069717, 6387.2654644715985, 6390.840228994266, 5377.166539186433, 5473.75368108436, 5529.834104976857, 5535.335759708821, 5555.972220138914, 12670.0, 13166.86833131666, 24831.00675972959, 25136.12023579166, 25362.74637253622, 2019.9091040903195, 2048.8258498027535, 2054.679055561615, 2145.710329105582, 2158.2554018863466, 9591.808163836755, 9737.65918192867, 10115.645952391631, 12686.36568171597, 14355.138691678532, 1678.1022153148128, 1686.6963946489627, 1692.9080742920871, 1710.9657806843793, 1748.2220411916703, 94333.0566694331, 97984.51007744987, 98416.0, 98725.0, 100881.49559252156, 10800.837987430195, 11033.172512061628, 11150.442477876073, 11212.046976006968, 11237.21339506243, 13531.0, 13643.658908527168, 13836.723265534632, 13842.515511957034, 13861.653458663412, 7322.524035937647, 7986.801979703091, 8345.582720863933, 8453.915460845436, 8546.829063418696, 8498.830023399498, 8561.015483219386, 8609.0, 8688.087750786202, 8696.347773916981, 4005.379166229239, 4042.6159514846045, 4338.501072376717, 4445.688801783844, 4527.818887244539, 1614.8142963559342, 1623.415570394657, 1659.7012537743321, 1838.6782313095155, 1867.2997625890291, 821.3675469888153, 903.575319599787, 979.7893452907659, 989.8812142542942, 1035.5598870480017, 18058.006809625596, 19709.507262318555, 20066.498337541678, 20650.89674551648, 20761.480962975744, 909.6361455417886, 946.8816397950256, 963.1331801378815, 981.2297346582898, 1003.9247056470793, 10821.67534973952, 11014.39420831862, 11049.28179668319, 11084.889151108548, 11140.220184587, 563383.0, 577195.0, 577401.0, 586584.0, 596639.0, 81667.5916620413, 96734.0, 100805.49597251967, 107051.46474267579, 108757.0, 985.9704208873745, 996.9501524923725, 999.2605471950704, 1021.2851004297022, 1090.1605763562172, 17506.0, 17657.470275891745, 17698.672599554826, 18027.459176224733, 18056.548586285448, 40487.78536643906, 46421.535784641725, 46994.76502617465, 47577.52422475731, 49873.750631246614, 59889.401105990124, 65250.0, 69453.65273173602, 69658.82047077191, 70304.64847675728, 7215.71137154508, 7771.261730135628, 7961.243681850215, 7983.560904150328, 7995.520268783892, 10421.895781042092, 11973.521059157885, 12108.455119519467, 12523.499060037497, 12886.871131288943, 10686.038256556947, 10972.506237219184, 11104.167187461135, 11139.554417823196, 11386.146039047271, 10765.3540787553, 10907.345559266469, 10985.121190304917, 11033.779324413626, 11110.666679999613, 10518.474076296308, 10997.450127493434, 11102.555897764321, 11363.659090227306, 11530.76938461243, 7842.725504607311, 7926.603669816602, 7982.241687039722, 8035.799105022187, 8229.218224268685, 9512.809743804946, 10875.891241087804, 11034.117270618492, 11214.215004949901, 11467.139964502529], "unit": "score", "name": "jquery.html", "value": 9186.149070714646}, {"lowerIsBetter": false, "replicates": [1538.6922615476901, 1543.8842086843488, 1839.9356022539214, 1989.7313862628541, 2014.4359579317795, 7906.644201010954, 8592.441491303061, 8647.308215342773, 8813.250873675745, 8821.33839962003, 8531.91468085319, 8550.973883134016, 8594.011688655806, 8600.569971501416, 8691.043985161627, 2440.5606990741658, 2449.2774631483667, 2449.6325551167333, 2452.141750387368, 2473.678421805163, 2112.225730386475, 2423.4789520253144, 2468.136152346682, 2490.86300253486, 2509.82431229814, 2036.5519585691125, 2470.147799009348, 2476.306634142443, 2498.475320182755, 2514.182890560566, 2467.0880067947305, 2470.4441500662388, 2487.1543675150447, 2494.4262819551514, 2497.5379554782335, 2463.224084413404, 2464.4208610976407, 2469.0494159748628, 2471.0733474946896, 2487.315988103286, 8737.7815554611, 8800.251978581828, 8839.116088391174, 8845.4250473719, 8862.645494180226, 5343.973280133574, 5386.245925570423, 5417.83746487606, 5472.50747432733, 5589.692566908819, 3573.1424458130123, 3622.945655815165, 3655.6161603031833, 3701.7223708221723, 3730.682891954187, 1020.117598277492, 1035.2080658296409, 1039.2828948025913, 1041.6718733598968, 1042.6246551241622, 10105.797884042351, 11821.527138914518, 12011.579594714143, 12028.458719357563, 12132.908038276597, 4772.976135119302, 4787.880302992453, 4800.5199480052415, 4884.145274576935, 4893.168161412497, 10022.899771002343, 10134.442605656759, 10150.441725705157, 10180.0, 10207.336523125972, 5321.122014867504, 5343.839684809462, 5344.251804747339, 5382.596305277119, 5448.237246785453, 4426.579474949875, 4807.78364973577, 4848.442429120696, 4859.271109333628, 4956.182229932093, 3847.2305538892333, 3894.201688653819, 3940.862069827542, 3942.8817135485983, 3967.7222594418113, 1170.9707257318635, 1334.0728193905143, 1335.5859683497952, 1347.3802051056427, 1353.8916886649044, 1330.6872884872048, 1342.7717288061053, 1364.2292104960666, 1377.669359353748, 1417.4755340524073, 7966.0, 8092.028956525254, 8162.979627546557, 8172.060213075453, 8185.549794761345, 489.49826427910966, 504.94950504949946, 506.6149726208108, 511.10046318479743, 513.3249776543832, 6001.729922153513, 6093.903097442414, 6159.476444502178, 6229.283632382243, 6234.220722409699, 10233.94883025595, 10448.0, 10461.895381046244, 10470.685879423629, 10491.580336786596, 8500.27747641445, 10130.392176469435, 10131.848022279672, 10372.792544149226, 10455.372677639367, 8173.019237691515, 8289.544075075808, 8307.750767476986, 8317.792055198548, 8389.622466989, 7833.686652534063, 8014.559199244098, 8057.395695322992, 8082.919170808216, 8237.423380363556, 9422.387544809566, 9458.290628202774, 9578.563215517728, 9667.371620844622, 9711.0, 9780.608775648894, 9787.0, 9883.258755593215, 10008.499575021075, 10018.998100189923, 6768.390844823989, 7209.134903811576, 7459.328660420588, 7495.812604684927, 7635.618219088912, 8076.434649574473, 8203.876941845996, 8245.051819040647, 8305.127961563949, 8340.165983401854, 6892.586444813327, 7268.055152830098, 7291.161516425679, 7371.631418429164, 7529.0212272406425, 6098.847528811815, 7205.855882882418, 7241.91371294289, 7273.836186210181, 7439.99560059385, 7679.654415551202, 7706.422018348534, 7751.534907905544, 7775.727849525466, 7805.687772489036, 6941.3058694132205, 6942.271061538466, 6969.860602787814, 7013.8246543834775, 7043.225245223124, 5727.31272247333, 7060.1880783708475, 7212.963935180291, 7249.0, 7250.9637451812405], "unit": "score", "name": "mootools.html", "value": 4824.5102951802255}, {"lowerIsBetter": false, "replicates": [300.7248367743515, 326.76309675485277, 328.90297362278125, 329.67414887965396, 335.88653613272004, 5295.867603309909, 6616.908210145326, 6669.966650166754, 6685.0640910272605, 6704.161979752531, 5640.717964101799, 6433.035044743279, 6602.2737498875085, 6639.136912201419, 6666.266710661824, 4626.4910859805395, 4753.572178503934, 4840.709557426548, 4855.5387238212315, 4866.51334866514, 4085.8569950051756, 4714.656322947943, 4848.830290939818, 4855.732934688591, 4871.464138944713, 4163.521195062576, 4651.255799072149, 4779.856604301876, 4791.2094504406905, 4813.205821039524, 4366.388705581221, 4883.877903052435, 4896.779644915988, 4901.289313049606, 4904.141775189363, 3857.305684976703, 4186.35111557709, 4191.538930717618, 4205.5794420557695, 4208.3687446882905, 6028.728707208186, 6437.420632143129, 6456.999165129366, 6458.160439142928, 6480.963045912678, 4334.371516130143, 5614.157876318544, 5675.914861277084, 5687.544996400319, 5776.393478684719, 7068.18715847679, 7114.537555058904, 7126.429885609139, 7127.679254433563, 7135.143782746104, 4571.6114130298965, 4584.220682483986, 4586.4266966629175, 4593.63250939924, 4599.931001034987, 6525.82535143674, 7098.148222213315, 7442.0, 7538.698452061966, 7541.77374678755, 4487.169873573399, 4626.74552899587, 4633.443986721548, 4638.930416043762, 4673.649476289292, 4712.69367491112, 4741.905161896742, 4760.404949381327, 4766.142094423037, 4770.0, 5663.716814159276, 5664.575156863251, 5669.837683274919, 5677.659340439587, 5683.829485115453, 7130.3939165170505, 7172.28277172289, 7173.390261827803, 7179.138503379628, 7189.1013623297085, 1616.870650347993, 1649.2001379331016, 1653.925573349202, 1654.8427899349542, 1655.7433597792362, 773.7137259214127, 997.3417544420647, 998.940063596172, 1044.300318786415, 1061.8301071828625, 6572.244191917991, 6642.83392915181, 6644.169478815148, 6651.135352404156, 6706.161729783777, 7380.077490313711, 7416.480846340704, 7428.702851885864, 7434.925650743531, 7448.664810083451, 6459.192600924885, 6499.0, 6708.362705542965, 6739.157605299338, 6759.459243260528, 3905.2189562087697, 3945.921081578352, 3951.7628942263555, 3954.9011274717786, 3957.248122856648, 7768.184340644264, 7782.883256751154, 7807.68769249235, 7815.53106813593, 7828.452008359474, 7414.480986330905, 7677.692892284358, 7689.346405555479, 7694.230576942373, 7739.071311442551, 7764.495307804975, 7776.92223077762, 7795.727149549852, 7807.68769249235, 7816.716978868889, 6485.735281620227, 6626.933730662631, 7447.143578488326, 7449.0316258886, 7489.363404110712, 7323.048003759477, 7329.083864516935, 7337.669804858688, 7347.632618369167, 7354.889676654748, 7471.17817040136, 7785.961070194613, 7813.921860781319, 7824.139344672195, 7826.373890088666, 4341.848035318749, 4421.845235416745, 4663.137319595886, 4663.323818046297, 4673.369095172108, 6021.488173505126, 7415.1101867776215, 7441.590712510864, 7449.329560339595, 7450.739224127129, 7179.03083083777, 7182.748603798842, 7216.927830721836, 7224.494285400182, 7226.458015648742, 5711.400302968294, 6041.486473649789, 6916.792496225121, 7190.568565886064, 7241.746538871114, 6966.5471744336455, 7025.367716905503, 7025.613591252326, 7030.578165310098, 7037.1555413350725, 7173.246809084971, 7191.460640451883, 7198.028266183998, 7209.927900721135, 7261.164966028974, 5069.797208111634, 6413.839654008687, 7020.333068358498, 7037.824054398477, 7053.224145343906], "unit": "score", "name": "prototype.html", "value": 5140.49041445485}, {"lowerIsBetter": false, "replicates": [681.8397676546011, 727.1891840597729, 746.1046743907311, 762.2034973452742, 794.217695569864, 14392.208428536427, 14460.638484037905, 14559.126452412862, 14582.708345833076, 14670.04644698094, 13647.45410183594, 15437.845621543782, 15847.445339413123, 15869.92065039676, 15878.603034924132, 904.8099899021213, 908.6683360573393, 911.1071150272737, 912.0788004115824, 915.9908400916006, 743.5167141358106, 886.4149661223562, 891.4873947480193, 912.2975309012056, 921.4379228670506, 938.1087966431883, 938.7183844846519, 972.8443449048153, 974.142754376148, 978.0854900667863, 932.3520153493325, 943.4339396362196, 957.9329446938717, 966.3284017607765, 967.5307475874231, 696.5611664651288, 697.0276464332279, 697.3166297028889, 697.553565717941, 715.7172916697928, 14831.332590033475, 14891.553253402415, 14893.553193404216, 15056.0, 15134.243287835674, 12170.756584868253, 12405.255684658949, 12439.75120497585, 12598.748025039447, 12700.555480558229, 9855.90144098557, 9879.506024698736, 9913.454759988197, 10248.38509689421, 10636.0, 3338.098713347407, 3402.727781777452, 3455.6026057003514, 3558.2705545363137, 3578.731595130376, 84570.0, 84953.57523212345, 85552.57223713842, 86291.0, 86311.56844215738, 9060.909390906007, 9133.77165570866, 9239.399439036575, 9298.814023719622, 9338.299627527962, 16960.57598560046, 18840.905795470935, 20519.17923283052, 20857.68713469299, 20857.791422085887, 6459.708058388341, 7130.572165670076, 7241.674124664402, 7263.709451621981, 7562.205968373351, 3986.461827653288, 4024.657904078186, 4030.5364883038824, 4031.274370613259, 4033.153037862082, 2967.3768508613, 3563.768355056913, 3622.1487950331652, 3626.0934766308424, 3632.164602141522, 654.6268626882727, 660.4848218389664, 660.5079215984123, 670.2727540618483, 675.0212192321154, 538.6014349381429, 595.4521839907296, 616.1558664629487, 618.4557589321458, 619.3465893482329, 7964.840703185904, 8154.2253485918745, 8273.420860539705, 8368.288695460955, 8464.703735369232, 459.90571932753704, 560.2240896358572, 594.560025581067, 606.0245385385942, 614.5680564285204, 2976.427094927636, 3829.7702137871815, 3850.0374906273432, 3855.9228815423535, 3881.2819628368843, 84321.0, 89014.0, 89562.55218723865, 93474.0, 93630.0, 74148.0, 75503.48993020218, 76129.0, 76879.0, 77659.0, 62783.0, 64001.0, 64736.02895956564, 66649.0, 68204.6589767048, 6854.725810967506, 7369.8526029478035, 7525.17223105447, 7558.962205188939, 7623.504472209289, 48442.5155748438, 49006.754966224944, 49580.00839983252, 50320.74839625925, 51686.48313516967, 59249.0, 63064.0, 65653.67173164104, 68550.28624284433, 69765.30234697588, 10649.094826939798, 10799.67600971972, 10894.0, 11171.273867198606, 11560.0, 9963.551640176065, 12095.274283543016, 12199.0, 12444.020299320813, 12486.063545233963, 11239.325640461599, 11411.885881141414, 11578.36319002463, 11799.705007374885, 11960.46177922013, 10043.899561004297, 10666.89333106659, 11674.357910314675, 11713.062954963752, 12000.459979301128, 11078.169137314895, 11206.439678015904, 11244.26912250701, 11259.042981346678, 11403.486843091914, 9122.251906687834, 9231.399959002643, 9406.81186376255, 9625.663101791684, 9718.12536871685, 9076.636934522545, 9633.277504187354, 9671.951640241754, 9674.951625241829, 9684.903150968681], "unit": "score", "name": "yui.html", "value": 6826.932334886096}], "name": "dromaeo_css", "value": 7414.955027813341}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 115.0, 115.0, 113.0, 126.0, 116.0, 126.0, 166.0, 169.0], "unit": "score", "name": "ai-astar", "value": 126.7}, {"lowerIsBetter": true, "replicates": [162.0, 126.0, 146.0, 157.0, 126.0, 146.0, 138.0, 196.0, 189.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [196.0, 194.0, 224.0, 267.0, 265.0, 211.0, 195.0, 278.0, 252.0, 205.0], "unit": "score", "name": "audio-dft", "value": 228.7}, {"lowerIsBetter": true, "replicates": [66.0, 77.0, 76.0, 115.0, 67.0, 82.0, 86.0, 79.0, 124.0, 57.0], "unit": "score", "name": "audio-fft", "value": 82.9}, {"lowerIsBetter": true, "replicates": [76.0, 108.0, 106.0, 81.0, 117.0, 65.0, 149.0, 120.0, 116.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [110.0, 86.0, 76.0, 76.0, 79.0, 114.0, 133.0, 107.0, 90.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.9}, {"lowerIsBetter": true, "replicates": [94.0, 105.0, 131.0, 96.0, 131.0, 112.0, 145.0, 150.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 115.3}, {"lowerIsBetter": true, "replicates": [116.0, 140.0, 149.0, 94.0, 153.0, 145.0, 117.0, 92.0, 132.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 122.6}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 55.0, 58.0, 58.0, 58.0, 57.0, 66.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [67.0, 92.0, 110.0, 67.0, 82.0, 73.0, 72.0, 70.0, 69.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.4}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 89.0, 87.0, 103.0, 73.0, 79.0, 77.0, 82.0, 74.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [134.0, 143.0, 110.0, 140.0, 133.0, 137.0, 139.0, 135.0, 133.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.9}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 150.0, 143.0, 145.0, 146.0, 182.0, 157.0, 139.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 66.0, 67.0, 67.0, 89.0, 91.0, 92.0, 94.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.7}], "name": "kraken", "value": 1610.1000000000004}]} 04:58:26 INFO - Return code: 0 04:58:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:58:26 ERROR - # TBPL SUCCESS # 04:58:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:26 INFO - 2016-04-07 04:58:26.246 screenresolution[2002:14222] starting screenresolution argv=screenresolution get 04:58:26 INFO - 2016-04-07 04:58:26.249 screenresolution[2002:14222] Display 0: 1600x1200x32@60 04:58:26 INFO - 2016-04-07 04:58:26.256 screenresolution[2003:14225] starting screenresolution argv=screenresolution list 04:58:26 INFO - Available Modes on Display 0 04:58:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:26 INFO - Intel Iris: 04:58:26 INFO - Chipset Model: Intel Iris 04:58:26 INFO - Type: GPU 04:58:26 INFO - Bus: Built-In 04:58:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:26 INFO - Vendor: Intel (0x8086) 04:58:26 INFO - Device ID: 0x0a2e 04:58:26 INFO - Revision ID: 0x0009 04:58:26 INFO - Displays: 04:58:26 INFO - Display: 04:58:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:26 INFO - Display Serial Number: 1600x1200 60 04:58:26 INFO - Main Display: Yes 04:58:26 INFO - Mirror: Off 04:58:26 INFO - Online: Yes 04:58:26 INFO - Rotation: Supported 04:58:26 INFO - Return code: 0 04:58:26 INFO - Running post-action listener: _resource_record_post_action 04:58:26 INFO - Running post-run listener: _resource_record_post_run 04:58:27 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 77824; Write bytes: 695980544; Read time: 2; Write time: 2338 04:58:27 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 387932672; Write bytes: 381326848; Read time: 28539; Write time: 690 04:58:27 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 73728; Write bytes: 299877888; Read time: 2; Write time: 1524 04:58:27 INFO - Running post-run listener: _upload_blobber_files 04:58:27 INFO - Blob upload gear active. 04:58:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:27 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 04:58:27 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'] 04:58:27 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 04:58:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:29 INFO - (blobuploader) - INFO - Done attempting. 04:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:30 INFO - (blobuploader) - INFO - Done attempting. 04:58:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:30 INFO - Return code: 0 04:58:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719b0fb209fa19479f34075cb693918b25186bd5d4fa0d4c24f09208edd59dcee3fb9ef46054de889752344e83f46779026954a92bd4d0a5a5a7f4dda97ae730", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47857a0cb62c6d8dfdf40f913d58dd5ddd923f73398c019a345978025dc2a7039c9d5d5efe585a6fb7574f6d4b440b6bb373bd7ff1864e5dbcb860ddf90f0c83"} 04:58:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:30 INFO - Contents: 04:58:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719b0fb209fa19479f34075cb693918b25186bd5d4fa0d4c24f09208edd59dcee3fb9ef46054de889752344e83f46779026954a92bd4d0a5a5a7f4dda97ae730", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47857a0cb62c6d8dfdf40f913d58dd5ddd923f73398c019a345978025dc2a7039c9d5d5efe585a6fb7574f6d4b440b6bb373bd7ff1864e5dbcb860ddf90f0c83"} 04:58:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:30 INFO - Copying logs to upload dir... 04:58:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.081102 ========= master_lag: 4.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-04-07 04:58:34.115330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-07 04:58:34.123005) ========= 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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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/719b0fb209fa19479f34075cb693918b25186bd5d4fa0d4c24f09208edd59dcee3fb9ef46054de889752344e83f46779026954a92bd4d0a5a5a7f4dda97ae730", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47857a0cb62c6d8dfdf40f913d58dd5ddd923f73398c019a345978025dc2a7039c9d5d5efe585a6fb7574f6d4b440b6bb373bd7ff1864e5dbcb860ddf90f0c83"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011498 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719b0fb209fa19479f34075cb693918b25186bd5d4fa0d4c24f09208edd59dcee3fb9ef46054de889752344e83f46779026954a92bd4d0a5a5a7f4dda97ae730", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47857a0cb62c6d8dfdf40f913d58dd5ddd923f73398c019a345978025dc2a7039c9d5d5efe585a6fb7574f6d4b440b6bb373bd7ff1864e5dbcb860ddf90f0c83"}' ========= master_lag: 2.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-07 04:58:36.480161) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:58:36.480466) ========= 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.mmKAW6g9Dv/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.hqUxf7DPJN/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005107 ========= master_lag: 0.23 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:58:36.713283) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2016-04-07 04:58:36.713551) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2016-04-07 04:58:42.748091) ========= ========= Total master_lag: 47.60 =========