builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0021 starttime: 1447287644.22 results: success (0) buildid: 20151111143931 builduid: 71dfd44a22eb43929456b6ee85e31b61 revision: c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:44.222306) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:44.222803) ========= ========= Started set props: basedir (results: 0, elapsed: 3 secs) (at 2015-11-11 16:20:44.223104) ========= 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.4YYhmWRWNe/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.y27H4j4G1H/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006782 basedir: '/builds/slave/test' ========= master_lag: 3.79 ========= ========= Finished set props: basedir (results: 0, elapsed: 3 secs) (at 2015-11-11 16:20:48.016741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.017198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.043471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.045650) ========= 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.4YYhmWRWNe/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.y27H4j4G1H/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005721 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.095562) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.098957) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.099339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.099639) ========= 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.4YYhmWRWNe/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.y27H4j4G1H/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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:0x0:0x0 using PTY: False --2015-11-11 16:20:48-- 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.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% 7.51M=0.002s 2015-11-11 16:20:48 (7.51 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.412776 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.528755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.529122) ========= 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.4YYhmWRWNe/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.y27H4j4G1H/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.022582 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:48.585778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 16:20:48.586323) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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:0x0:0x0 using PTY: False 2015-11-11 16:20:48,674 truncating revision to first 12 chars 2015-11-11 16:20:48,675 Setting DEBUG logging. 2015-11-11 16:20:48,675 attempt 1/10 2015-11-11 16:20:48,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c5780f2a10e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 16:20:49,341 unpacking tar archive at: mozilla-inbound-c5780f2a10e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.099266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 16:20:49.704279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:49.704644) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:49.719704) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:49.720087) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 16:20:49.720574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-11 16:20:49.720957) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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:0x0:0x0 using PTY: False 16:20:49 INFO - MultiFileLogger online at 20151111 16:20:49 in /builds/slave/test 16:20:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:20:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:20:49 INFO - {'append_to_log': False, 16:20:49 INFO - 'base_work_dir': '/builds/slave/test', 16:20:49 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:20:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:20:49 INFO - 'branch': 'Mozilla-Inbound', 16:20:49 INFO - 'buildbot_json_path': 'buildprops.json', 16:20:49 INFO - 'config_files': ('talos/mac_config.py',), 16:20:49 INFO - 'default_actions': ('clobber', 16:20:49 INFO - 'read-buildbot-config', 16:20:49 INFO - 'download-and-extract', 16:20:49 INFO - 'populate-webroot', 16:20:49 INFO - 'create-virtualenv', 16:20:49 INFO - 'install', 16:20:49 INFO - 'run-tests'), 16:20:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:20:49 INFO - 'download_minidump_stackwalk': True, 16:20:49 INFO - 'download_symbols': 'ondemand', 16:20:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:20:49 INFO - 'tooltool.py': '/tools/tooltool.py', 16:20:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:20:49 INFO - '/tools/misc-python/virtualenv.py')}, 16:20:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:20:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:20:49 INFO - 'installer_path': 'installer.exe', 16:20:49 INFO - 'log_level': 'info', 16:20:49 INFO - 'log_name': 'talos', 16:20:49 INFO - 'log_to_console': True, 16:20:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:20:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:20:49 INFO - 'opt_config_files': (), 16:20:49 INFO - 'pip_index': False, 16:20:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:20:49 INFO - 'cmd': ('bash', 16:20:49 INFO - '-c', 16:20:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:20:49 INFO - 'enabled': True, 16:20:49 INFO - 'halt_on_failure': False, 16:20:49 INFO - 'name': 'check_screen_resolution'},), 16:20:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:20:49 INFO - 'cmd': ('bash', 16:20:49 INFO - '-c', 16:20:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:20:49 INFO - 'enabled': True, 16:20:49 INFO - 'halt_on_failure': False, 16:20:49 INFO - 'name': 'check_screen_resolution'},), 16:20:49 INFO - 'run_cmd_checks_enabled': True, 16:20:49 INFO - 'sps_profile': False, 16:20:49 INFO - 'sps_profile_interval': 0, 16:20:49 INFO - 'suite': 'dromaeojs', 16:20:49 INFO - 'system_bits': '64', 16:20:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:20:49 INFO - 'title': 't-yosemite-r5-0021', 16:20:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:20:49 INFO - 'use_talos_json': True, 16:20:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:20:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:20:49 INFO - 'work_dir': 'build'} 16:20:49 INFO - ##### 16:20:49 INFO - ##### Running clobber step. 16:20:49 INFO - ##### 16:20:49 INFO - Running pre-action listener: _resource_record_pre_action 16:20:49 INFO - Running main action method: clobber 16:20:49 INFO - rmtree: /builds/slave/test/build 16:20:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:20:51 INFO - Running post-action listener: _resource_record_post_action 16:20:51 INFO - ##### 16:20:51 INFO - ##### Running read-buildbot-config step. 16:20:51 INFO - ##### 16:20:51 INFO - Running pre-action listener: _resource_record_pre_action 16:20:51 INFO - Running main action method: read_buildbot_config 16:20:51 INFO - Using buildbot properties: 16:20:51 INFO - { 16:20:51 INFO - "properties": { 16:20:51 INFO - "buildnumber": 3125, 16:20:51 INFO - "product": "firefox", 16:20:51 INFO - "script_repo_revision": "production", 16:20:51 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 16:20:51 INFO - "repository": "", 16:20:51 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 16:20:51 INFO - "buildid": "20151111143931", 16:20:51 INFO - "slavename": "t-yosemite-r5-0021", 16:20:51 INFO - "pgo_build": "False", 16:20:51 INFO - "basedir": "/builds/slave/test", 16:20:51 INFO - "project": "", 16:20:51 INFO - "platform": "yosemite", 16:20:51 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:20:51 INFO - "slavebuilddir": "test", 16:20:51 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 16:20:51 INFO - "branch": "mozilla-inbound", 16:20:51 INFO - "repo_path": "integration/mozilla-inbound", 16:20:51 INFO - "stage_platform": "macosx64", 16:20:51 INFO - "builduid": "71dfd44a22eb43929456b6ee85e31b61", 16:20:51 INFO - "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5" 16:20:51 INFO - }, 16:20:51 INFO - "sourcestamp": { 16:20:51 INFO - "repository": "", 16:20:51 INFO - "hasPatch": false, 16:20:51 INFO - "project": "", 16:20:51 INFO - "branch": "mozilla-inbound-macosx64-talos", 16:20:51 INFO - "changes": [ 16:20:51 INFO - { 16:20:51 INFO - "category": null, 16:20:51 INFO - "files": [ 16:20:51 INFO - { 16:20:51 INFO - "url": null, 16:20:51 INFO - "name": "https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:20:51 INFO - } 16:20:51 INFO - ], 16:20:51 INFO - "repository": "", 16:20:51 INFO - "rev": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5", 16:20:51 INFO - "who": "tnikkel@gmail.com", 16:20:51 INFO - "when": 1447287576, 16:20:51 INFO - "number": 6651094, 16:20:51 INFO - "comments": "Bug 1223639. Rename ForceInside to MoveInsideAndClamp so it's clearer what it does. r=botond\n\nThis has led to confusion at least twice.", 16:20:51 INFO - "project": "", 16:20:51 INFO - "at": "Wed 11 Nov 2015 16:19:36", 16:20:51 INFO - "branch": "mozilla-inbound-macosx64-talos", 16:20:51 INFO - "revlink": "", 16:20:51 INFO - "properties": [ 16:20:51 INFO - [ 16:20:51 INFO - "buildid", 16:20:51 INFO - "20151111143931", 16:20:51 INFO - "Change" 16:20:51 INFO - ], 16:20:51 INFO - [ 16:20:51 INFO - "builduid", 16:20:51 INFO - "71dfd44a22eb43929456b6ee85e31b61", 16:20:51 INFO - "Change" 16:20:51 INFO - ], 16:20:51 INFO - [ 16:20:51 INFO - "pgo_build", 16:20:51 INFO - "False", 16:20:51 INFO - "Change" 16:20:51 INFO - ] 16:20:51 INFO - ], 16:20:51 INFO - "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5" 16:20:51 INFO - } 16:20:51 INFO - ], 16:20:51 INFO - "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5" 16:20:51 INFO - } 16:20:51 INFO - } 16:20:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:20:51 INFO - Running post-action listener: _resource_record_post_action 16:20:51 INFO - ##### 16:20:51 INFO - ##### Running download-and-extract step. 16:20:51 INFO - ##### 16:20:51 INFO - Running pre-action listener: _resource_record_pre_action 16:20:51 INFO - Running main action method: download_and_extract 16:20:51 INFO - mkdir: /builds/slave/test/build/tests 16:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:51 INFO - https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/test_packages.json 16:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/test_packages.json 16:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:20:52 INFO - Downloaded 1149 bytes. 16:20:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:20:52 INFO - Using the following test package requirements: 16:20:52 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:20:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:20:52 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:20:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:20:52 INFO - u'jsshell-mac.zip'], 16:20:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:20:52 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:20:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:20:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:20:52 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:20:52 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:20:52 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:20:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:20:52 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:20:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:20:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:20:52 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:20:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:20:52 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')]} 16:20:52 INFO - https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:20:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:20:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:20:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:20:53 INFO - Downloaded 17454197 bytes. 16:20:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:20:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:20:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:20:58 INFO - Return code: 0 16:20:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:58 INFO - https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:20:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:20:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:20:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:20:59 INFO - Downloaded 17454197 bytes. 16:20:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:20:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:20:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:21:05 INFO - Return code: 0 16:21:05 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')]} 16:21:05 INFO - https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:21:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:21:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:21:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:21:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:21:07 INFO - Downloaded 11131693 bytes. 16:21:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 16:21:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:21:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:21:07 INFO - Return code: 0 16:21: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')]} 16:21:07 INFO - https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 16:21:11 INFO - Downloaded 108691253 bytes. 16:21:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:21:11 INFO - mkdir: /builds/slave/test/properties 16:21:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:11 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:11 INFO - Contents: 16:21:11 INFO - build_url:https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:21:11 INFO - Running post-action listener: _resource_record_post_action 16:21:11 INFO - Running post-action listener: set_extra_try_arguments 16:21:11 INFO - ##### 16:21:11 INFO - ##### Running populate-webroot step. 16:21:11 INFO - ##### 16:21:11 INFO - Running pre-action listener: _resource_record_pre_action 16:21:11 INFO - Running main action method: populate_webroot 16:21:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:21:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:21:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:21:11 INFO - '../fennec_ids.txt'], 16:21:11 INFO - 'tests': ['tcheck2']}, 16:21:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:21:11 INFO - '--tppagecycles', 16:21:11 INFO - '7'], 16:21:11 INFO - 'tests': ['tsvgm']}}, 16:21:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:21:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:21:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:21:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:21:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:11 INFO - 'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:11 INFO - 'tests': ['damp', 'tps']}, 16:21:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:11 INFO - 'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['damp', 'tps']}, 16:21:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:21:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:11 INFO - 'other': {'tests': ['a11yr', 16:21:11 INFO - 'ts_paint', 16:21:11 INFO - 'tpaint', 16:21:11 INFO - 'sessionrestore', 16:21:11 INFO - 'sessionrestore_no_auto_restore']}, 16:21:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['a11yr', 16:21:11 INFO - 'ts_paint', 16:21:11 INFO - 'tpaint', 16:21:11 INFO - 'sessionrestore', 16:21:11 INFO - 'sessionrestore_no_auto_restore']}, 16:21:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['a11yr', 16:21:11 INFO - 'ts_paint', 16:21:11 INFO - 'tpaint', 16:21:11 INFO - 'sessionrestore', 16:21:11 INFO - 'sessionrestore_no_auto_restore']}, 16:21:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['a11yr', 16:21:11 INFO - 'ts_paint', 16:21:11 INFO - 'tpaint', 16:21:11 INFO - 'sessionrestore', 16:21:11 INFO - 'sessionrestore_no_auto_restore']}, 16:21:11 INFO - 'other_l64': {'tests': ['a11yr', 16:21:11 INFO - 'ts_paint', 16:21:11 INFO - 'tpaint', 16:21:11 INFO - 'sessionrestore', 16:21:11 INFO - 'sessionrestore_no_auto_restore']}, 16:21:11 INFO - 'other_nol64': {'tests': ['a11yr', 16:21:11 INFO - 'ts_paint', 16:21:11 INFO - 'tpaint', 16:21:11 INFO - 'sessionrestore', 16:21:11 INFO - 'sessionrestore_no_auto_restore']}, 16:21:11 INFO - 'svgr': {'tests': ['tsvgx', 16:21:11 INFO - 'tsvgr_opacity', 16:21:11 INFO - 'tart', 16:21:11 INFO - 'tscrollx', 16:21:11 INFO - 'cart']}, 16:21:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['tsvgx', 16:21:11 INFO - 'tsvgr_opacity', 16:21:11 INFO - 'tart', 16:21:11 INFO - 'tscrollx', 16:21:11 INFO - 'cart']}, 16:21:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:11 INFO - 'tests': ['tp5o']}, 16:21:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:11 INFO - 'talos_options': ['--e10s'], 16:21:11 INFO - 'tests': ['tp5o']}, 16:21:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:11 INFO - 'talos_options': ['--xperf_path', 16:21:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:11 INFO - 'tests': ['tp5n']}, 16:21:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:11 INFO - 'talos_options': ['--e10s', 16:21:11 INFO - '--xperf_path', 16:21:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:11 INFO - 'tests': ['tp5n']}}, 16:21:11 INFO - 'talos.zip': {'path': '', 16:21:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:21:11 INFO - Running post-action listener: _resource_record_post_action 16:21:11 INFO - ##### 16:21:11 INFO - ##### Running create-virtualenv step. 16:21:11 INFO - ##### 16:21:11 INFO - Running pre-action listener: _resource_record_pre_action 16:21:11 INFO - Running main action method: create_virtualenv 16:21:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:11 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 16:21:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:21:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:11 INFO - Using real prefix '/tools/python27' 16:21:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:16 INFO - Installing pip.................done. 16:21:16 INFO - Return code: 0 16:21:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10f0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e854a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efce9f0>, '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 0x10ed2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/Render', 16:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:16 INFO - 'HOME': '/Users/cltbld', 16:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:16 INFO - 'LOGNAME': 'cltbld', 16:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:16 INFO - 'MOZ_NO_REMOTE': '1', 16:21:16 INFO - 'NO_EM_RESTART': '1', 16:21:16 INFO - 'PAGER': '/bin/cat', 16:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:16 INFO - 'PWD': '/builds/slave/test', 16:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:16 INFO - 'SHELL': '/bin/bash', 16:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y27H4j4G1H/Listeners', 16:21:16 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 16:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:16 INFO - 'USER': 'cltbld', 16:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:16 INFO - 'XPC_FLAGS': '0x0', 16:21:16 INFO - 'XPC_SERVICE_NAME': '0', 16:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:16 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 16:21:16 INFO - Cleaning up... 16:21:16 INFO - Return code: 0 16:21:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10f0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e854a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efce9f0>, '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 0x10ed2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/Render', 16:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:16 INFO - 'HOME': '/Users/cltbld', 16:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:16 INFO - 'LOGNAME': 'cltbld', 16:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:16 INFO - 'MOZ_NO_REMOTE': '1', 16:21:16 INFO - 'NO_EM_RESTART': '1', 16:21:16 INFO - 'PAGER': '/bin/cat', 16:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:16 INFO - 'PWD': '/builds/slave/test', 16:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:16 INFO - 'SHELL': '/bin/bash', 16:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y27H4j4G1H/Listeners', 16:21:16 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 16:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:16 INFO - 'USER': 'cltbld', 16:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:16 INFO - 'XPC_FLAGS': '0x0', 16:21:16 INFO - 'XPC_SERVICE_NAME': '0', 16:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:17 INFO - Downloading/unpacking psutil>=0.7.1 16:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:21:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:21:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:20 INFO - Installing collected packages: psutil 16:21:20 INFO - Running setup.py install for psutil 16:21:20 INFO - building 'psutil._psutil_osx' extension 16:21:20 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 16:21:20 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 16:21:20 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 16:21:20 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 16:21:20 INFO - building 'psutil._psutil_posix' extension 16:21:20 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 16:21:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:21:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:21:20 INFO - ^ 16:21:21 INFO - 1 warning generated. 16:21:21 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 16:21:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:21 INFO - Successfully installed psutil 16:21:21 INFO - Cleaning up... 16:21:21 INFO - Return code: 0 16:21:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:21:21 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')]} 16:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:21 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')]} 16:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10f0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e854a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efce9f0>, '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 0x10ed2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:21:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/Render', 16:21:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:21 INFO - 'HOME': '/Users/cltbld', 16:21:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:21 INFO - 'LOGNAME': 'cltbld', 16:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:21 INFO - 'MOZ_NO_REMOTE': '1', 16:21:21 INFO - 'NO_EM_RESTART': '1', 16:21:21 INFO - 'PAGER': '/bin/cat', 16:21:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:21 INFO - 'PWD': '/builds/slave/test', 16:21:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:21 INFO - 'SHELL': '/bin/bash', 16:21:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y27H4j4G1H/Listeners', 16:21:21 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 16:21:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:21 INFO - 'USER': 'cltbld', 16:21:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:21 INFO - 'XPC_FLAGS': '0x0', 16:21:21 INFO - 'XPC_SERVICE_NAME': '0', 16:21:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:21:21 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 16:21:21 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 16:21:21 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 16:21:21 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 16:21:21 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 16:21:21 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 16:21:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:21:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:21:24 INFO - Installing collected packages: mozsystemmonitor 16:21:24 INFO - Running setup.py install for mozsystemmonitor 16:21:24 INFO - Successfully installed mozsystemmonitor 16:21:24 INFO - Cleaning up... 16:21:24 INFO - Return code: 0 16:21:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21: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')]} 16:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10f0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e854a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efce9f0>, '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 0x10ed2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/Render', 16:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:24 INFO - 'HOME': '/Users/cltbld', 16:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:24 INFO - 'LOGNAME': 'cltbld', 16:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:24 INFO - 'MOZ_NO_REMOTE': '1', 16:21:24 INFO - 'NO_EM_RESTART': '1', 16:21:24 INFO - 'PAGER': '/bin/cat', 16:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:24 INFO - 'PWD': '/builds/slave/test', 16:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:24 INFO - 'SHELL': '/bin/bash', 16:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y27H4j4G1H/Listeners', 16:21:24 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 16:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:24 INFO - 'USER': 'cltbld', 16:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:24 INFO - 'XPC_FLAGS': '0x0', 16:21:24 INFO - 'XPC_SERVICE_NAME': '0', 16:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:25 INFO - Downloading/unpacking blobuploader==1.2.4 16:21:25 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 16:21:25 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 16:21:25 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 16:21:25 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 16:21:25 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 16:21:25 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 16:21:27 INFO - Downloading blobuploader-1.2.4.tar.gz 16:21:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:21:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:21:27 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 16:21:27 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 16:21:27 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 16:21:27 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 16:21:27 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 16:21:27 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 16:21:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:21:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:29 INFO - Downloading docopt-0.6.1.tar.gz 16:21:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:21:29 INFO - Installing collected packages: blobuploader, requests, docopt 16:21:29 INFO - Running setup.py install for blobuploader 16:21:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:21:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:21:29 INFO - Running setup.py install for requests 16:21:30 INFO - Running setup.py install for docopt 16:21:30 INFO - Successfully installed blobuploader requests docopt 16:21:30 INFO - Cleaning up... 16:21:30 INFO - Return code: 0 16:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10f0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e854a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efce9f0>, '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 0x10ed2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 16:21:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/Render', 16:21:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:30 INFO - 'HOME': '/Users/cltbld', 16:21:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:30 INFO - 'LOGNAME': 'cltbld', 16:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:30 INFO - 'MOZ_NO_REMOTE': '1', 16:21:30 INFO - 'NO_EM_RESTART': '1', 16:21:30 INFO - 'PAGER': '/bin/cat', 16:21:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:30 INFO - 'PWD': '/builds/slave/test', 16:21:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:30 INFO - 'SHELL': '/bin/bash', 16:21:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y27H4j4G1H/Listeners', 16:21:30 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 16:21:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:30 INFO - 'USER': 'cltbld', 16:21:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:30 INFO - 'XPC_FLAGS': '0x0', 16:21:30 INFO - 'XPC_SERVICE_NAME': '0', 16:21:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:30 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-rwhAvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:31 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-AUNbkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:31 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-uppAI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:31 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-PnxXPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:31 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-DkCgzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:31 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-K2wCjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:31 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-VnF8_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:31 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-YY1RoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:31 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-eBvvs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:32 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-T4cdhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:32 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-M7K72V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:32 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-OEcN7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:32 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-cTMcPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:32 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-8W05zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:32 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-ndoJzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:32 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-9vFmKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:33 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-LlyOij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:21:33 INFO - Running setup.py install for manifestparser 16:21:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:21:33 INFO - Running setup.py install for mozcrash 16:21:33 INFO - Running setup.py install for mozdebug 16:21:33 INFO - Running setup.py install for mozdevice 16:21:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:21:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:21:34 INFO - Running setup.py install for mozfile 16:21:34 INFO - Running setup.py install for mozhttpd 16:21:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:21:34 INFO - Running setup.py install for mozinfo 16:21:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:21:34 INFO - Running setup.py install for mozInstall 16:21:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:21:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:21:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:21:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:21:34 INFO - Running setup.py install for mozleak 16:21:34 INFO - Running setup.py install for mozlog 16:21:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:21:35 INFO - Running setup.py install for moznetwork 16:21:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:21:35 INFO - Running setup.py install for mozprocess 16:21:35 INFO - Running setup.py install for mozprofile 16:21:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:21:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:21:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:21:35 INFO - Running setup.py install for mozrunner 16:21:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:21:36 INFO - Running setup.py install for mozscreenshot 16:21:36 INFO - Running setup.py install for moztest 16:21:36 INFO - Running setup.py install for mozversion 16:21:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:21:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:21:36 INFO - Cleaning up... 16:21:36 INFO - Return code: 0 16:21:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10f0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e854a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efce9f0>, '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 0x10ed2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/Render', 16:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:36 INFO - 'HOME': '/Users/cltbld', 16:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:36 INFO - 'LOGNAME': 'cltbld', 16:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:36 INFO - 'MOZ_NO_REMOTE': '1', 16:21:36 INFO - 'NO_EM_RESTART': '1', 16:21:36 INFO - 'PAGER': '/bin/cat', 16:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:36 INFO - 'PWD': '/builds/slave/test', 16:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:36 INFO - 'SHELL': '/bin/bash', 16:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y27H4j4G1H/Listeners', 16:21:36 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 16:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:36 INFO - 'USER': 'cltbld', 16:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:36 INFO - 'XPC_FLAGS': '0x0', 16:21:36 INFO - 'XPC_SERVICE_NAME': '0', 16:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:37 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-PeNvq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:37 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)) 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:37 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-wdsqJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:37 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-Of8FC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:37 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)) 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:37 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-UY5ltz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:37 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-sS7MZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:37 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)) 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:37 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-IqcXvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:37 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)) 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:37 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-EeTehV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:38 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)) 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:38 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-DQRoib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:38 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)) 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:38 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-WV6lfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:38 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)) 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:38 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-X4SC_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:38 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-_X7SxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:38 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)) 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:38 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-Gm8G65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:38 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)) 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:38 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-cRqA8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:38 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-dUO3qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:39 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-Gjy5v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:39 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-B93Aw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:39 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)) 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:39 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-SGzYlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:39 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)) 16:21:39 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:21:39 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:21:39 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)) 16:21:39 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:21:39 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:21:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:42 INFO - Downloading blessings-1.5.1.tar.gz 16:21:42 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:21:42 INFO - Installing collected packages: blessings 16:21:42 INFO - Running setup.py install for blessings 16:21:42 INFO - Successfully installed blessings 16:21:42 INFO - Cleaning up... 16:21:42 INFO - Return code: 0 16:21:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:43 INFO - Reading from file tmpfile_stdout 16:21:43 INFO - Current package versions: 16:21:43 INFO - blessings == 1.5.1 16:21:43 INFO - blobuploader == 1.2.4 16:21:43 INFO - docopt == 0.6.1 16:21:43 INFO - manifestparser == 1.1 16:21:43 INFO - mozInstall == 1.12 16:21:43 INFO - mozcrash == 0.16 16:21:43 INFO - mozdebug == 0.1 16:21:43 INFO - mozdevice == 0.47 16:21:43 INFO - mozfile == 1.2 16:21:43 INFO - mozhttpd == 0.7 16:21:43 INFO - mozinfo == 0.9 16:21:43 INFO - mozleak == 0.1 16:21:43 INFO - mozlog == 3.0 16:21:43 INFO - moznetwork == 0.27 16:21:43 INFO - mozprocess == 0.22 16:21:43 INFO - mozprofile == 0.27 16:21:43 INFO - mozrunner == 6.11 16:21:43 INFO - mozscreenshot == 0.1 16:21:43 INFO - mozsystemmonitor == 0.0 16:21:43 INFO - moztest == 0.7 16:21:43 INFO - mozversion == 1.4 16:21:43 INFO - psutil == 3.1.1 16:21:43 INFO - requests == 1.2.3 16:21:43 INFO - wsgiref == 0.1.2 16:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:43 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')]} 16:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:43 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')]} 16:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10f0ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f088228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2e854a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efce9f0>, '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 0x10ed2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/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.y27H4j4G1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 16:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 16:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/Render', 16:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:43 INFO - 'HOME': '/Users/cltbld', 16:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:43 INFO - 'LOGNAME': 'cltbld', 16:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:43 INFO - 'MOZ_NO_REMOTE': '1', 16:21:43 INFO - 'NO_EM_RESTART': '1', 16:21:43 INFO - 'PAGER': '/bin/cat', 16:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:43 INFO - 'PWD': '/builds/slave/test', 16:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:43 INFO - 'SHELL': '/bin/bash', 16:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y27H4j4G1H/Listeners', 16:21:43 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 16:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:43 INFO - 'USER': 'cltbld', 16:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:43 INFO - 'XPC_FLAGS': '0x0', 16:21:43 INFO - 'XPC_SERVICE_NAME': '0', 16:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:43 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 1)) 16:21:43 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 2)) 16:21:43 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 3)) 16:21:43 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 4)) 16:21:43 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 5)) 16:21:43 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 6)) 16:21:43 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 7)) 16:21:43 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 8)) 16:21:43 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:21:43 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 3)) 16:21:43 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:21:43 INFO - Cleaning up... 16:21:43 INFO - Return code: 0 16:21:43 INFO - Running post-action listener: _resource_record_post_action 16:21:43 INFO - Running post-action listener: _start_resource_monitoring 16:21:43 INFO - Starting resource monitoring. 16:21:43 INFO - ##### 16:21:43 INFO - ##### Running install step. 16:21:43 INFO - ##### 16:21:43 INFO - Running pre-action listener: _resource_record_pre_action 16:21:43 INFO - Running main action method: install 16:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:43 INFO - Reading from file tmpfile_stdout 16:21:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:21:43 INFO - Reading from file tmpfile_stdout 16:21:43 INFO - Output received: 16:21:43 INFO - Usage: mozinstall [options] installer 16:21:43 INFO - Options: 16:21:43 INFO - -h, --help show this help message and exit 16:21:43 INFO - -d DEST, --destination=DEST 16:21:43 INFO - Directory to install application into. [default: 16:21:43 INFO - "/builds/slave/test"] 16:21:43 INFO - --app=APP Application being installed. [default: firefox] 16:21:43 INFO - mkdir: /builds/slave/test/build/application 16:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:22:26 INFO - Reading from file tmpfile_stdout 16:22:26 INFO - Output received: 16:22:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:22:26 INFO - Running post-action listener: _resource_record_post_action 16:22:26 INFO - ##### 16:22:26 INFO - ##### Running run-tests step. 16:22:26 INFO - ##### 16:22:26 INFO - Running pre-action listener: _resource_record_pre_action 16:22:26 INFO - Running main action method: run_tests 16:22:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:22:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:22:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:22:26 INFO - 2015-11-11 16:22:26.365 screenresolution[2213:15124] starting screenresolution argv=screenresolution get 16:22:26 INFO - 2015-11-11 16:22:26.369 screenresolution[2213:15124] Display 0: 1600x1200x32@60 16:22:26 INFO - 2015-11-11 16:22:26.377 screenresolution[2214:15126] starting screenresolution argv=screenresolution list 16:22:26 INFO - Available Modes on Display 0 16:22:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:22:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:22:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:22:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:22:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:22:26 INFO - Intel HD Graphics 3000: 16:22:26 INFO - Chipset Model: Intel HD Graphics 3000 16:22:26 INFO - Type: GPU 16:22:26 INFO - Bus: Built-In 16:22:26 INFO - VRAM (Total): 512 MB 16:22:26 INFO - VRAM (Dynamic, Max): 10 16:22:26 INFO - Vendor: Intel (0x8086) 16:22:26 INFO - Device ID: 0x0116 16:22:26 INFO - Revision ID: 0x0009 16:22:26 INFO - Displays: 16:22:26 INFO - Display: 16:22:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:22:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:22:26 INFO - Display Serial Number: 1600x1200 60 16:22:26 INFO - Main Display: Yes 16:22:26 INFO - Mirror: Off 16:22:26 INFO - Online: Yes 16:22:26 INFO - Rotation: Supported 16:22:26 INFO - Return code: 0 16:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:22:26 INFO - Python 2.7.3 16:22:26 INFO - Return code: 0 16:22:26 INFO - grabbing minidump binary from tooltool 16:22:26 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')]} 16:22:26 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 0x10efce9f0>, '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 0x10ed2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:22:26 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 16:22:26 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 16:22:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:22:26 INFO - Return code: 0 16:22:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:22:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:22:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:22:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:22:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0021', '--webServer', 'localhost'] in /builds/slave/test/build 16:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0021 --webServer localhost 16:22:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4YYhmWRWNe/Render', 16:22:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:26 INFO - 'HOME': '/Users/cltbld', 16:22:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:26 INFO - 'LOGNAME': 'cltbld', 16:22:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:26 INFO - 'MOZ_NO_REMOTE': '1', 16:22:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:26 INFO - 'NO_EM_RESTART': '1', 16:22:26 INFO - 'PAGER': '/bin/cat', 16:22:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:26 INFO - 'PWD': '/builds/slave/test', 16:22:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:26 INFO - 'SHELL': '/bin/bash', 16:22:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y27H4j4G1H/Listeners', 16:22:26 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 16:22:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:26 INFO - 'USER': 'cltbld', 16:22:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:26 INFO - 'XPC_FLAGS': '0x0', 16:22:26 INFO - 'XPC_SERVICE_NAME': '0', 16:22:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:22:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0021', '--webServer', 'localhost'] with output_timeout 3600 16:22:27 INFO - mozversion INFO | application_buildid: 20151111143931 16:22:27 INFO - mozversion INFO | application_changeset: c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 16:22:27 INFO - mozversion INFO | application_display_name: Nightly 16:22:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:22:27 INFO - mozversion INFO | application_name: Firefox 16:22:27 INFO - mozversion INFO | application_remotingname: firefox 16:22:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:22:27 INFO - mozversion INFO | application_vendor: Mozilla 16:22:27 INFO - mozversion INFO | application_version: 45.0a1 16:22:27 INFO - mozversion INFO | platform_buildid: 20151111143931 16:22:27 INFO - mozversion INFO | platform_changeset: c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 16:22:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:22:27 INFO - mozversion INFO | platform_version: 45.0a1 16:22:27 INFO - 2015-11-11 16:22:27,053 DEBUG : using testdate: 1447287747 16:22:27 INFO - 2015-11-11 16:22:27,053 DEBUG : actual date: 1447287747 16:22:27 INFO - 2015-11-11 16:22:27,066 INFO : starting webserver on 'localhost:50060' 16:22:27 INFO - 2015-11-11 16:22:27,067 INFO : Starting test suite t-yosemite-r5-0021 16:22:27 INFO - 2015-11-11 16:22:27,067 INFO : Starting test dromaeo_css 16:22:27 INFO - 2015-11-11 16:22:27,067 DEBUG : operating with platform_type : mac_ 16:22:27 INFO - 2015-11-11 16:22:27,068 INFO : Initialising browser for dromaeo_css test... 16:22:27 INFO - 2015-11-11 16:22:27,088 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpK30JXE/profile http://localhost:50060/getInfo.html 16:22:29 INFO - 2015-11-11 16:22:29,979 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:22:29 INFO - 2015-11-11 16:22:29,979 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:22:29 INFO - 2015-11-11 16:22:29,979 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:22:29 INFO - 2015-11-11 16:22:29,979 DEBUG : BROWSER_OUTPUT: __metrics 16:22:30 INFO - 2015-11-11 16:22:30,001 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:22:30 INFO - 2015-11-11 16:22:30,920 INFO : Browser initialized. 16:22:30 INFO - 2015-11-11 16:22:30,920 INFO : Running cycle 1/1 for dromaeo_css test... 16:22:30 INFO - 2015-11-11 16:22:30,921 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpK30JXE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:22:43 INFO - 2015-11-11 16:22:43,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 229650432 16:22:43 INFO - 2015-11-11 16:22:43,240 DEBUG : BROWSER_OUTPUT: 16:23:34 INFO - 2015-11-11 16:23:34,956 DEBUG : BROWSER_OUTPUT: 1447287814953 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] 16:25:44 INFO - 2015-11-11 16:25:44,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50060/tests/dromaeo/cssquery-ext.html) 16:25:46 INFO - 2015-11-11 16:25:46,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 368508928 16:25:46 INFO - 2015-11-11 16:25:46,292 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-11 16:28:49,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/dromaeo/cssquery-ext.html (next: http://localhost:50060/tests/dromaeo/cssquery-jquery.html) 16:28:49 INFO - 2015-11-11 16:28:49,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 368283648 16:28:49 INFO - 2015-11-11 16:28:49,892 DEBUG : BROWSER_OUTPUT: 16:31:52 INFO - 2015-11-11 16:31:52,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50060/tests/dromaeo/cssquery-mootools.html) 16:31:52 INFO - 2015-11-11 16:31:52,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 327680000 16:31:52 INFO - 2015-11-11 16:31:52,863 DEBUG : BROWSER_OUTPUT: 16:34:55 INFO - 2015-11-11 16:34:55,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50060/tests/dromaeo/cssquery-prototype.html) 16:34:55 INFO - 2015-11-11 16:34:55,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 316715008 16:34:55 INFO - 2015-11-11 16:34:55,644 DEBUG : BROWSER_OUTPUT: 16:37:58 INFO - 2015-11-11 16:37:58,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50060/tests/dromaeo/cssquery-yui.html) 16:37:59 INFO - 2015-11-11 16:37:59,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 319709184 16:37:59 INFO - 2015-11-11 16:37:59,523 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/dromaeo/cssquery-yui.html (next: http://localhost:50060/tests/dromaeo/cssquery-dojo.html) 16:41:02 INFO - 2015-11-11 16:41:02,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 362479616 16:41:02 INFO - 2015-11-11 16:41:02,759 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,759 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:41:02 INFO - 2015-11-11 16:41:02,760 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:41:02 INFO - 2015-11-11 16:41:02,760 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:41:02 INFO - 2015-11-11 16:41:02,760 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:41:02 INFO - 2015-11-11 16:41:02,760 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2514.811389145814;2596.701379341376;2601.7008044074914;2629.3952390950085;2636.7626913577774;4313.28830742927;4405.207062728708;4419.469663640363;4432.224360736875;4442.5557444255555;4363.585459381362;4371.934420983688;4441.444819397583;4527.230370836957;4545.772711364435;3884.7863367514774;4024.899377515571;4037.8586749463775;4127.9174416511805;4191.497020357561;4168.687348448863;4180.49834019918;4183.602557757008;4212.852550160745;4253.404523366731;3955.307821131319;3967.444557761916;4047.8583249586122;4073.368627862686;4133.5659755725665;4051.2505186540584;4084.5098588169312;4100.331922167255;4113.4446849675505;4162.791860406967;4024.2353952749177;4097.97951010246;4098.303288440972;4099.733517321394;4143.6892233082635;4238.597333253336;4322.308430651112;4342.891427714301;4361.302191649321;4393.890152746175;4684.414448193976;4699.154152252593;4703.129920964632;4706.152892479352;4737.668363214576;4746.382970213885;4748.264019077049;4756.429228492603;4763.976180119112;4811.158047341736;4328.7402755834755;4366.912661746747;4429.092036132585;4442.73343599385;4446.555344465528;4811.9518804812205;4835.44392394872;4842.661013729075;4859.246816743411;4864.927026094611;4609.792559334838;4617.12274667812;4639.234526303122;4639.814407423665;4689.648276379286;4523.909521809545;4595.4025976622825;4649.5815376616265;4650.790714417859;4787.712737235707;4637.281221410619;4663.766811659471;4668.85993420198;4685.601723853442;4703.529647035269;4642.675012749075;4679.836205732851;4685.109829132454;4686.27362758773;4739.786709598076;3542.6103128655827;3595.065283026432;3623.329684008414;3630.8366123524506;3645.635436456333;3184.8248346341175;3237.4658181399805;3295.901122966267;3359.2105855124514;3378.8648454061563;4467.441569803775;4471.061077173765;4483.153197719472;4499.10017996402;4517.367568540407;4680.017739419911;4761.40482439695;4775.689580177277;4779.665423420327;4804.783784729626;4289.442372491556;4373.081652852937;4374.4531933508315;4386.539413361615;4452.643788496913;4105.507339119325;4130.896727581774;4168.687348448879;4180.728252663567;4218.7679677618025;4753.904921901542;4836.903261934742;4864.100141473838;4876.561109500162;4883.755812209375;4606.286025666027;4614.861554153381;4710.481846996896;4715.363425937455;4736.928946065743;4816.494268101799;4849.418069831643;4883.633727470383;4910.8772280693265;4930.087933732271;4713.457952335388;4715.056988602225;4716.1510928033285;4722.716637001791;4771.1888978872985;4551.499335073073;4622.699524530894;4674.555917187861;4681.882952926204;4752.073345697556;4547.295169248771;4582.862514124582;4603.723776573416;4609.101225261042;4666.253399456206;4623.42207224097;4647.117047760915;4658.091672123904;4672.859814205579;4726.527347265246;4378.430803995588;4483.461984561874;4497.347884556786;4499.965008048232;4522.841700540465;4521.773911304487;4597.770111494478;4611.469680986595;4619.399478067964;4651.162790697707;4583.106294272585;4594.379758732662;4605.424321959755;4617.53824617549;4658.86023419298 16:41:02 INFO - 2015-11-11 16:41:02,760 DEBUG : BROWSER_OUTPUT: |1;ext.html;452.4389756701691;458.8256462544235;463.85388602590183;480.66593717366425;486.5110563883297;26658;32809.67190328096;33469;33954.15114622136;34216.48675269873;36549.634503654954;36563.81718091413;36836;37010.07474813131;37086;6738.427233685118;7686.730964416232;7853.214678532129;7860.764177074669;7941.920580794204;6744.156980377453;6854.383105520502;9247.352685312031;9466.337356385056;9608.135267825894;9316.441013539175;9348.906510934872;9365.719028429157;9428.528573571328;9462.243020558373;6965.164180298397;7132.358087772125;9132.36073474857;9282.582283797212;9344.953275233649;6925.065116209297;9262.768430789216;9380.90619093807;9451.385659932082;9484;33798.1550461238;33896;34331.4850277246;34364;34881.30237395263;2415.359929618635;2567.0373609896287;2687.543117670001;2798.720127987205;2878.8848446062134;22529.528681110085;23701.407464813346;23725.644115338284;23829;24517;2003.9098240579062;2020.8484363672783;2050.0877109686194;2074.968875466869;2137.3694760045823;224953;225615;226149.86925065433;227496;227798;52101;52903;52943.47056529386;52998.470015300125;53185.2022219667;47411.28883066757;48600;48871.75564122156;60052;61015;12497.937510312571;12582.37088145589;12746.80879786804;12776.808347874789;12877.935610321889;9384.202342800801;9523.380980236263;9549.856752148724;9559.90440095604;9568.282378821477;17375.47873563795;17608.38370657021;17647.64704705899;17688.11559422024;17806.821931780516;7089;7264.455165862581;7280.235575264627;7310.122785265802;7321.560706357635;753.4913933095139;773.9148693643695;874.6719980007497;922.0548937339147;972.7130496503548;23077.653835192486;23540.76459235386;23633.172838950555;23633.645495317585;23840.761592383853;860.359032520776;870.7377387687236;880.4409200157946;922.239152699026;966.8066386722684;12394.62816115518;12399.194052386747;12466.75066498665;12496.68758281032;12507.624771256877;258287;263523;264535;264796;266321;47007.76496117497;47494.287585686245;47569.52430475651;47687.761561191975;47702.99999999931;1129.7514546799691;1139.1797905508022;1161.651504548649;1165.551262763825;1166.935818529989;23247.651285230397;24009.759902400754;26024;26746;27092;44397;45084.09831803411;45237;45289.32066018946;45338;212105;226186;230497;239319;248556;35076.78522537709;35352;35583;35950.46074308835;36089;37734;38007.42988855114;38104.80947595244;38517.80741096276;38831.41752873766;30039.849800750857;31594;31867.521987170676;31939.36121277515;32004.839975799972;30835.383292334478;31386.372272554876;31598.36803263876;31655.05034848958;31946.68053319437;31205.219869503446;31667;31870.52194217042;31886.52170217402;31935.201619958756;26306;27549.449011019267;27781.44437111287;27858.86070569634;28459;20807.583848322647;20897.89551052235;20936.68594971107;20950.685739714223;20970.47573810667 16:41:02 INFO - 2015-11-11 16:41:02,762 DEBUG : BROWSER_OUTPUT: |2;jquery.html;278.96931337552854;279.7272659157322;281.2588828437069;281.28974339792023;288.62767030530614;9754.561044752985;10076.865436002794;14094.647633809147;14626.341814618341;14640.414383424664;15982.12098334591;16006;16129.193540322996;16165.030098194116;16511;4618.5150559191225;4749.145153872301;4752.239641657336;4768.690035147722;4785.569298763111;4705.976470117645;4715.198416269225;4728.9763551182195;4750.833720819772;4760.595349395306;3294.58817647794;3412.1640198151363;3444.276701892593;4677.4854765975715;4683.578477936985;4927.630427717918;5076;5165.096108181053;5167.48325167484;5180.222966555009;3222.242772948355;3324.734021278292;3338.3156452927333;4497.505274419811;4507.977460112711;10963.848795876478;10995.780084398348;11138.053265472445;11238.719032024183;11286.040686541653;1502.301429835121;1505.7139143562688;1576.566444227835;1629.789315049351;1679.3786299069423;7866.977292951937;7889.526628402315;7891.556978831553;8169.5098294102545;8180.141085186089;1230.6492649594823;1241.3731065811799;1249.4564864284066;1278.0350835119518;1279.2260682287176;45904.770476147736;47600.761996189794;48691.756541217066;49293.507064929254;50363;5364.114921037985;5451.672899626035;5479.479449452296;5553.805616803393;5569.944300557024;6236.095766113888;6249.406306400884;6255.093011513396;6264.843378915472;6275.560710750295;4381.211381951216;4392.538783427694;4415.072834704748;4433.911321773611;4446.644268458515;4661.813527458931;4681.180793361148;4705.576498115186;4749.928751068736;4793.161196790547;2413.674153989224;2433.330834020623;2433.415980164748;2474.2824580871347;2474.406142525781;849.9277561407226;860.6772460327377;861.7673228228343;866.8136350684633;920.3419555018194;294.3685793971918;299.9460097182528;336.24177479782935;349.36066997394704;366.8165917041479;9170.403923744936;9446.433214007182;9582.425054496753;9588.760280992892;9775.266854985763;368.990775230616;372.2814967113497;377.2417440943723;377.4187750863694;400.58139244488996;4982.177940639754;5167.896642067138;5204.9219261711105;5229.346331708536;5244.160934250502;415970;436332;439776;465373;471820;45747.542524574994;63095;63113.684431577545;63957.68021159864;64095.359046409874;408.03296188034545;417.09906601740096;418.03434067304624;419.27674761037576;420.62144070336944;8864.335174861782;9028.142326478974;9077.95461022717;9127.543622818965;9229.307801914749;29526.557101643062;29714.257143570718;30041.5493767598;30336;30588;36377.45433818442;36992;37573.2485350286;39142;39491.80254098711;4957.4794646561595;4992.525710057539;5088.651507350629;5097.770600323069;5105.617078719037;9462.905370946202;9606.759831004281;9833.950830245803;9838.803223935623;9866.802663946537;8285.751427457186;8294.221435819069;8492.74521764348;8499.745007649533;8514.446560973516;7425.9628701856145;7903.960480197562;8137.6744930204495;8266.090730019814;8373.162683731822;8331.708390206313;8379.45533540318;8556.957215213884;8583.484990900566;8616.61225244878;5070.391553013662;5092.465291144525;5111.412187598325;5115.053715062725;5126.871828204325;8001.759947201594;8120.715774947848;8237.135100814328;8240.258376746122;8573.442726222776 16:41:02 INFO - 2015-11-11 16:41:02,763 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1027.0705011964167;1359.4494229836916;1462.9707405851884;1471.0144203383732;1511.659876527782;6039.063945088507;6274.592151510149;6280.963640999235;6521.90217146742;6554.934450655492;6388.616682999023;6392.041193820929;6564.606123632585;6568.901466477994;6584.407403333699;1890.395073576456;1917.2235244725907;1919.500929758259;1920.7791104023006;1926.7398901148376;1859.2655900919128;1872.728454374115;1881.5578339090303;1910.4555201767498;1913.550315675822;1898.3260942365469;1904.828565429111;1910.8949007804565;1914.885106893584;1921.5292253397868;1781.714925611896;1798.6762382771096;1811.2121227266116;1813.1478205243513;1814.2470874587032;1847.2795609712089;1869.2990128701738;1875.0999520230366;1886.1512319456162;1890.3478299986482;5864.354920958691;6465.515086368494;6489.253735820394;6489.286178520359;6533.118029066063;3602.585702644177;3681.7606855554304;3824.1204522959597;3925.8625948091967;3957.7625342479255;2353.51752890657;2373.1931143411152;2437.3662847659557;2446.3394883381566;2448.779609835123;785.3873978296938;813.259933460554;817.199144838062;818.8607936650784;825.2820046559472;8302.418830681854;8483.194096560817;8497.150284971514;8500.319974402033;8523;3462.4806279058344;3535.752497325214;3554.129238336624;3571.2143328467696;3571.285742851388;7283.198848126702;7283.308085731847;7304.013958115693;7318.085239345082;7329.010583571257;4014.6587540059422;4040.1313717550865;4044.9595504045174;4051.493563304587;4065.1259979104634;3702.7222958278235;3705.981470092632;3712.443133529938;3713.6472035156617;3729.664330210294;2814.2682902445104;2824.6045553622507;2856.11460447262;2858.6140870982567;2873.252954231873;851.3444647621297;867.0245973280059;873.4933738431695;873.5632183908046;877.8858748362672;827.3339961331186;851.3870013590205;852.1138016462809;854.8589482735279;1025.6717850287837;6215.098810672427;6217.844553886189;6219.689015549205;6229.906551401733;6240.095186197976;390.8690588652776;400.82163437270134;408.01057435718855;408.4485943975609;411.26178509575385;4813.927791083137;4891.413030436299;4902.558769710672;4916.532929371704;4925.6305777066145;7263.418926485869;7441.1070671519765;7627.923720762721;7855.253750893656;7880.17258187882;7669.7315593953945;7686.116096648845;7693.6922523099565;7760.534367937942;7769.223077692185;6118.847028824226;6160.10678451631;6235.812925612239;6317.46301564363;6321.146645202931;6023.156758053964;6142.662153581417;6165.938340616536;6191.288001879841;6207.131001659681;6839.863202735818;6860.794176174722;6940.7917762467205;6987.965060174666;7035.753748618774;6997.370236678723;7119.181294151032;7164.032855564432;7255.891161632685;7317.158526769277;5427.755750991294;5527.170924361378;5539.473749993906;5540.335159780852;5548.389677135431;6308.621482710869;6308.968455157695;6368.77709280173;6391.936080639134;6428.453581445442;5892.587518873809;5962.314333851663;5967.31375891778;6014.097885317237;6098.26820781509;5848.53211743051;5872.5301975842685;5880.911786323294;5909.763609455574;5979.222701048836;5878.617889837147;5958.076498142795;5959.553033522417;5974.044152935509;5976.61152025117;5378.757955891916;5390.703511306916;5424.159255315432;5438.2386465894015;5448.972755136199;5497.45025497447;5506.889862202654;5525.11598144295;5538.91691624634;5539 16:41:02 INFO - 2015-11-11 16:41:02,767 DEBUG : BROWSER_OUTPUT: |4;prototype.html;250.23677782762573;254.1511352084038;257.8130855130031;261.2358850362689;262.40434214333465;4979.278004689318;5042.4453310135905;5061.9746901265535;5064.898702025962;5078.2382642603625;4898.779554920028;4954.900901981958;5007.399112106543;5019.7239151846725;5040.949590504094;3803.8588423472916;3809.1619843634357;3825.751326163804;3833.2716783811125;3836.846526138951;3671.1005803578028;3722.9441558376648;3752;3810.5427348718194;3819.178876541543;3739.1399978005074;3793.6775374093236;3798.088458769903;3821.14024344523;3825.9426108608254;3813.466114743938;3816.8091595420256;3825.8087095645246;3826.215625796705;3833.9424908626393;3282.6224984126893;3283.507473878937;3291.703746662788;3301.7028467437804;3317.502374643823;4851.442084160296;4871.780769865364;4887.437944636341;4894.535019173209;4900.191468407708;4152.356384760367;4208.3266677331785;4217.030083080878;4249.3413520904305;4348.239058164809;5155.304033955443;5160.225966105077;5163.870903227412;5167.4057483389515;5174.560162386202;3276.7050965413227;3313.8177400242976;3454.6199918008997;3464.497647841049;3465.2722928185112;5263.6578622389425;5369.919451208235;5431.945680543223;5443.673379597237;5468.316460442445;3373.5614370131725;3389.169653434875;3389.254364039907;3410.334984677964;3418.7606867519034;3453.4992426098074;3456.3087382523595;3477.4957631143343;3478.4434490481403;3480.0603836964383;4123.237201117803;4130.752154870717;4132.607402296777;4135.152293779768;4159.168166366739;5084.262781896604;5173.81891633791;5202.609804264695;5213.165893457029;5240.502152295526;1262.6527704881232;1276.961691149267;1290.167841742071;1290.6515240884908;1292.4571679894466;820.0528389709895;820.3970081989733;825.1830687619214;835.7910522369408;838.262329150356;4979.427365852901;4991.650584459053;4992.201247800407;4992.625553083533;5010.624203184703;5426.348838139448;5433.918491222635;5444.754986025639;5448.45515448452;5460.754266058037;5050.4697006814495;5051.62112841531;5056.191009438546;5059.569936555434;5061.493850614909;2914;2972.390659914712;2973.44991176633;2986.4624367614038;2995.99634122567;5526.115821468546;5528.723563821793;5545.223668686387;5571.164325351229;5579.330480342385;5469.863253418696;5562.916556251659;5572.554195664337;5581.190727344593;5585.497305242467;5494.120940649477;5539.307586551681;5552.7223638817895;5552.750126244409;5558.805441809517;5262.184361423985;5433.293671822796;5451.7274136292235;5479.75341109659;5512.889742205213;5372.435894231049;5376.220448035091;5384.300040994645;5387.542058925035;5395.676259424447;5344.812931547377;5456.317960254968;5463.562914966873;5497.917531236954;5609;3506.4564992426212;3516.0682419159457;3547.467879818048;3567.839447224933;3584.6056933736745;5415;5441.591880609049;5453.291072160594;5467.562594992471;5502.614816962774;5265.183896496049;5273.947260527346;5279.683219006872;5288.048151332797;5302.469753024667;5133.281340612392;5254.894902102013;5263.710495922761;5264.710440925785;5282.630215885005;5140.30605868203;5148.639595228298;5157.742112894415;5162.716050617102;5176.275321454924;5251.343582052244;5283.128283833278;5284.04887120322;5287.048331300402;5288.180332048385;5054.014467179012;5193.324867767166;5219.243209734491;5241.895162096813;5257.316548848626 16:41:02 INFO - 2015-11-11 16:41:02,768 DEBUG : BROWSER_OUTPUT: |5;yui.html;569.8974184646763;619.7582942652366;623.2832242920638;624.4972796898496;634.0932466572805;10891.346519208853;11517.193796434243;11523.539058437664;11571.479283432245;11616.01263892568;9190.678326258583;10655.04104630583;10894.237403381767;10922.399268040255;11029.944850275757;737.0639288104104;756.1568850731422;761.075293518375;761.1399118995528;761.6458346868704;749.8275396658772;757.1746795992367;764.7017663111391;764.8202672371988;765.1697907770076;750.7785203365021;771.4021633234261;775.5734346109646;778.4084096086987;780.1340512031641;746.6490749347798;770.8650986077414;771.5370777533464;776.095848336687;778.8130848596353;567.3957235544174;575.315374704105;575.9280089988752;576.7318197038397;577.1717585265116;10003.149732272766;10129.645462408855;10135.341202821794;10148.035936586013;10149.797004059878;8092.878606820902;8264.093408094248;8298.21166989135;8697;8863.822723545492;7359.705611775523;7360.705571777123;7446.218147094585;7477.962610186969;7521.938153397159;2632.8157029007975;2695;2733.371324595354;2739.369944912681;2792.9162125136277;35498.11254718627;35938.460923086175;36765.26469470649;38400.42399364012;38611.613883861086;7334.229905859915;7463.365613922877;7679.3856491481665;7736.806579835549;7917.049954005556;16172.353105875869;16224.756628650579;16307.429239976544;16315.836841631432;16320.102394368187;5831.912521312183;5944.375840536768;5957.165996760457;5986.311574169026;6229.221347331583;3070.8973723351514;3082.3681145365144;3110.082525654892;3128.139761565588;3167.8732850686174;2492.389364605683;2500.437401584629;2515.245426372081;2535.77178053976;2546.59254519276;347.0352420271649;351.46050812003455;352.19347693781464;357.65128999225544;359.90282623691456;382.254603523131;388.5337594886091;389.1050583657576;402.141428051113;428.38954489851835;5960.612560183574;6476.439555393694;6555.934440655532;6672.766453174116;6770.729170833111;480.7932588986769;490.38174025715;501.45341577680506;506.74915916621507;507.00120762098607;2937.818329841864;2992.7755418343277;3092.7835051546176;3092.7835051546626;3240.4977228529615;48522.75738621284;48907.02185956261;48908.51091489111;48922;49896.750516247186;39274.41088383677;39851.80074099669;40184.799076004434;41258.79370603188;41950.79024604918;34712.13219669528;35391.823040885145;37536;37852.43221351682;37855.62144378521;6599.373059559334;6674.866502670016;6797.116374871235;6834.589924604539;6893.965530172317;29085.563716543846;29524.852375737984;29697.554536681535;29789.5531567031;30273;33150.668493314755;33968.830155849064;36609;39972.800136000296;39988.20023599453;6194.163787888578;6312.968435157794;6333.778317758856;6528.151340325728;6694.0628312037325;9373.1564159226;9376.48429336393;9412;9532.608532803233;9649.083337082966;8901;8903.109689031045;8953.865692014755;8989.370744048116;9012.41419307743;8936.329775267011;8944.463332200088;8959.641614335354;8973.82052358936;8989.730308090768;8542.487450752975;8737.694180703646;8758.649654013769;8820.2061814437;8832.425892316978;6764.898526522008;7479.626018699152;7599.696012159673;7687.884681729666;8036.316913062221;6916.688749006407;7465.141508726349;7648.770536883902;7882.487638303492;7951.324137448381 16:41:02 INFO - 2015-11-11 16:41:02,768 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:41:02 INFO - 2015-11-11 16:41:02,768 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:41:02 INFO - 2015-11-11 16:41:02,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1390 16:41:02 INFO - 2015-11-11 16:41:02,769 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:41:02 INFO - 2015-11-11 16:41:02,769 DEBUG : BROWSER_OUTPUT: __startTimestamp1447288862754__endTimestamp 16:41:02 INFO - 2015-11-11 16:41:02,769 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,769 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:41:02 INFO - 2015-11-11 16:41:02,769 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:41:02 INFO - 2015-11-11 16:41:02,770 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,770 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4395.19 Median:4547.30 stddev:476.23 (10.5%) stddev-sans-first:454.27 16:41:02 INFO - 2015-11-11 16:41:02,770 DEBUG : BROWSER_OUTPUT: Values: 2514.8 2596.7 2601.7 2629.4 2636.8 4313.3 4405.2 4419.5 4432.2 4442.6 4363.6 4371.9 4441.4 4527.2 4545.8 3884.8 4024.9 4037.9 4127.9 4191.5 4168.7 4180.5 4183.6 4212.9 4253.4 3955.3 3967.4 4047.9 4073.4 4133.6 4051.3 4084.5 4100.3 4113.4 4162.8 4024.2 4098.0 4098.3 4099.7 4143.7 4238.6 4322.3 4342.9 4361.3 4393.9 4684.4 4699.2 4703.1 4706.2 4737.7 4746.4 4748.3 4756.4 4764.0 4811.2 4328.7 4366.9 4429.1 4442.7 4446.6 4812.0 4835.4 4842.7 4859.2 4864.9 4609.8 4617.1 4639.2 4639.8 4689.6 4523.9 4595.4 4649.6 4650.8 4787.7 4637.3 4663.8 4668.9 4685.6 4703.5 4642.7 4679.8 4685.1 4686.3 4739.8 3542.6 3595.1 3623.3 3630.8 3645.6 3184.8 3237.5 3295.9 3359.2 3378.9 4467.4 4471.1 4483.2 4499.1 4517.4 4680.0 4761.4 4775.7 4779.7 4804.8 4289.4 4373.1 4374.5 4386.5 4452.6 4105.5 4130.9 4168.7 4180.7 4218.8 4753.9 4836.9 4864.1 4876.6 4883.8 4606.3 4614.9 4710.5 4715.4 4736.9 4816.5 4849.4 4883.6 4910.9 4930.1 4713.5 4715.1 4716.2 4722.7 4771.2 4551.5 4622.7 4674.6 4681.9 4752.1 4547.3 4582.9 4603.7 4609.1 4666.3 4623.4 4647.1 4658.1 4672.9 4726.5 4378.4 4483.5 4497.3 4500.0 4522.8 4521.8 4597.8 4611.5 4619.4 4651.2 4583.1 4594.4 4605.4 4617.5 4658.9 16:41:02 INFO - 2015-11-11 16:41:02,770 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,771 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39529.67 Median:34085.32 stddev:62860.67 (184.4%) stddev-sans-first:62968.54 16:41:02 INFO - 2015-11-11 16:41:02,773 DEBUG : BROWSER_OUTPUT: Values: 452.4 458.8 463.9 480.7 486.5 26658.0 32809.7 33469.0 33954.2 34216.5 36549.6 36563.8 36836.0 37010.1 37086.0 6738.4 7686.7 7853.2 7860.8 7941.9 6744.2 6854.4 9247.4 9466.3 9608.1 9316.4 9348.9 9365.7 9428.5 9462.2 6965.2 7132.4 9132.4 9282.6 9345.0 6925.1 9262.8 9380.9 9451.4 9484.0 33798.2 33896.0 34331.5 34364.0 34881.3 2415.4 2567.0 2687.5 2798.7 2878.9 22529.5 23701.4 23725.6 23829.0 24517.0 2003.9 2020.8 2050.1 2075.0 2137.4 224953.0 225615.0 226149.9 227496.0 227798.0 52101.0 52903.0 52943.5 52998.5 53185.2 47411.3 48600.0 48871.8 60052.0 61015.0 12497.9 12582.4 12746.8 12776.8 12877.9 9384.2 9523.4 9549.9 9559.9 9568.3 17375.5 17608.4 17647.6 17688.1 17806.8 7089.0 7264.5 7280.2 7310.1 7321.6 753.5 773.9 874.7 922.1 972.7 23077.7 23540.8 23633.2 23633.6 23840.8 860.4 870.7 880.4 922.2 966.8 12394.6 12399.2 12466.8 12496.7 12507.6 258287.0 263523.0 264535.0 264796.0 266321.0 47007.8 47494.3 47569.5 47687.8 47703.0 1129.8 1139.2 1161.7 1165.6 1166.9 23247.7 24009.8 26024.0 26746.0 27092.0 44397.0 45084.1 45237.0 45289.3 45338.0 212105.0 226186.0 230497.0 239319.0 248556.0 35076.8 35352.0 35583.0 35950.5 36089.0 37734.0 38007.4 38104.8 38517.8 38831.4 30039.8 31594.0 31867.5 31939.4 32004.8 30835.4 31386.4 31598.4 31655.1 31946.7 31205.2 31667.0 31870.5 31886.5 31935.2 26306.0 27549.4 27781.4 27858.9 28459.0 20807.6 20897.9 20936.7 20950.7 20970.5 16:41:02 INFO - 2015-11-11 16:41:02,773 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,773 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22154.77 Median:4751.54 stddev:73104.33 (1538.5%) stddev-sans-first:73290.95 16:41:02 INFO - 2015-11-11 16:41:02,773 DEBUG : BROWSER_OUTPUT: Values: 279.0 279.7 281.3 281.3 288.6 9754.6 10076.9 14094.6 14626.3 14640.4 15982.1 16006.0 16129.2 16165.0 16511.0 4618.5 4749.1 4752.2 4768.7 4785.6 4706.0 4715.2 4729.0 4750.8 4760.6 3294.6 3412.2 3444.3 4677.5 4683.6 4927.6 5076.0 5165.1 5167.5 5180.2 3222.2 3324.7 3338.3 4497.5 4508.0 10963.8 10995.8 11138.1 11238.7 11286.0 1502.3 1505.7 1576.6 1629.8 1679.4 7867.0 7889.5 7891.6 8169.5 8180.1 1230.6 1241.4 1249.5 1278.0 1279.2 45904.8 47600.8 48691.8 49293.5 50363.0 5364.1 5451.7 5479.5 5553.8 5569.9 6236.1 6249.4 6255.1 6264.8 6275.6 4381.2 4392.5 4415.1 4433.9 4446.6 4661.8 4681.2 4705.6 4749.9 4793.2 2413.7 2433.3 2433.4 2474.3 2474.4 849.9 860.7 861.8 866.8 920.3 294.4 299.9 336.2 349.4 366.8 9170.4 9446.4 9582.4 9588.8 9775.3 369.0 372.3 377.2 377.4 400.6 4982.2 5167.9 5204.9 5229.3 5244.2 415970.0 436332.0 439776.0 465373.0 471820.0 45747.5 63095.0 63113.7 63957.7 64095.4 408.0 417.1 418.0 419.3 420.6 8864.3 9028.1 9078.0 9127.5 9229.3 29526.6 29714.3 30041.5 30336.0 30588.0 36377.5 36992.0 37573.2 39142.0 39491.8 4957.5 4992.5 5088.7 5097.8 5105.6 9462.9 9606.8 9834.0 9838.8 9866.8 8285.8 8294.2 8492.7 8499.7 8514.4 7426.0 7904.0 8137.7 8266.1 8373.2 8331.7 8379.5 8557.0 8583.5 8616.6 5070.4 5092.5 5111.4 5115.1 5126.9 8001.8 8120.7 8237.1 8240.3 8573.4 16:41:02 INFO - 2015-11-11 16:41:02,774 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,774 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4517.10 Median:5886.75 stddev:2360.26 (40.1%) stddev-sans-first:2352.30 16:41:02 INFO - 2015-11-11 16:41:02,775 DEBUG : BROWSER_OUTPUT: Values: 1027.1 1359.4 1463.0 1471.0 1511.7 6039.1 6274.6 6281.0 6521.9 6554.9 6388.6 6392.0 6564.6 6568.9 6584.4 1890.4 1917.2 1919.5 1920.8 1926.7 1859.3 1872.7 1881.6 1910.5 1913.6 1898.3 1904.8 1910.9 1914.9 1921.5 1781.7 1798.7 1811.2 1813.1 1814.2 1847.3 1869.3 1875.1 1886.2 1890.3 5864.4 6465.5 6489.3 6489.3 6533.1 3602.6 3681.8 3824.1 3925.9 3957.8 2353.5 2373.2 2437.4 2446.3 2448.8 785.4 813.3 817.2 818.9 825.3 8302.4 8483.2 8497.2 8500.3 8523.0 3462.5 3535.8 3554.1 3571.2 3571.3 7283.2 7283.3 7304.0 7318.1 7329.0 4014.7 4040.1 4045.0 4051.5 4065.1 3702.7 3706.0 3712.4 3713.6 3729.7 2814.3 2824.6 2856.1 2858.6 2873.3 851.3 867.0 873.5 873.6 877.9 827.3 851.4 852.1 854.9 1025.7 6215.1 6217.8 6219.7 6229.9 6240.1 390.9 400.8 408.0 408.4 411.3 4813.9 4891.4 4902.6 4916.5 4925.6 7263.4 7441.1 7627.9 7855.3 7880.2 7669.7 7686.1 7693.7 7760.5 7769.2 6118.8 6160.1 6235.8 6317.5 6321.1 6023.2 6142.7 6165.9 6191.3 6207.1 6839.9 6860.8 6940.8 6988.0 7035.8 6997.4 7119.2 7164.0 7255.9 7317.2 5427.8 5527.2 5539.5 5540.3 5548.4 6308.6 6309.0 6368.8 6391.9 6428.5 5892.6 5962.3 5967.3 6014.1 6098.3 5848.5 5872.5 5880.9 5909.8 5979.2 5878.6 5958.1 5959.6 5974.0 5976.6 5378.8 5390.7 5424.2 5438.2 5449.0 5497.5 5506.9 5525.1 5538.9 5539.0 16:41:02 INFO - 2015-11-11 16:41:02,775 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,775 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4352.37 Median:5057.88 stddev:1345.37 (26.6%) stddev-sans-first:1313.44 16:41:02 INFO - 2015-11-11 16:41:02,777 DEBUG : BROWSER_OUTPUT: Values: 250.2 254.2 257.8 261.2 262.4 4979.3 5042.4 5062.0 5064.9 5078.2 4898.8 4954.9 5007.4 5019.7 5040.9 3803.9 3809.2 3825.8 3833.3 3836.8 3671.1 3722.9 3752.0 3810.5 3819.2 3739.1 3793.7 3798.1 3821.1 3825.9 3813.5 3816.8 3825.8 3826.2 3833.9 3282.6 3283.5 3291.7 3301.7 3317.5 4851.4 4871.8 4887.4 4894.5 4900.2 4152.4 4208.3 4217.0 4249.3 4348.2 5155.3 5160.2 5163.9 5167.4 5174.6 3276.7 3313.8 3454.6 3464.5 3465.3 5263.7 5369.9 5431.9 5443.7 5468.3 3373.6 3389.2 3389.3 3410.3 3418.8 3453.5 3456.3 3477.5 3478.4 3480.1 4123.2 4130.8 4132.6 4135.2 4159.2 5084.3 5173.8 5202.6 5213.2 5240.5 1262.7 1277.0 1290.2 1290.7 1292.5 820.1 820.4 825.2 835.8 838.3 4979.4 4991.7 4992.2 4992.6 5010.6 5426.3 5433.9 5444.8 5448.5 5460.8 5050.5 5051.6 5056.2 5059.6 5061.5 2914.0 2972.4 2973.4 2986.5 2996.0 5526.1 5528.7 5545.2 5571.2 5579.3 5469.9 5562.9 5572.6 5581.2 5585.5 5494.1 5539.3 5552.7 5552.8 5558.8 5262.2 5433.3 5451.7 5479.8 5512.9 5372.4 5376.2 5384.3 5387.5 5395.7 5344.8 5456.3 5463.6 5497.9 5609.0 3506.5 3516.1 3547.5 3567.8 3584.6 5415.0 5441.6 5453.3 5467.6 5502.6 5265.2 5273.9 5279.7 5288.0 5302.5 5133.3 5254.9 5263.7 5264.7 5282.6 5140.3 5148.6 5157.7 5162.7 5176.3 5251.3 5283.1 5284.0 5287.0 5288.2 5054.0 5193.3 5219.2 5241.9 5257.3 16:41:02 INFO - 2015-11-11 16:41:02,777 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-11-11 16:41:02,777 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10979.88 Median:5888.14 stddev:13053.89 (221.7%) stddev-sans-first:13067.10 16:41:02 INFO - 2015-11-11 16:41:02,778 DEBUG : BROWSER_OUTPUT: Values: 569.9 619.8 623.3 624.5 634.1 10891.3 11517.2 11523.5 11571.5 11616.0 9190.7 10655.0 10894.2 10922.4 11029.9 737.1 756.2 761.1 761.1 761.6 749.8 757.2 764.7 764.8 765.2 750.8 771.4 775.6 778.4 780.1 746.6 770.9 771.5 776.1 778.8 567.4 575.3 575.9 576.7 577.2 10003.1 10129.6 10135.3 10148.0 10149.8 8092.9 8264.1 8298.2 8697.0 8863.8 7359.7 7360.7 7446.2 7478.0 7521.9 2632.8 2695.0 2733.4 2739.4 2792.9 35498.1 35938.5 36765.3 38400.4 38611.6 7334.2 7463.4 7679.4 7736.8 7917.0 16172.4 16224.8 16307.4 16315.8 16320.1 5831.9 5944.4 5957.2 5986.3 6229.2 3070.9 3082.4 3110.1 3128.1 3167.9 2492.4 2500.4 2515.2 2535.8 2546.6 347.0 351.5 352.2 357.7 359.9 382.3 388.5 389.1 402.1 428.4 5960.6 6476.4 6555.9 6672.8 6770.7 480.8 490.4 501.5 506.7 507.0 2937.8 2992.8 3092.8 3092.8 3240.5 48522.8 48907.0 48908.5 48922.0 49896.8 39274.4 39851.8 40184.8 41258.8 41950.8 34712.1 35391.8 37536.0 37852.4 37855.6 6599.4 6674.9 6797.1 6834.6 6894.0 29085.6 29524.9 29697.6 29789.6 30273.0 33150.7 33968.8 36609.0 39972.8 39988.2 6194.2 6313.0 6333.8 6528.2 6694.1 9373.2 9376.5 9412.0 9532.6 9649.1 8901.0 8903.1 8953.9 8989.4 9012.4 8936.3 8944.5 8959.6 8973.8 8989.7 8542.5 8737.7 8758.6 8820.2 8832.4 6764.9 7479.6 7599.7 7687.9 8036.3 6916.7 7465.1 7648.8 7882.5 7951.3 16:41:02 INFO - 2015-11-11 16:41:02,778 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:41:02 INFO - 2015-11-11 16:41:02,778 DEBUG : BROWSER_OUTPUT: 16:41:03 INFO - 2015-11-11 16:41:03,491 INFO : Browser exited with error code: 0 16:41:03 INFO - 2015-11-11 16:41:03,525 INFO : Completed test dromaeo_css (00:18:36) 16:41:03 INFO - 2015-11-11 16:41:03,525 INFO : Starting test kraken 16:41:03 INFO - 2015-11-11 16:41:03,525 DEBUG : operating with platform_type : mac_ 16:41:03 INFO - 2015-11-11 16:41:03,526 INFO : Initialising browser for kraken test... 16:41:03 INFO - 2015-11-11 16:41:03,542 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpB3XxWg/profile http://localhost:50060/getInfo.html 16:41:06 INFO - 2015-11-11 16:41:06,332 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:41:06 INFO - 2015-11-11 16:41:06,332 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:41:06 INFO - 2015-11-11 16:41:06,332 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:41:06 INFO - 2015-11-11 16:41:06,332 DEBUG : BROWSER_OUTPUT: __metrics 16:41:06 INFO - 2015-11-11 16:41:06,350 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:07 INFO - 2015-11-11 16:41:07,168 INFO : Browser initialized. 16:41:07 INFO - 2015-11-11 16:41:07,168 INFO : Running cycle 1/1 for kraken test... 16:41:07 INFO - 2015-11-11 16:41:07,169 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpB3XxWg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:41:19 INFO - 2015-11-11 16:41:19,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 228671488 16:41:19 INFO - 2015-11-11 16:41:19,523 DEBUG : BROWSER_OUTPUT: 16:41:22 INFO - 2015-11-11 16:41:22,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50060/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:23 INFO - 2015-11-11 16:41:23,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 285147136 16:41:23 INFO - 2015-11-11 16:41:23,051 DEBUG : BROWSER_OUTPUT: 16:41:26 INFO - 2015-11-11 16:41:26,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50060/tests/kraken/driver.html?testName=audio-dft) 16:41:26 INFO - 2015-11-11 16:41:26,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 298766336 16:41:26 INFO - 2015-11-11 16:41:26,745 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-11 16:41:30,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50060/tests/kraken/driver.html?testName=audio-fft) 16:41:30 INFO - 2015-11-11 16:41:30,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 280555520 16:41:30 INFO - 2015-11-11 16:41:30,765 DEBUG : BROWSER_OUTPUT: 16:41:33 INFO - 2015-11-11 16:41:33,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50060/tests/kraken/driver.html?testName=audio-oscillator) 16:41:33 INFO - 2015-11-11 16:41:33,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 282288128 16:41:33 INFO - 2015-11-11 16:41:33,650 DEBUG : BROWSER_OUTPUT: 16:41:36 INFO - 2015-11-11 16:41:36,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:41:36 INFO - 2015-11-11 16:41:36,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 283181056 16:41:36 INFO - 2015-11-11 16:41:36,738 DEBUG : BROWSER_OUTPUT: 16:41:40 INFO - 2015-11-11 16:41:40,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50060/tests/kraken/driver.html?testName=imaging-darkroom) 16:41:40 INFO - 2015-11-11 16:41:40,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 280313856 16:41:40 INFO - 2015-11-11 16:41:40,898 DEBUG : BROWSER_OUTPUT: 16:41:44 INFO - 2015-11-11 16:41:44,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50060/tests/kraken/driver.html?testName=imaging-desaturate) 16:41:45 INFO - 2015-11-11 16:41:45,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 279764992 16:41:45 INFO - 2015-11-11 16:41:45,176 DEBUG : BROWSER_OUTPUT: 16:41:48 INFO - 2015-11-11 16:41:48,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50060/tests/kraken/driver.html?testName=json-parse-financial) 16:41:49 INFO - 2015-11-11 16:41:49,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 279420928 16:41:49 INFO - 2015-11-11 16:41:49,120 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-11 16:41:50,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:41:51 INFO - 2015-11-11 16:41:51,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 316551168 16:41:51 INFO - 2015-11-11 16:41:51,464 DEBUG : BROWSER_OUTPUT: 16:41:53 INFO - 2015-11-11 16:41:53,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50060/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:41:54 INFO - 2015-11-11 16:41:54,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 318550016 16:41:54 INFO - 2015-11-11 16:41:54,133 DEBUG : BROWSER_OUTPUT: 16:41:56 INFO - 2015-11-11 16:41:56,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:41:57 INFO - 2015-11-11 16:41:57,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 326234112 16:41:57 INFO - 2015-11-11 16:41:57,139 DEBUG : BROWSER_OUTPUT: 16:42:00 INFO - 2015-11-11 16:42:00,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:00 INFO - 2015-11-11 16:42:00,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 326234112 16:42:00 INFO - 2015-11-11 16:42:00,730 DEBUG : BROWSER_OUTPUT: 16:42:03 INFO - 2015-11-11 16:42:03,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:04 INFO - 2015-11-11 16:42:04,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 326352896 16:42:04 INFO - 2015-11-11 16:42:04,379 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50060/tests/kraken/driver.html?testName=ai-astar) 16:42:06 INFO - 2015-11-11 16:42:06,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 385695744 16:42:06 INFO - 2015-11-11 16:42:06,622 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,622 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:42:06 INFO - 2015-11-11 16:42:06,622 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:42:06 INFO - 2015-11-11 16:42:06,622 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:42:06 INFO - 2015-11-11 16:42:06,622 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:42:06 INFO - 2015-11-11 16:42:06,622 DEBUG : BROWSER_OUTPUT: |0;ai-astar;128;133;124;132;132;132;132;132;124;131 16:42:06 INFO - 2015-11-11 16:42:06,623 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;189;158;193;203;157;182;181;151;200;162 16:42:06 INFO - 2015-11-11 16:42:06,623 DEBUG : BROWSER_OUTPUT: |2;audio-dft;195;197;198;197;198;199;196;197;189;197 16:42:06 INFO - 2015-11-11 16:42:06,623 DEBUG : BROWSER_OUTPUT: |3;audio-fft;91;97;104;149;83;84;87;87;140;81 16:42:06 INFO - 2015-11-11 16:42:06,623 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;118;121;165;109;109;110;154;107;107;157 16:42:06 INFO - 2015-11-11 16:42:06,623 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;142;142;149;142;141;149;141;148;149 16:42:06 INFO - 2015-11-11 16:42:06,623 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;155;154;162;154;154;154;148;154;155;155 16:42:06 INFO - 2015-11-11 16:42:06,624 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;123;124;129;124;125;124;124;124;123;124 16:42:06 INFO - 2015-11-11 16:42:06,624 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;66;71;72;74;73;72;71;83;71;72 16:42:06 INFO - 2015-11-11 16:42:06,624 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;76;77;80;83;82;81;82;81;82;82 16:42:06 INFO - 2015-11-11 16:42:06,624 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;105;104;104;105;104;109;111;105;105 16:42:06 INFO - 2015-11-11 16:42:06,624 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;158;155;163;152;162;151;151;162;161;156 16:42:06 INFO - 2015-11-11 16:42:06,625 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;177;175;189;192;179;194;188;190;182;189 16:42:06 INFO - 2015-11-11 16:42:06,625 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;82;85;88;88;89;88;88;88;88;89 16:42:06 INFO - 2015-11-11 16:42:06,625 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:42:06 INFO - 2015-11-11 16:42:06,625 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:42:06 INFO - 2015-11-11 16:42:06,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 16:42:06 INFO - 2015-11-11 16:42:06,625 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:42:06 INFO - 2015-11-11 16:42:06,626 DEBUG : BROWSER_OUTPUT: __startTimestamp1447288926617__endTimestamp 16:42:06 INFO - 2015-11-11 16:42:06,626 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,626 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:42:06 INFO - 2015-11-11 16:42:06,626 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:42:06 INFO - 2015-11-11 16:42:06,626 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,626 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:130.00 Median:132.00 stddev:3.43 (2.6%) stddev-sans-first:3.56 16:42:06 INFO - 2015-11-11 16:42:06,627 DEBUG : BROWSER_OUTPUT: Values: 128.0 133.0 124.0 132.0 132.0 132.0 132.0 132.0 124.0 131.0 16:42:06 INFO - 2015-11-11 16:42:06,627 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,627 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:177.60 Median:185.50 stddev:19.16 (10.3%) stddev-sans-first:19.87 16:42:06 INFO - 2015-11-11 16:42:06,627 DEBUG : BROWSER_OUTPUT: Values: 189.0 158.0 193.0 203.0 157.0 182.0 181.0 151.0 200.0 162.0 16:42:06 INFO - 2015-11-11 16:42:06,627 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,628 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.30 Median:197.00 stddev:2.79 (1.4%) stddev-sans-first:2.92 16:42:06 INFO - 2015-11-11 16:42:06,628 DEBUG : BROWSER_OUTPUT: Values: 195.0 197.0 198.0 197.0 198.0 199.0 196.0 197.0 189.0 197.0 16:42:06 INFO - 2015-11-11 16:42:06,628 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,628 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:100.30 Median:85.50 stddev:24.38 (28.5%) stddev-sans-first:25.63 16:42:06 INFO - 2015-11-11 16:42:06,628 DEBUG : BROWSER_OUTPUT: Values: 91.0 97.0 104.0 149.0 83.0 84.0 87.0 87.0 140.0 81.0 16:42:06 INFO - 2015-11-11 16:42:06,628 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,629 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:125.70 Median:119.50 stddev:23.36 (19.5%) stddev-sans-first:24.61 16:42:06 INFO - 2015-11-11 16:42:06,629 DEBUG : BROWSER_OUTPUT: Values: 118.0 121.0 165.0 109.0 109.0 110.0 154.0 107.0 107.0 157.0 16:42:06 INFO - 2015-11-11 16:42:06,629 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,629 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:144.50 Median:145.00 stddev:3.69 (2.5%) stddev-sans-first:3.80 16:42:06 INFO - 2015-11-11 16:42:06,629 DEBUG : BROWSER_OUTPUT: Values: 142.0 142.0 142.0 149.0 142.0 141.0 149.0 141.0 148.0 149.0 16:42:06 INFO - 2015-11-11 16:42:06,630 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,630 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.50 Median:154.50 stddev:3.34 (2.2%) stddev-sans-first:3.54 16:42:06 INFO - 2015-11-11 16:42:06,630 DEBUG : BROWSER_OUTPUT: Values: 155.0 154.0 162.0 154.0 154.0 154.0 148.0 154.0 155.0 155.0 16:42:06 INFO - 2015-11-11 16:42:06,630 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,630 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:124.40 Median:124.00 stddev:1.71 (1.4%) stddev-sans-first:1.74 16:42:06 INFO - 2015-11-11 16:42:06,630 DEBUG : BROWSER_OUTPUT: Values: 123.0 124.0 129.0 124.0 125.0 124.0 124.0 124.0 123.0 124.0 16:42:06 INFO - 2015-11-11 16:42:06,630 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,631 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:72.00 stddev:4.25 (5.9%) stddev-sans-first:3.80 16:42:06 INFO - 2015-11-11 16:42:06,631 DEBUG : BROWSER_OUTPUT: Values: 66.0 71.0 72.0 74.0 73.0 72.0 71.0 83.0 71.0 72.0 16:42:06 INFO - 2015-11-11 16:42:06,631 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,631 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:80.60 Median:82.00 stddev:2.32 (2.8%) stddev-sans-first:1.76 16:42:06 INFO - 2015-11-11 16:42:06,631 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 80.0 83.0 82.0 81.0 82.0 81.0 82.0 82.0 16:42:06 INFO - 2015-11-11 16:42:06,631 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,633 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.50 Median:105.00 stddev:2.51 (2.4%) stddev-sans-first:2.49 16:42:06 INFO - 2015-11-11 16:42:06,633 DEBUG : BROWSER_OUTPUT: Values: 103.0 105.0 104.0 104.0 105.0 104.0 109.0 111.0 105.0 105.0 16:42:06 INFO - 2015-11-11 16:42:06,633 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,633 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:157.10 Median:159.50 stddev:4.77 (3.0%) stddev-sans-first:5.05 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: Values: 158.0 155.0 163.0 152.0 162.0 151.0 151.0 162.0 161.0 156.0 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.50 Median:189.00 stddev:6.69 (3.5%) stddev-sans-first:6.35 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: Values: 177.0 175.0 189.0 192.0 179.0 194.0 188.0 190.0 182.0 189.0 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.30 Median:88.00 stddev:2.16 (2.5%) stddev-sans-first:1.17 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 88.0 88.0 89.0 88.0 88.0 88.0 88.0 89.0 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:42:06 INFO - 2015-11-11 16:42:06,634 DEBUG : BROWSER_OUTPUT: 16:42:07 INFO - 2015-11-11 16:42:07,389 INFO : Browser exited with error code: 0 16:42:07 INFO - 2015-11-11 16:42:07,448 INFO : Completed test kraken (00:01:03) 16:42:07 INFO - 2015-11-11 16:42:07,448 INFO : Starting test v8_7 16:42:07 INFO - 2015-11-11 16:42:07,448 DEBUG : operating with platform_type : mac_ 16:42:07 INFO - 2015-11-11 16:42:07,448 INFO : Initialising browser for v8_7 test... 16:42:07 INFO - 2015-11-11 16:42:07,465 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmp4bEJhk/profile http://localhost:50060/getInfo.html 16:42:10 INFO - 2015-11-11 16:42:10,185 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:42:10 INFO - 2015-11-11 16:42:10,185 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:42:10 INFO - 2015-11-11 16:42:10,185 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:42:10 INFO - 2015-11-11 16:42:10,186 DEBUG : BROWSER_OUTPUT: __metrics 16:42:10 INFO - 2015-11-11 16:42:10,203 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:42:11 INFO - 2015-11-11 16:42:11,090 INFO : Browser initialized. 16:42:11 INFO - 2015-11-11 16:42:11,091 INFO : Running cycle 1/1 for v8_7 test... 16:42:11 INFO - 2015-11-11 16:42:11,091 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmp4bEJhk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:42:23 INFO - 2015-11-11 16:42:23,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 228048896 16:42:23 INFO - 2015-11-11 16:42:23,443 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50060/tests/v8_7/run.html (next: http://localhost:50060/tests/v8_7/run.html) 16:42:46 INFO - 2015-11-11 16:42:46,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 753405952 16:42:46 INFO - 2015-11-11 16:42:46,596 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,596 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:42:46 INFO - 2015-11-11 16:42:46,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:42:46 INFO - 2015-11-11 16:42:46,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:42:46 INFO - 2015-11-11 16:42:46,597 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:42:46 INFO - 2015-11-11 16:42:46,597 DEBUG : BROWSER_OUTPUT: |0;Richards;202.5931928687196 16:42:46 INFO - 2015-11-11 16:42:46,597 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;231.16042533518262 16:42:46 INFO - 2015-11-11 16:42:46,597 DEBUG : BROWSER_OUTPUT: |2;Encrypt;384.9114703618168 16:42:46 INFO - 2015-11-11 16:42:46,597 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7013.986013986014 16:42:46 INFO - 2015-11-11 16:42:46,597 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2290.6178489702515 16:42:46 INFO - 2015-11-11 16:42:46,598 DEBUG : BROWSER_OUTPUT: |5;Earley;940.7337723424271 16:42:46 INFO - 2015-11-11 16:42:46,598 DEBUG : BROWSER_OUTPUT: |6;Boyer;15584.615384615385 16:42:46 INFO - 2015-11-11 16:42:46,598 DEBUG : BROWSER_OUTPUT: |7;RegExp;36285.71428571428 16:42:46 INFO - 2015-11-11 16:42:46,598 DEBUG : BROWSER_OUTPUT: |8;Splay;821.0180623973728 16:42:46 INFO - 2015-11-11 16:42:46,598 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6993.006993006993 16:42:46 INFO - 2015-11-11 16:42:46,598 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:42:46 INFO - 2015-11-11 16:42:46,599 DEBUG : BROWSER_OUTPUT: __startTimestamp1447288966595__endTimestamp 16:42:46 INFO - 2015-11-11 16:42:46,599 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,599 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:42:46 INFO - 2015-11-11 16:42:46,599 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:42:46 INFO - 2015-11-11 16:42:46,599 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,599 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:202.59 Median:202.59 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,600 DEBUG : BROWSER_OUTPUT: Values: 202.6 16:42:46 INFO - 2015-11-11 16:42:46,600 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,600 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:231.16 Median:231.16 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,600 DEBUG : BROWSER_OUTPUT: Values: 231.2 16:42:46 INFO - 2015-11-11 16:42:46,600 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,601 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:384.91 Median:384.91 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,601 DEBUG : BROWSER_OUTPUT: Values: 384.9 16:42:46 INFO - 2015-11-11 16:42:46,601 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,601 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7013.99 Median:7013.99 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,601 DEBUG : BROWSER_OUTPUT: Values: 7014.0 16:42:46 INFO - 2015-11-11 16:42:46,603 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,603 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2290.62 Median:2290.62 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,603 DEBUG : BROWSER_OUTPUT: Values: 2290.6 16:42:46 INFO - 2015-11-11 16:42:46,603 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,603 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:940.73 Median:940.73 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,603 DEBUG : BROWSER_OUTPUT: Values: 940.7 16:42:46 INFO - 2015-11-11 16:42:46,603 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,604 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15584.62 Median:15584.62 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,604 DEBUG : BROWSER_OUTPUT: Values: 15584.6 16:42:46 INFO - 2015-11-11 16:42:46,604 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,604 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36285.71 Median:36285.71 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,604 DEBUG : BROWSER_OUTPUT: Values: 36285.7 16:42:46 INFO - 2015-11-11 16:42:46,604 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,604 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:821.02 Median:821.02 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,604 DEBUG : BROWSER_OUTPUT: Values: 821.0 16:42:46 INFO - 2015-11-11 16:42:46,605 DEBUG : BROWSER_OUTPUT: 16:42:46 INFO - 2015-11-11 16:42:46,605 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6993.01 Median:6993.01 stddev:0.00 (0.0%) 16:42:46 INFO - 2015-11-11 16:42:46,605 DEBUG : BROWSER_OUTPUT: Values: 6993.0 16:42:46 INFO - 2015-11-11 16:42:46,605 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:42:46 INFO - 2015-11-11 16:42:46,605 DEBUG : BROWSER_OUTPUT: 16:42:47 INFO - 2015-11-11 16:42:47,369 INFO : Browser exited with error code: 0 16:42:47 INFO - 2015-11-11 16:42:47,391 INFO : Completed test v8_7 (00:00:39) 16:42:47 INFO - 2015-11-11 16:42:47,843 INFO : Completed test suite (00:20:20) 16:42:47 INFO - 2015-11-11 16:42:47,844 DEBUG : Working with test: dromaeo_css 16:42:47 INFO - 2015-11-11 16:42:47,844 DEBUG : Generating results file: dromaeo_css 16:42:47 INFO - 2015-11-11 16:42:47,844 DEBUG : Working with test: kraken 16:42:47 INFO - 2015-11-11 16:42:47,845 DEBUG : Generating results file: kraken 16:42:47 INFO - 2015-11-11 16:42:47,845 INFO : javascript benchmark 16:42:47 INFO - 2015-11-11 16:42:47,845 DEBUG : Working with test: v8_7 16:42:47 INFO - 2015-11-11 16:42:47,845 DEBUG : Generating results file: v8_7 16:42:47 INFO - 2015-11-11 16:42:47,845 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:42:48 INFO - 2015-11-11 16:42:48,896 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 16:42:48 INFO - 2015-11-11 16:42:48,896 DEBUG : process_Request line: dromaeo_css 5496.48 graph.html#tests=[[72,63,55]] 16:42:48 INFO - 2015-11-11 16:42:48,896 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:42:48 INFO - 2015-11-11 16:42:48,924 DEBUG : process_Request line: kraken 1841.80 graph.html#tests=[[232,63,55]] 16:42:48 INFO - 2015-11-11 16:42:48,924 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:42:48 INFO - 2015-11-11 16:42:48,953 DEBUG : process_Request line: v8_7 15323.57 graph.html#tests=[[230,63,55]] 16:42:48 INFO - 2015-11-11 16:42:48,954 INFO : javascript benchmark 16:42:49 INFO - 2015-11-11 16:42:48,956 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [278.96931337552854, 279.7272659157322, 281.2588828437069, 281.28974339792023, 288.62767030530614, 9754.561044752985, 10076.865436002794, 14094.647633809147, 14626.341814618341, 14640.414383424664, 15982.12098334591, 16006.0, 16129.193540322996, 16165.030098194116, 16511.0, 4618.5150559191225, 4749.145153872301, 4752.239641657336, 4768.690035147722, 4785.569298763111, 4705.976470117645, 4715.198416269225, 4728.9763551182195, 4750.833720819772, 4760.595349395306, 3294.58817647794, 3412.1640198151363, 3444.276701892593, 4677.4854765975715, 4683.578477936985, 4927.630427717918, 5076.0, 5165.096108181053, 5167.48325167484, 5180.222966555009, 3222.242772948355, 3324.734021278292, 3338.3156452927333, 4497.505274419811, 4507.977460112711, 10963.848795876478, 10995.780084398348, 11138.053265472445, 11238.719032024183, 11286.040686541653, 1502.301429835121, 1505.7139143562688, 1576.566444227835, 1629.789315049351, 1679.3786299069423, 7866.977292951937, 7889.526628402315, 7891.556978831553, 8169.5098294102545, 8180.141085186089, 1230.6492649594823, 1241.3731065811799, 1249.4564864284066, 1278.0350835119518, 1279.2260682287176, 45904.770476147736, 47600.761996189794, 48691.756541217066, 49293.507064929254, 50363.0, 5364.114921037985, 5451.672899626035, 5479.479449452296, 5553.805616803393, 5569.944300557024, 6236.095766113888, 6249.406306400884, 6255.093011513396, 6264.843378915472, 6275.560710750295, 4381.211381951216, 4392.538783427694, 4415.072834704748, 4433.911321773611, 4446.644268458515, 4661.813527458931, 4681.180793361148, 4705.576498115186, 4749.928751068736, 4793.161196790547, 2413.674153989224, 2433.330834020623, 2433.415980164748, 2474.2824580871347, 2474.406142525781, 849.9277561407226, 860.6772460327377, 861.7673228228343, 866.8136350684633, 920.3419555018194, 294.3685793971918, 299.9460097182528, 336.24177479782935, 349.36066997394704, 366.8165917041479, 9170.403923744936, 9446.433214007182, 9582.425054496753, 9588.760280992892, 9775.266854985763, 368.990775230616, 372.2814967113497, 377.2417440943723, 377.4187750863694, 400.58139244488996, 4982.177940639754, 5167.896642067138, 5204.9219261711105, 5229.346331708536, 5244.160934250502, 415970.0, 436332.0, 439776.0, 465373.0, 471820.0, 45747.542524574994, 63095.0, 63113.684431577545, 63957.68021159864, 64095.359046409874, 408.03296188034545, 417.09906601740096, 418.03434067304624, 419.27674761037576, 420.62144070336944, 8864.335174861782, 9028.142326478974, 9077.95461022717, 9127.543622818965, 9229.307801914749, 29526.557101643062, 29714.257143570718, 30041.5493767598, 30336.0, 30588.0, 36377.45433818442, 36992.0, 37573.2485350286, 39142.0, 39491.80254098711, 4957.4794646561595, 4992.525710057539, 5088.651507350629, 5097.770600323069, 5105.617078719037, 9462.905370946202, 9606.759831004281, 9833.950830245803, 9838.803223935623, 9866.802663946537, 8285.751427457186, 8294.221435819069, 8492.74521764348, 8499.745007649533, 8514.446560973516, 7425.9628701856145, 7903.960480197562, 8137.6744930204495, 8266.090730019814, 8373.162683731822, 8331.708390206313, 8379.45533540318, 8556.957215213884, 8583.484990900566, 8616.61225244878, 5070.391553013662, 5092.465291144525, 5111.412187598325, 5115.053715062725, 5126.871828204325, 8001.759947201594, 8120.715774947848, 8237.135100814328, 8240.258376746122, 8573.442726222776], "dojo.html": [2514.811389145814, 2596.701379341376, 2601.7008044074914, 2629.3952390950085, 2636.7626913577774, 4313.28830742927, 4405.207062728708, 4419.469663640363, 4432.224360736875, 4442.5557444255555, 4363.585459381362, 4371.934420983688, 4441.444819397583, 4527.230370836957, 4545.772711364435, 3884.7863367514774, 4024.899377515571, 4037.8586749463775, 4127.9174416511805, 4191.497020357561, 4168.687348448863, 4180.49834019918, 4183.602557757008, 4212.852550160745, 4253.404523366731, 3955.307821131319, 3967.444557761916, 4047.8583249586122, 4073.368627862686, 4133.5659755725665, 4051.2505186540584, 4084.5098588169312, 4100.331922167255, 4113.4446849675505, 4162.791860406967, 4024.2353952749177, 4097.97951010246, 4098.303288440972, 4099.733517321394, 4143.6892233082635, 4238.597333253336, 4322.308430651112, 4342.891427714301, 4361.302191649321, 4393.890152746175, 4684.414448193976, 4699.154152252593, 4703.129920964632, 4706.152892479352, 4737.668363214576, 4746.382970213885, 4748.264019077049, 4756.429228492603, 4763.976180119112, 4811.158047341736, 4328.7402755834755, 4366.912661746747, 4429.092036132585, 4442.73343599385, 4446.555344465528, 4811.9518804812205, 4835.44392394872, 4842.661013729075, 4859.246816743411, 4864.927026094611, 4609.792559334838, 4617.12274667812, 4639.234526303122, 4639.814407423665, 4689.648276379286, 4523.909521809545, 4595.4025976622825, 4649.5815376616265, 4650.790714417859, 4787.712737235707, 4637.281221410619, 4663.766811659471, 4668.85993420198, 4685.601723853442, 4703.529647035269, 4642.675012749075, 4679.836205732851, 4685.109829132454, 4686.27362758773, 4739.786709598076, 3542.6103128655827, 3595.065283026432, 3623.329684008414, 3630.8366123524506, 3645.635436456333, 3184.8248346341175, 3237.4658181399805, 3295.901122966267, 3359.2105855124514, 3378.8648454061563, 4467.441569803775, 4471.061077173765, 4483.153197719472, 4499.10017996402, 4517.367568540407, 4680.017739419911, 4761.40482439695, 4775.689580177277, 4779.665423420327, 4804.783784729626, 4289.442372491556, 4373.081652852937, 4374.4531933508315, 4386.539413361615, 4452.643788496913, 4105.507339119325, 4130.896727581774, 4168.687348448879, 4180.728252663567, 4218.7679677618025, 4753.904921901542, 4836.903261934742, 4864.100141473838, 4876.561109500162, 4883.755812209375, 4606.286025666027, 4614.861554153381, 4710.481846996896, 4715.363425937455, 4736.928946065743, 4816.494268101799, 4849.418069831643, 4883.633727470383, 4910.8772280693265, 4930.087933732271, 4713.457952335388, 4715.056988602225, 4716.1510928033285, 4722.716637001791, 4771.1888978872985, 4551.499335073073, 4622.699524530894, 4674.555917187861, 4681.882952926204, 4752.073345697556, 4547.295169248771, 4582.862514124582, 4603.723776573416, 4609.101225261042, 4666.253399456206, 4623.42207224097, 4647.117047760915, 4658.091672123904, 4672.859814205579, 4726.527347265246, 4378.430803995588, 4483.461984561874, 4497.347884556786, 4499.965008048232, 4522.841700540465, 4521.773911304487, 4597.770111494478, 4611.469680986595, 4619.399478067964, 4651.162790697707, 4583.106294272585, 4594.379758732662, 4605.424321959755, 4617.53824617549, 4658.86023419298], "mootools.html": [1027.0705011964167, 1359.4494229836916, 1462.9707405851884, 1471.0144203383732, 1511.659876527782, 6039.063945088507, 6274.592151510149, 6280.963640999235, 6521.90217146742, 6554.934450655492, 6388.616682999023, 6392.041193820929, 6564.606123632585, 6568.901466477994, 6584.407403333699, 1890.395073576456, 1917.2235244725907, 1919.500929758259, 1920.7791104023006, 1926.7398901148376, 1859.2655900919128, 1872.728454374115, 1881.5578339090303, 1910.4555201767498, 1913.550315675822, 1898.3260942365469, 1904.828565429111, 1910.8949007804565, 1914.885106893584, 1921.5292253397868, 1781.714925611896, 1798.6762382771096, 1811.2121227266116, 1813.1478205243513, 1814.2470874587032, 1847.2795609712089, 1869.2990128701738, 1875.0999520230366, 1886.1512319456162, 1890.3478299986482, 5864.354920958691, 6465.515086368494, 6489.253735820394, 6489.286178520359, 6533.118029066063, 3602.585702644177, 3681.7606855554304, 3824.1204522959597, 3925.8625948091967, 3957.7625342479255, 2353.51752890657, 2373.1931143411152, 2437.3662847659557, 2446.3394883381566, 2448.779609835123, 785.3873978296938, 813.259933460554, 817.199144838062, 818.8607936650784, 825.2820046559472, 8302.418830681854, 8483.194096560817, 8497.150284971514, 8500.319974402033, 8523.0, 3462.4806279058344, 3535.752497325214, 3554.129238336624, 3571.2143328467696, 3571.285742851388, 7283.198848126702, 7283.308085731847, 7304.013958115693, 7318.085239345082, 7329.010583571257, 4014.6587540059422, 4040.1313717550865, 4044.9595504045174, 4051.493563304587, 4065.1259979104634, 3702.7222958278235, 3705.981470092632, 3712.443133529938, 3713.6472035156617, 3729.664330210294, 2814.2682902445104, 2824.6045553622507, 2856.11460447262, 2858.6140870982567, 2873.252954231873, 851.3444647621297, 867.0245973280059, 873.4933738431695, 873.5632183908046, 877.8858748362672, 827.3339961331186, 851.3870013590205, 852.1138016462809, 854.8589482735279, 1025.6717850287837, 6215.098810672427, 6217.844553886189, 6219.689015549205, 6229.906551401733, 6240.095186197976, 390.8690588652776, 400.82163437270134, 408.01057435718855, 408.4485943975609, 411.26178509575385, 4813.927791083137, 4891.413030436299, 4902.558769710672, 4916.532929371704, 4925.6305777066145, 7263.418926485869, 7441.1070671519765, 7627.923720762721, 7855.253750893656, 7880.17258187882, 7669.7315593953945, 7686.116096648845, 7693.6922523099565, 7760.534367937942, 7769.223077692185, 6118.847028824226, 6160.10678451631, 6235.812925612239, 6317.46301564363, 6321.146645202931, 6023.156758053964, 6142.662153581417, 6165.938340616536, 6191.288001879841, 6207.131001659681, 6839.863202735818, 6860.794176174722, 6940.7917762467205, 6987.965060174666, 7035.753748618774, 6997.370236678723, 7119.181294151032, 7164.032855564432, 7255.891161632685, 7317.158526769277, 5427.755750991294, 5527.170924361378, 5539.473749993906, 5540.335159780852, 5548.389677135431, 6308.621482710869, 6308.968455157695, 6368.77709280173, 6391.936080639134, 6428.453581445442, 5892.587518873809, 5962.314333851663, 5967.31375891778, 6014.097885317237, 6098.26820781509, 5848.53211743051, 5872.5301975842685, 5880.911786323294, 5909.763609455574, 5979.222701048836, 5878.617889837147, 5958.076498142795, 5959.553033522417, 5974.044152935509, 5976.61152025117, 5378.757955891916, 5390.703511306916, 5424.159255315432, 5438.2386465894015, 5448.972755136199, 5497.45025497447, 5506.889862202654, 5525.11598144295, 5538.91691624634, 5539.0], "ext.html": [452.4389756701691, 458.8256462544235, 463.85388602590183, 480.66593717366425, 486.5110563883297, 26658.0, 32809.67190328096, 33469.0, 33954.15114622136, 34216.48675269873, 36549.634503654954, 36563.81718091413, 36836.0, 37010.07474813131, 37086.0, 6738.427233685118, 7686.730964416232, 7853.214678532129, 7860.764177074669, 7941.920580794204, 6744.156980377453, 6854.383105520502, 9247.352685312031, 9466.337356385056, 9608.135267825894, 9316.441013539175, 9348.906510934872, 9365.719028429157, 9428.528573571328, 9462.243020558373, 6965.164180298397, 7132.358087772125, 9132.36073474857, 9282.582283797212, 9344.953275233649, 6925.065116209297, 9262.768430789216, 9380.90619093807, 9451.385659932082, 9484.0, 33798.1550461238, 33896.0, 34331.4850277246, 34364.0, 34881.30237395263, 2415.359929618635, 2567.0373609896287, 2687.543117670001, 2798.720127987205, 2878.8848446062134, 22529.528681110085, 23701.407464813346, 23725.644115338284, 23829.0, 24517.0, 2003.9098240579062, 2020.8484363672783, 2050.0877109686194, 2074.968875466869, 2137.3694760045823, 224953.0, 225615.0, 226149.86925065433, 227496.0, 227798.0, 52101.0, 52903.0, 52943.47056529386, 52998.470015300125, 53185.2022219667, 47411.28883066757, 48600.0, 48871.75564122156, 60052.0, 61015.0, 12497.937510312571, 12582.37088145589, 12746.80879786804, 12776.808347874789, 12877.935610321889, 9384.202342800801, 9523.380980236263, 9549.856752148724, 9559.90440095604, 9568.282378821477, 17375.47873563795, 17608.38370657021, 17647.64704705899, 17688.11559422024, 17806.821931780516, 7089.0, 7264.455165862581, 7280.235575264627, 7310.122785265802, 7321.560706357635, 753.4913933095139, 773.9148693643695, 874.6719980007497, 922.0548937339147, 972.7130496503548, 23077.653835192486, 23540.76459235386, 23633.172838950555, 23633.645495317585, 23840.761592383853, 860.359032520776, 870.7377387687236, 880.4409200157946, 922.239152699026, 966.8066386722684, 12394.62816115518, 12399.194052386747, 12466.75066498665, 12496.68758281032, 12507.624771256877, 258287.0, 263523.0, 264535.0, 264796.0, 266321.0, 47007.76496117497, 47494.287585686245, 47569.52430475651, 47687.761561191975, 47702.99999999931, 1129.7514546799691, 1139.1797905508022, 1161.651504548649, 1165.551262763825, 1166.935818529989, 23247.651285230397, 24009.759902400754, 26024.0, 26746.0, 27092.0, 44397.0, 45084.09831803411, 45237.0, 45289.32066018946, 45338.0, 212105.0, 226186.0, 230497.0, 239319.0, 248556.0, 35076.78522537709, 35352.0, 35583.0, 35950.46074308835, 36089.0, 37734.0, 38007.42988855114, 38104.80947595244, 38517.80741096276, 38831.41752873766, 30039.849800750857, 31594.0, 31867.521987170676, 31939.36121277515, 32004.839975799972, 30835.383292334478, 31386.372272554876, 31598.36803263876, 31655.05034848958, 31946.68053319437, 31205.219869503446, 31667.0, 31870.52194217042, 31886.52170217402, 31935.201619958756, 26306.0, 27549.449011019267, 27781.44437111287, 27858.86070569634, 28459.0, 20807.583848322647, 20897.89551052235, 20936.68594971107, 20950.685739714223, 20970.47573810667], "prototype.html": [250.23677782762573, 254.1511352084038, 257.8130855130031, 261.2358850362689, 262.40434214333465, 4979.278004689318, 5042.4453310135905, 5061.9746901265535, 5064.898702025962, 5078.2382642603625, 4898.779554920028, 4954.900901981958, 5007.399112106543, 5019.7239151846725, 5040.949590504094, 3803.8588423472916, 3809.1619843634357, 3825.751326163804, 3833.2716783811125, 3836.846526138951, 3671.1005803578028, 3722.9441558376648, 3752.0, 3810.5427348718194, 3819.178876541543, 3739.1399978005074, 3793.6775374093236, 3798.088458769903, 3821.14024344523, 3825.9426108608254, 3813.466114743938, 3816.8091595420256, 3825.8087095645246, 3826.215625796705, 3833.9424908626393, 3282.6224984126893, 3283.507473878937, 3291.703746662788, 3301.7028467437804, 3317.502374643823, 4851.442084160296, 4871.780769865364, 4887.437944636341, 4894.535019173209, 4900.191468407708, 4152.356384760367, 4208.3266677331785, 4217.030083080878, 4249.3413520904305, 4348.239058164809, 5155.304033955443, 5160.225966105077, 5163.870903227412, 5167.4057483389515, 5174.560162386202, 3276.7050965413227, 3313.8177400242976, 3454.6199918008997, 3464.497647841049, 3465.2722928185112, 5263.6578622389425, 5369.919451208235, 5431.945680543223, 5443.673379597237, 5468.316460442445, 3373.5614370131725, 3389.169653434875, 3389.254364039907, 3410.334984677964, 3418.7606867519034, 3453.4992426098074, 3456.3087382523595, 3477.4957631143343, 3478.4434490481403, 3480.0603836964383, 4123.237201117803, 4130.752154870717, 4132.607402296777, 4135.152293779768, 4159.168166366739, 5084.262781896604, 5173.81891633791, 5202.609804264695, 5213.165893457029, 5240.502152295526, 1262.6527704881232, 1276.961691149267, 1290.167841742071, 1290.6515240884908, 1292.4571679894466, 820.0528389709895, 820.3970081989733, 825.1830687619214, 835.7910522369408, 838.262329150356, 4979.427365852901, 4991.650584459053, 4992.201247800407, 4992.625553083533, 5010.624203184703, 5426.348838139448, 5433.918491222635, 5444.754986025639, 5448.45515448452, 5460.754266058037, 5050.4697006814495, 5051.62112841531, 5056.191009438546, 5059.569936555434, 5061.493850614909, 2914.0, 2972.390659914712, 2973.44991176633, 2986.4624367614038, 2995.99634122567, 5526.115821468546, 5528.723563821793, 5545.223668686387, 5571.164325351229, 5579.330480342385, 5469.863253418696, 5562.916556251659, 5572.554195664337, 5581.190727344593, 5585.497305242467, 5494.120940649477, 5539.307586551681, 5552.7223638817895, 5552.750126244409, 5558.805441809517, 5262.184361423985, 5433.293671822796, 5451.7274136292235, 5479.75341109659, 5512.889742205213, 5372.435894231049, 5376.220448035091, 5384.300040994645, 5387.542058925035, 5395.676259424447, 5344.812931547377, 5456.317960254968, 5463.562914966873, 5497.917531236954, 5609.0, 3506.4564992426212, 3516.0682419159457, 3547.467879818048, 3567.839447224933, 3584.6056933736745, 5415.0, 5441.591880609049, 5453.291072160594, 5467.562594992471, 5502.614816962774, 5265.183896496049, 5273.947260527346, 5279.683219006872, 5288.048151332797, 5302.469753024667, 5133.281340612392, 5254.894902102013, 5263.710495922761, 5264.710440925785, 5282.630215885005, 5140.30605868203, 5148.639595228298, 5157.742112894415, 5162.716050617102, 5176.275321454924, 5251.343582052244, 5283.128283833278, 5284.04887120322, 5287.048331300402, 5288.180332048385, 5054.014467179012, 5193.324867767166, 5219.243209734491, 5241.895162096813, 5257.316548848626], "yui.html": [569.8974184646763, 619.7582942652366, 623.2832242920638, 624.4972796898496, 634.0932466572805, 10891.346519208853, 11517.193796434243, 11523.539058437664, 11571.479283432245, 11616.01263892568, 9190.678326258583, 10655.04104630583, 10894.237403381767, 10922.399268040255, 11029.944850275757, 737.0639288104104, 756.1568850731422, 761.075293518375, 761.1399118995528, 761.6458346868704, 749.8275396658772, 757.1746795992367, 764.7017663111391, 764.8202672371988, 765.1697907770076, 750.7785203365021, 771.4021633234261, 775.5734346109646, 778.4084096086987, 780.1340512031641, 746.6490749347798, 770.8650986077414, 771.5370777533464, 776.095848336687, 778.8130848596353, 567.3957235544174, 575.315374704105, 575.9280089988752, 576.7318197038397, 577.1717585265116, 10003.149732272766, 10129.645462408855, 10135.341202821794, 10148.035936586013, 10149.797004059878, 8092.878606820902, 8264.093408094248, 8298.21166989135, 8697.0, 8863.822723545492, 7359.705611775523, 7360.705571777123, 7446.218147094585, 7477.962610186969, 7521.938153397159, 2632.8157029007975, 2695.0, 2733.371324595354, 2739.369944912681, 2792.9162125136277, 35498.11254718627, 35938.460923086175, 36765.26469470649, 38400.42399364012, 38611.613883861086, 7334.229905859915, 7463.365613922877, 7679.3856491481665, 7736.806579835549, 7917.049954005556, 16172.353105875869, 16224.756628650579, 16307.429239976544, 16315.836841631432, 16320.102394368187, 5831.912521312183, 5944.375840536768, 5957.165996760457, 5986.311574169026, 6229.221347331583, 3070.8973723351514, 3082.3681145365144, 3110.082525654892, 3128.139761565588, 3167.8732850686174, 2492.389364605683, 2500.437401584629, 2515.245426372081, 2535.77178053976, 2546.59254519276, 347.0352420271649, 351.46050812003455, 352.19347693781464, 357.65128999225544, 359.90282623691456, 382.254603523131, 388.5337594886091, 389.1050583657576, 402.141428051113, 428.38954489851835, 5960.612560183574, 6476.439555393694, 6555.934440655532, 6672.766453174116, 6770.729170833111, 480.7932588986769, 490.38174025715, 501.45341577680506, 506.74915916621507, 507.00120762098607, 2937.818329841864, 2992.7755418343277, 3092.7835051546176, 3092.7835051546626, 3240.4977228529615, 48522.75738621284, 48907.02185956261, 48908.51091489111, 48922.0, 49896.750516247186, 39274.41088383677, 39851.80074099669, 40184.799076004434, 41258.79370603188, 41950.79024604918, 34712.13219669528, 35391.823040885145, 37536.0, 37852.43221351682, 37855.62144378521, 6599.373059559334, 6674.866502670016, 6797.116374871235, 6834.589924604539, 6893.965530172317, 29085.563716543846, 29524.852375737984, 29697.554536681535, 29789.5531567031, 30273.0, 33150.668493314755, 33968.830155849064, 36609.0, 39972.800136000296, 39988.20023599453, 6194.163787888578, 6312.968435157794, 6333.778317758856, 6528.151340325728, 6694.0628312037325, 9373.1564159226, 9376.48429336393, 9412.0, 9532.608532803233, 9649.083337082966, 8901.0, 8903.109689031045, 8953.865692014755, 8989.370744048116, 9012.41419307743, 8936.329775267011, 8944.463332200088, 8959.641614335354, 8973.82052358936, 8989.730308090768, 8542.487450752975, 8737.694180703646, 8758.649654013769, 8820.2061814437, 8832.425892316978, 6764.898526522008, 7479.626018699152, 7599.696012159673, 7687.884681729666, 8036.316913062221, 6916.688749006407, 7465.141508726349, 7648.770536883902, 7882.487638303492, 7951.324137448381]}, "summary": {"lowerIsBetter": false, "suite": 5496.47942479267, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5633.632588003806, "unit": "ms", "value": 5633.632588003806}, "dojo.html": {"lowerIsBetter": false, "filtered": 4364.535110197369, "unit": "ms", "value": 4364.535110197369}, "mootools.html": {"lowerIsBetter": false, "filtered": 3624.3108125226727, "unit": "ms", "value": 3624.3108125226727}, "ext.html": {"lowerIsBetter": false, "filtered": 16020.890187836243, "unit": "ms", "value": 16020.890187836243}, "prototype.html": {"lowerIsBetter": false, "filtered": 3904.049955917759, "unit": "ms", "value": 3904.049955917759}, "yui.html": {"lowerIsBetter": false, "filtered": 4946.581950115558, "unit": "ms", "value": 4946.581950115558}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0021"}, "testrun": {"date": 1447287747, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111143931", "branch": "Mozilla-Inbound", "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5"}}, {"talos_counters": {}, "results": {"audio-dft": [195.0, 197.0, 198.0, 197.0, 198.0, 199.0, 196.0, 197.0, 189.0, 197.0], "ai-astar": [128.0, 133.0, 124.0, 132.0, 132.0, 132.0, 132.0, 132.0, 124.0, 131.0], "imaging-gaussian-blur": [142.0, 142.0, 142.0, 149.0, 142.0, 141.0, 149.0, 141.0, 148.0, 149.0], "audio-beat-detection": [189.0, 158.0, 193.0, 203.0, 157.0, 182.0, 181.0, 151.0, 200.0, 162.0], "json-stringify-tinderbox": [76.0, 77.0, 80.0, 83.0, 82.0, 81.0, 82.0, 81.0, 82.0, 82.0], "stanford-crypto-pbkdf2": [177.0, 175.0, 189.0, 192.0, 179.0, 194.0, 188.0, 190.0, 182.0, 189.0], "json-parse-financial": [66.0, 71.0, 72.0, 74.0, 73.0, 72.0, 71.0, 83.0, 71.0, 72.0], "stanford-crypto-sha256-iterative": [82.0, 85.0, 88.0, 88.0, 89.0, 88.0, 88.0, 88.0, 88.0, 89.0], "audio-fft": [91.0, 97.0, 104.0, 149.0, 83.0, 84.0, 87.0, 87.0, 140.0, 81.0], "imaging-darkroom": [155.0, 154.0, 162.0, 154.0, 154.0, 154.0, 148.0, 154.0, 155.0, 155.0], "stanford-crypto-ccm": [158.0, 155.0, 163.0, 152.0, 162.0, 151.0, 151.0, 162.0, 161.0, 156.0], "audio-oscillator": [118.0, 121.0, 165.0, 109.0, 109.0, 110.0, 154.0, 107.0, 107.0, 157.0], "stanford-crypto-aes": [103.0, 105.0, 104.0, 104.0, 105.0, 104.0, 109.0, 111.0, 105.0, 105.0], "imaging-desaturate": [123.0, 124.0, 129.0, 124.0, 125.0, 124.0, 124.0, 124.0, 123.0, 124.0]}, "summary": {"lowerIsBetter": true, "suite": 1841.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 100.3, "unit": "ms", "value": 100.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 185.5, "unit": "ms", "value": 185.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 177.6, "unit": "ms", "value": 177.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 157.1, "unit": "ms", "value": 157.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 154.5, "unit": "ms", "value": 154.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.5, "unit": "ms", "value": 72.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 125.7, "unit": "ms", "value": 125.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 130.0, "unit": "ms", "value": 130.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 196.3, "unit": "ms", "value": 196.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 87.3, "unit": "ms", "value": 87.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 80.6, "unit": "ms", "value": 80.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 144.5, "unit": "ms", "value": 144.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 105.5, "unit": "ms", "value": 105.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 124.4, "unit": "ms", "value": 124.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0021"}, "testrun": {"date": 1447287747, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111143931", "branch": "Mozilla-Inbound", "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5"}}, {"talos_counters": {}, "results": {"DeltaBlue": [231.16042533518262], "Encrypt": [384.9114703618168], "NavierStokes": [6993.006993006993], "Decrypt": [7013.986013986014], "Splay": [821.0180623973728], "Richards": [202.5931928687196], "RegExp": [36285.71428571428], "Earley": [940.7337723424271], "Boyer": [15584.615384615385], "RayTrace": [2290.6178489702515]}, "summary": {"lowerIsBetter": false, "suite": 15323.570534438753, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 286.0264679999999, "unit": "score", "value": 286.0264679999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 691.5382379999998, "unit": "score", "value": 691.5382379999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 212.21200000000007, "unit": "score", "value": 212.21200000000007}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.95003290129611, "unit": "score", "value": 37.95003290129611}, "Splay": {"lowerIsBetter": false, "filtered": 99.256038, "unit": "score", "value": 99.256038}, "RegExp": {"lowerIsBetter": false, "filtered": 25.105885826771676, "unit": "score", "value": 25.105885826771676}, "Richards": {"lowerIsBetter": false, "filtered": 174.25067200000004, "unit": "score", "value": 174.25067200000004}, "Earley": {"lowerIsBetter": false, "filtered": 708.4501690000002, "unit": "score", "value": 708.4501690000002}, "Boyer": {"lowerIsBetter": false, "filtered": 42.76416090819347, "unit": "score", "value": 42.76416090819347}, "RayTrace": {"lowerIsBetter": false, "filtered": 323.05214085914093, "unit": "score", "value": 323.05214085914093}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0021"}, "testrun": {"date": 1447287747, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111143931", "branch": "Mozilla-Inbound", "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5"}}] 16:42:49 INFO - RETURN: dromaeo_css: 5496.48 16:42:49 INFO - RETURN: kraken: 1841.80 16:42:49 INFO - RETURN: v8_7: 15323.57 16:42:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15323.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1841.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5496.48"}}} 16:42:49 INFO - Return code: 0 16:42:49 INFO - # TBPL SUCCESS # 16:42:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:42:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:42:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:42:49 INFO - 2015-11-11 16:42:49.103 screenresolution[2239:17174] starting screenresolution argv=screenresolution get 16:42:49 INFO - 2015-11-11 16:42:49.107 screenresolution[2239:17174] Display 0: 1600x1200x32@60 16:42:49 INFO - 2015-11-11 16:42:49.114 screenresolution[2240:17178] starting screenresolution argv=screenresolution list 16:42:49 INFO - Available Modes on Display 0 16:42:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:42:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:42:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:42:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:42:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:42:49 INFO - Intel HD Graphics 3000: 16:42:49 INFO - Chipset Model: Intel HD Graphics 3000 16:42:49 INFO - Type: GPU 16:42:49 INFO - Bus: Built-In 16:42:49 INFO - VRAM (Total): 512 MB 16:42:49 INFO - VRAM (Dynamic, Max): 10 16:42:49 INFO - Vendor: Intel (0x8086) 16:42:49 INFO - Device ID: 0x0116 16:42:49 INFO - Revision ID: 0x0009 16:42:49 INFO - Displays: 16:42:49 INFO - Display: 16:42:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:42:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:42:49 INFO - Display Serial Number: 1600x1200 60 16:42:49 INFO - Main Display: Yes 16:42:49 INFO - Mirror: Off 16:42:49 INFO - Online: Yes 16:42:49 INFO - Rotation: Supported 16:42:49 INFO - Return code: 0 16:42:49 INFO - Running post-action listener: _resource_record_post_action 16:42:49 INFO - Running post-run listener: _resource_record_post_run 16:42:50 INFO - Total resource usage - Wall time: 1266s; CPU: 30.0%; Read bytes: 45056; Write bytes: 687641600; Read time: 298; Write time: 62168 16:42:50 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 334430720; Write bytes: 334440448; Read time: 36961; Write time: 6058 16:42:50 INFO - run-tests - Wall time: 1223s; CPU: 30.0%; Read bytes: 45056; Write bytes: 342850560; Read time: 298; Write time: 55238 16:42:50 INFO - Running post-run listener: _upload_blobber_files 16:42:50 INFO - Blob upload gear active. 16:42:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:42:50 INFO - Copying logs to upload dir... 16:42:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1320.819788 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-11 16:42:50.672149) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 16:42:50.673298) ========= 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.4YYhmWRWNe/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.y27H4j4G1H/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/ah5o_EpNQ1qwSm4TYzqj3Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 16:42:50.722632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:42:50.723055) ========= 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.4YYhmWRWNe/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.y27H4j4G1H/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005774 ========= master_lag: 0.19 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:42:50.915562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 16:42:50.915888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 16:42:50.919649) ========= ========= Total master_lag: 4.26 =========