builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0016 starttime: 1448029120.25 results: success (0) buildid: 20151120041233 builduid: b70b88be3af44ce8b2ffa292c6c0dc86 revision: 1b2e15608f34fef0f23369731c80138f55f00cf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.246790) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.247208) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.247491) ========= 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.xPUomqCbMK/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.oMyT1DU6zS/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005594 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.267429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.267715) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.286521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.286852) ========= 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.xPUomqCbMK/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.oMyT1DU6zS/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005593 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.335639) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.335950) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.336301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.336601) ========= 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.xPUomqCbMK/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.oMyT1DU6zS/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-20 06:18:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-20 06:18:40 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217646 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.567445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.567755) ========= 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.xPUomqCbMK/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.oMyT1DU6zS/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019521 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:40.619608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 06:18:40.623007) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-20 06:18:40,694 truncating revision to first 12 chars 2015-11-20 06:18:40,694 Setting DEBUG logging. 2015-11-20 06:18:40,694 attempt 1/10 2015-11-20 06:18:40,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1b2e15608f34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 06:18:41,553 unpacking tar archive at: mozilla-central-1b2e15608f34/testing/mozharness/ program finished with exit code 0 elapsedTime=1.103707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 06:18:41.740738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:41.744083) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:41.758368) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:41.758670) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 06:18:41.759111) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-20 06:18:41.759397) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:18:41 INFO - MultiFileLogger online at 20151120 06:18:41 in /builds/slave/test 06:18:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:18:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:18:41 INFO - {'append_to_log': False, 06:18:41 INFO - 'base_work_dir': '/builds/slave/test', 06:18:41 INFO - 'blob_upload_branch': 'Firefox', 06:18:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:18:41 INFO - 'branch': 'Firefox', 06:18:41 INFO - 'buildbot_json_path': 'buildprops.json', 06:18:41 INFO - 'config_files': ('talos/mac_config.py',), 06:18:41 INFO - 'default_actions': ('clobber', 06:18:41 INFO - 'read-buildbot-config', 06:18:41 INFO - 'download-and-extract', 06:18:41 INFO - 'populate-webroot', 06:18:41 INFO - 'create-virtualenv', 06:18:41 INFO - 'install', 06:18:41 INFO - 'run-tests'), 06:18:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:18:41 INFO - 'download_minidump_stackwalk': True, 06:18:41 INFO - 'download_symbols': 'ondemand', 06:18:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:18:41 INFO - 'tooltool.py': '/tools/tooltool.py', 06:18:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:18:41 INFO - '/tools/misc-python/virtualenv.py')}, 06:18:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:18:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:18:41 INFO - 'installer_path': 'installer.exe', 06:18:41 INFO - 'log_level': 'info', 06:18:41 INFO - 'log_name': 'talos', 06:18:41 INFO - 'log_to_console': True, 06:18:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:18:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:18:41 INFO - 'opt_config_files': (), 06:18:41 INFO - 'pip_index': False, 06:18:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:18:41 INFO - 'cmd': ('bash', 06:18:41 INFO - '-c', 06:18:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:18:41 INFO - 'enabled': True, 06:18:41 INFO - 'halt_on_failure': False, 06:18:41 INFO - 'name': 'check_screen_resolution'},), 06:18:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:18:41 INFO - 'cmd': ('bash', 06:18:41 INFO - '-c', 06:18:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:18:41 INFO - 'enabled': True, 06:18:41 INFO - 'halt_on_failure': False, 06:18:41 INFO - 'name': 'check_screen_resolution'},), 06:18:41 INFO - 'run_cmd_checks_enabled': True, 06:18:41 INFO - 'sps_profile': False, 06:18:41 INFO - 'sps_profile_interval': 0, 06:18:41 INFO - 'suite': 'dromaeojs-e10s', 06:18:41 INFO - 'system_bits': '64', 06:18:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:18:41 INFO - 'title': 't-yosemite-r7-0016', 06:18:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:18:41 INFO - 'use_talos_json': True, 06:18:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:18:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:18:41 INFO - 'work_dir': 'build'} 06:18:41 INFO - ##### 06:18:41 INFO - ##### Running clobber step. 06:18:41 INFO - ##### 06:18:41 INFO - Running pre-action listener: _resource_record_pre_action 06:18:41 INFO - Running main action method: clobber 06:18:41 INFO - rmtree: /builds/slave/test/build 06:18:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:18:43 INFO - Running post-action listener: _resource_record_post_action 06:18:43 INFO - ##### 06:18:43 INFO - ##### Running read-buildbot-config step. 06:18:43 INFO - ##### 06:18:43 INFO - Running pre-action listener: _resource_record_pre_action 06:18:43 INFO - Running main action method: read_buildbot_config 06:18:43 INFO - Using buildbot properties: 06:18:43 INFO - { 06:18:43 INFO - "properties": { 06:18:43 INFO - "buildnumber": 3, 06:18:43 INFO - "product": "firefox", 06:18:43 INFO - "script_repo_revision": "production", 06:18:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:18:43 INFO - "repository": "", 06:18:43 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:18:43 INFO - "buildid": "20151120041233", 06:18:43 INFO - "slavename": "t-yosemite-r7-0016", 06:18:43 INFO - "pgo_build": "False", 06:18:43 INFO - "basedir": "/builds/slave/test", 06:18:43 INFO - "project": "", 06:18:43 INFO - "platform": "yosemite_r7", 06:18:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:18:43 INFO - "slavebuilddir": "test", 06:18:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:18:43 INFO - "branch": "mozilla-central", 06:18:43 INFO - "repo_path": "mozilla-central", 06:18:43 INFO - "stage_platform": "macosx64", 06:18:43 INFO - "builduid": "b70b88be3af44ce8b2ffa292c6c0dc86", 06:18:43 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 06:18:43 INFO - }, 06:18:43 INFO - "sourcestamp": { 06:18:43 INFO - "repository": "", 06:18:43 INFO - "hasPatch": false, 06:18:43 INFO - "project": "", 06:18:43 INFO - "branch": "mozilla-central-macosx64-talos", 06:18:43 INFO - "changes": [ 06:18:43 INFO - { 06:18:43 INFO - "category": null, 06:18:43 INFO - "files": [ 06:18:43 INFO - { 06:18:43 INFO - "url": null, 06:18:43 INFO - "name": "https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 06:18:43 INFO - } 06:18:43 INFO - ], 06:18:43 INFO - "repository": "", 06:18:43 INFO - "rev": "1b2e15608f34fef0f23369731c80138f55f00cf2", 06:18:43 INFO - "who": "cbook@mozilla.com", 06:18:43 INFO - "when": 1448027971, 06:18:43 INFO - "number": 6688504, 06:18:43 INFO - "comments": "Merge m-c to f-t", 06:18:43 INFO - "project": "", 06:18:43 INFO - "at": "Fri 20 Nov 2015 05:59:31", 06:18:43 INFO - "branch": "mozilla-central-macosx64-talos", 06:18:43 INFO - "revlink": "", 06:18:43 INFO - "properties": [ 06:18:43 INFO - [ 06:18:43 INFO - "buildid", 06:18:43 INFO - "20151120041233", 06:18:43 INFO - "Change" 06:18:43 INFO - ], 06:18:43 INFO - [ 06:18:43 INFO - "builduid", 06:18:43 INFO - "b70b88be3af44ce8b2ffa292c6c0dc86", 06:18:43 INFO - "Change" 06:18:43 INFO - ], 06:18:43 INFO - [ 06:18:43 INFO - "pgo_build", 06:18:43 INFO - "False", 06:18:43 INFO - "Change" 06:18:43 INFO - ] 06:18:43 INFO - ], 06:18:43 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 06:18:43 INFO - } 06:18:43 INFO - ], 06:18:43 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 06:18:43 INFO - } 06:18:43 INFO - } 06:18:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 06:18:43 INFO - Running post-action listener: _resource_record_post_action 06:18:43 INFO - ##### 06:18:43 INFO - ##### Running download-and-extract step. 06:18:43 INFO - ##### 06:18:43 INFO - Running pre-action listener: _resource_record_pre_action 06:18:43 INFO - Running main action method: download_and_extract 06:18:43 INFO - mkdir: /builds/slave/test/build/tests 06:18: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')]} 06:18:43 INFO - https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/test_packages.json 06:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/test_packages.json 06:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:18:44 INFO - Downloaded 1149 bytes. 06:18:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:18:44 INFO - Using the following test package requirements: 06:18:44 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:18:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:18:44 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 06:18:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:18:44 INFO - u'jsshell-mac.zip'], 06:18:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:18:44 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 06:18:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:18:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:18:44 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 06:18:44 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:18:44 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 06:18:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:18:44 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 06:18:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:18:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:18:44 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 06:18:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:44 INFO - https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:18:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:18:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:18:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/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 06:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/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 06:18:45 INFO - Downloaded 17525176 bytes. 06:18:45 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 06:18:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:18:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 06:18:48 INFO - Return code: 0 06:18:48 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 06:18:48 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')]} 06:18:48 INFO - https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:18:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:18:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:18:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/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 06:18:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/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 06:18:49 INFO - Downloaded 17525176 bytes. 06:18:49 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 06:18:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:18:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 06:18:52 INFO - Return code: 0 06:18: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')]} 06:18:52 INFO - https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/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 06:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/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 06:18:53 INFO - Downloaded 11130997 bytes. 06:18:53 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 06:18:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:18:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 06:18:53 INFO - Return code: 0 06:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:53 INFO - https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:18:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:18:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:18:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 06:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JIJSHnNWR3G174Dj-_JmzA/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 06:18:56 INFO - Downloaded 109422023 bytes. 06:18:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:18:56 INFO - mkdir: /builds/slave/test/properties 06:18:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:56 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:56 INFO - Contents: 06:18:56 INFO - build_url:https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:18:56 INFO - Running post-action listener: _resource_record_post_action 06:18:56 INFO - Running post-action listener: set_extra_try_arguments 06:18:56 INFO - ##### 06:18:56 INFO - ##### Running populate-webroot step. 06:18:56 INFO - ##### 06:18:56 INFO - Running pre-action listener: _resource_record_pre_action 06:18:56 INFO - Running main action method: populate_webroot 06:18:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:18:56 INFO - '../fennec_ids.txt'], 06:18:56 INFO - 'tests': ['tcheck2']}, 06:18:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:56 INFO - '--tppagecycles', 06:18:56 INFO - '7'], 06:18:56 INFO - 'tests': ['tsvgm']}}, 06:18:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:18:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:18:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:18:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:56 INFO - 'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:56 INFO - 'tests': ['damp', 'tps']}, 06:18:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:56 INFO - 'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['damp', 'tps']}, 06:18:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:18:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:56 INFO - 'other': {'tests': ['a11yr', 06:18:56 INFO - 'ts_paint', 06:18:56 INFO - 'tpaint', 06:18:56 INFO - 'sessionrestore', 06:18:56 INFO - 'sessionrestore_no_auto_restore']}, 06:18:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['a11yr', 06:18:56 INFO - 'ts_paint', 06:18:56 INFO - 'tpaint', 06:18:56 INFO - 'sessionrestore', 06:18:56 INFO - 'sessionrestore_no_auto_restore']}, 06:18:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['a11yr', 06:18:56 INFO - 'ts_paint', 06:18:56 INFO - 'tpaint', 06:18:56 INFO - 'sessionrestore', 06:18:56 INFO - 'sessionrestore_no_auto_restore']}, 06:18:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['a11yr', 06:18:56 INFO - 'ts_paint', 06:18:56 INFO - 'tpaint', 06:18:56 INFO - 'sessionrestore', 06:18:56 INFO - 'sessionrestore_no_auto_restore']}, 06:18:56 INFO - 'other_l64': {'tests': ['a11yr', 06:18:56 INFO - 'ts_paint', 06:18:56 INFO - 'tpaint', 06:18:56 INFO - 'sessionrestore', 06:18:56 INFO - 'sessionrestore_no_auto_restore']}, 06:18:56 INFO - 'other_nol64': {'tests': ['a11yr', 06:18:56 INFO - 'ts_paint', 06:18:56 INFO - 'tpaint', 06:18:56 INFO - 'sessionrestore', 06:18:56 INFO - 'sessionrestore_no_auto_restore']}, 06:18:56 INFO - 'svgr': {'tests': ['tsvgx', 06:18:56 INFO - 'tsvgr_opacity', 06:18:56 INFO - 'tart', 06:18:56 INFO - 'tscrollx', 06:18:56 INFO - 'cart']}, 06:18:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['tsvgx', 06:18:56 INFO - 'tsvgr_opacity', 06:18:56 INFO - 'tart', 06:18:56 INFO - 'tscrollx', 06:18:56 INFO - 'cart']}, 06:18:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:56 INFO - 'tests': ['tp5o']}, 06:18:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:56 INFO - 'talos_options': ['--e10s'], 06:18:56 INFO - 'tests': ['tp5o']}, 06:18:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:56 INFO - 'talos_options': ['--xperf_path', 06:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:56 INFO - 'tests': ['tp5n']}, 06:18:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:56 INFO - 'talos_options': ['--e10s', 06:18:56 INFO - '--xperf_path', 06:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:56 INFO - 'tests': ['tp5n']}}, 06:18:56 INFO - 'talos.zip': {'path': '', 06:18:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:56 INFO - Running post-action listener: _resource_record_post_action 06:18:56 INFO - ##### 06:18:56 INFO - ##### Running create-virtualenv step. 06:18:56 INFO - ##### 06:18:56 INFO - Running pre-action listener: _resource_record_pre_action 06:18:56 INFO - Running main action method: create_virtualenv 06:18:56 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:56 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 06:18:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:56 INFO - Using real prefix '/tools/python27' 06:18:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:57 INFO - Installing distribute.............................................................................................................................................................................................done. 06:19:00 INFO - Installing pip.................done. 06:19:00 INFO - Return code: 0 06:19:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:19:00 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')]} 06:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:00 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')]} 06:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:00 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 0x10fcdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc168d80260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc039f0>, '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 0x10f962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:19:00 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 06:19:00 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 06:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/Render', 06:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:00 INFO - 'HOME': '/Users/cltbld', 06:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:00 INFO - 'LOGNAME': 'cltbld', 06:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:00 INFO - 'MOZ_NO_REMOTE': '1', 06:19:00 INFO - 'NO_EM_RESTART': '1', 06:19:00 INFO - 'PAGER': '/bin/cat', 06:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:00 INFO - 'PWD': '/builds/slave/test', 06:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:00 INFO - 'SHELL': '/bin/bash', 06:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMyT1DU6zS/Listeners', 06:19:00 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 06:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:00 INFO - 'USER': 'cltbld', 06:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:00 INFO - 'XPC_FLAGS': '0x0', 06:19:00 INFO - 'XPC_SERVICE_NAME': '0', 06:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:00 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 06:19:00 INFO - Cleaning up... 06:19:00 INFO - Return code: 0 06:19:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:19:00 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')]} 06:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:00 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')]} 06:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:00 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 0x10fcdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc168d80260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc039f0>, '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 0x10f962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:19:00 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 06:19:00 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 06:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/Render', 06:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:00 INFO - 'HOME': '/Users/cltbld', 06:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:00 INFO - 'LOGNAME': 'cltbld', 06:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:00 INFO - 'MOZ_NO_REMOTE': '1', 06:19:00 INFO - 'NO_EM_RESTART': '1', 06:19:00 INFO - 'PAGER': '/bin/cat', 06:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:00 INFO - 'PWD': '/builds/slave/test', 06:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:00 INFO - 'SHELL': '/bin/bash', 06:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMyT1DU6zS/Listeners', 06:19:00 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 06:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:00 INFO - 'USER': 'cltbld', 06:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:00 INFO - 'XPC_FLAGS': '0x0', 06:19:00 INFO - 'XPC_SERVICE_NAME': '0', 06:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:00 INFO - Downloading/unpacking psutil>=0.7.1 06:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:19:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:03 INFO - Installing collected packages: psutil 06:19:03 INFO - Running setup.py install for psutil 06:19:03 INFO - building 'psutil._psutil_osx' extension 06:19:03 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 06:19:03 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 06:19:03 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 06:19:04 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 06:19:04 INFO - building 'psutil._psutil_posix' extension 06:19:04 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 06:19:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:19:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:19:04 INFO - ^ 06:19:04 INFO - 1 warning generated. 06:19:04 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 06:19:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:04 INFO - Successfully installed psutil 06:19:04 INFO - Cleaning up... 06:19:04 INFO - Return code: 0 06:19:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:19:04 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')]} 06:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:04 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')]} 06:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:04 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 0x10fcdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc168d80260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc039f0>, '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 0x10f962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:19:04 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 06:19:04 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 06:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/Render', 06:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:04 INFO - 'HOME': '/Users/cltbld', 06:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:04 INFO - 'LOGNAME': 'cltbld', 06:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:04 INFO - 'MOZ_NO_REMOTE': '1', 06:19:04 INFO - 'NO_EM_RESTART': '1', 06:19:04 INFO - 'PAGER': '/bin/cat', 06:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:04 INFO - 'PWD': '/builds/slave/test', 06:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:04 INFO - 'SHELL': '/bin/bash', 06:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMyT1DU6zS/Listeners', 06:19:04 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 06:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:04 INFO - 'USER': 'cltbld', 06:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:04 INFO - 'XPC_FLAGS': '0x0', 06:19:04 INFO - 'XPC_SERVICE_NAME': '0', 06:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:19:04 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 06:19:04 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 06:19:04 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 06:19:04 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 06:19:04 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 06:19:04 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 06:19:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:19:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:19:06 INFO - Installing collected packages: mozsystemmonitor 06:19:06 INFO - Running setup.py install for mozsystemmonitor 06:19:07 INFO - Successfully installed mozsystemmonitor 06:19:07 INFO - Cleaning up... 06:19:07 INFO - Return code: 0 06:19:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:07 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 0x10fcdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc168d80260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc039f0>, '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 0x10f962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:19:07 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 06:19:07 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 06:19:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/Render', 06:19:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:07 INFO - 'HOME': '/Users/cltbld', 06:19:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:07 INFO - 'LOGNAME': 'cltbld', 06:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:07 INFO - 'MOZ_NO_REMOTE': '1', 06:19:07 INFO - 'NO_EM_RESTART': '1', 06:19:07 INFO - 'PAGER': '/bin/cat', 06:19:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:07 INFO - 'PWD': '/builds/slave/test', 06:19:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:07 INFO - 'SHELL': '/bin/bash', 06:19:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMyT1DU6zS/Listeners', 06:19:07 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 06:19:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:07 INFO - 'USER': 'cltbld', 06:19:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:07 INFO - 'XPC_FLAGS': '0x0', 06:19:07 INFO - 'XPC_SERVICE_NAME': '0', 06:19:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:07 INFO - Downloading/unpacking blobuploader==1.2.4 06:19:07 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 06:19:07 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 06:19:07 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 06:19:07 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 06:19:07 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 06:19:07 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 06:19:09 INFO - Downloading blobuploader-1.2.4.tar.gz 06:19:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:19:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:19:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:19:10 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 06:19:10 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 06:19:10 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 06:19:10 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 06:19:10 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 06:19:10 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 06:19:10 INFO - Downloading docopt-0.6.1.tar.gz 06:19:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:19:10 INFO - Installing collected packages: blobuploader, requests, docopt 06:19:10 INFO - Running setup.py install for blobuploader 06:19:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:19:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:19:10 INFO - Running setup.py install for requests 06:19:11 INFO - Running setup.py install for docopt 06:19:11 INFO - Successfully installed blobuploader requests docopt 06:19:11 INFO - Cleaning up... 06:19:11 INFO - Return code: 0 06:19:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:11 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 0x10fcdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc168d80260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc039f0>, '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 0x10f962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:19:11 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 06:19:11 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 06:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/Render', 06:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:11 INFO - 'HOME': '/Users/cltbld', 06:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:11 INFO - 'LOGNAME': 'cltbld', 06:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:11 INFO - 'MOZ_NO_REMOTE': '1', 06:19:11 INFO - 'NO_EM_RESTART': '1', 06:19:11 INFO - 'PAGER': '/bin/cat', 06:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:11 INFO - 'PWD': '/builds/slave/test', 06:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:11 INFO - 'SHELL': '/bin/bash', 06:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMyT1DU6zS/Listeners', 06:19:11 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 06:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:11 INFO - 'USER': 'cltbld', 06:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:11 INFO - 'XPC_FLAGS': '0x0', 06:19:11 INFO - 'XPC_SERVICE_NAME': '0', 06:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-gKo_E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-n_JwF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-YJof6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-3Ndrtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-eqRecK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-VmLoIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-27yQwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-BaruY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-7XjHhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Z_Gv9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-n1DV6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-JMJ2tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:13 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-GnX06V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:13 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-_lNafS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:13 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-U9wMhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:13 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-mpNj7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:13 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-zMXNok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:19:13 INFO - Running setup.py install for manifestparser 06:19:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:19:13 INFO - Running setup.py install for mozcrash 06:19:13 INFO - Running setup.py install for mozdebug 06:19:13 INFO - Running setup.py install for mozdevice 06:19:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:19:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:19:14 INFO - Running setup.py install for mozfile 06:19:14 INFO - Running setup.py install for mozhttpd 06:19:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:19:14 INFO - Running setup.py install for mozinfo 06:19:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:19:14 INFO - Running setup.py install for mozInstall 06:19:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:19:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:19:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:19:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:19:14 INFO - Running setup.py install for mozleak 06:19:14 INFO - Running setup.py install for mozlog 06:19:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:19:15 INFO - Running setup.py install for moznetwork 06:19:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:19:15 INFO - Running setup.py install for mozprocess 06:19:15 INFO - Running setup.py install for mozprofile 06:19:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:19:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:19:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:19:15 INFO - Running setup.py install for mozrunner 06:19:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:19:15 INFO - Running setup.py install for mozscreenshot 06:19:15 INFO - Running setup.py install for moztest 06:19:15 INFO - Running setup.py install for mozversion 06:19:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:19:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:19:16 INFO - Cleaning up... 06:19:16 INFO - Return code: 0 06:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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', '-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 0x10fcdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc168d80260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc039f0>, '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 0x10f962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:19:16 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 06:19:16 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 06:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/Render', 06:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:16 INFO - 'HOME': '/Users/cltbld', 06:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:16 INFO - 'LOGNAME': 'cltbld', 06:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:16 INFO - 'MOZ_NO_REMOTE': '1', 06:19:16 INFO - 'NO_EM_RESTART': '1', 06:19:16 INFO - 'PAGER': '/bin/cat', 06:19:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:16 INFO - 'PWD': '/builds/slave/test', 06:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:16 INFO - 'SHELL': '/bin/bash', 06:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMyT1DU6zS/Listeners', 06:19:16 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 06:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:16 INFO - 'USER': 'cltbld', 06:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:16 INFO - 'XPC_FLAGS': '0x0', 06:19:16 INFO - 'XPC_SERVICE_NAME': '0', 06:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-l5NSZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:16 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)) 06:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-eQN58H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:16 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)) 06:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-A8ZOjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:16 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)) 06:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-YDGrKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:16 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)) 06:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-PIN7eV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:16 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)) 06:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Y9yyTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-WYs8p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-gJEgiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-vQLaO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-vs_raR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-qLMIPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-9quA_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-DDRd_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-fXeq7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-6MczJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:17 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)) 06:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-PIyzMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:18 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)) 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-uWH9eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:18 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)) 06:19:18 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)) 06:19:18 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)) 06:19:18 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)) 06:19:18 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)) 06:19:18 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)) 06:19:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:20 INFO - Downloading blessings-1.5.1.tar.gz 06:19:20 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 06:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:19:20 INFO - Installing collected packages: blessings 06:19:20 INFO - Running setup.py install for blessings 06:19:20 INFO - Successfully installed blessings 06:19:20 INFO - Cleaning up... 06:19:20 INFO - Return code: 0 06:19:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:20 INFO - Reading from file tmpfile_stdout 06:19:20 INFO - Current package versions: 06:19:20 INFO - blessings == 1.5.1 06:19:20 INFO - blobuploader == 1.2.4 06:19:20 INFO - docopt == 0.6.1 06:19:20 INFO - manifestparser == 1.1 06:19:20 INFO - mozInstall == 1.12 06:19:20 INFO - mozcrash == 0.16 06:19:20 INFO - mozdebug == 0.1 06:19:20 INFO - mozdevice == 0.47 06:19:20 INFO - mozfile == 1.2 06:19:20 INFO - mozhttpd == 0.7 06:19:20 INFO - mozinfo == 0.9 06:19:20 INFO - mozleak == 0.1 06:19:20 INFO - mozlog == 3.0 06:19:20 INFO - moznetwork == 0.27 06:19:20 INFO - mozprocess == 0.22 06:19:20 INFO - mozprofile == 0.27 06:19:20 INFO - mozrunner == 6.11 06:19:20 INFO - mozscreenshot == 0.1 06:19:20 INFO - mozsystemmonitor == 0.0 06:19:20 INFO - moztest == 0.7 06:19:20 INFO - mozversion == 1.4 06:19:20 INFO - psutil == 3.1.1 06:19:20 INFO - requests == 1.2.3 06:19:20 INFO - wsgiref == 0.1.2 06:19:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:20 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 0x10fcdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc168d80260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc039f0>, '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 0x10f962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/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.oMyT1DU6zS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:19:20 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 06:19:20 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 06:19:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/Render', 06:19:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:20 INFO - 'HOME': '/Users/cltbld', 06:19:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:20 INFO - 'LOGNAME': 'cltbld', 06:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:20 INFO - 'MOZ_NO_REMOTE': '1', 06:19:20 INFO - 'NO_EM_RESTART': '1', 06:19:20 INFO - 'PAGER': '/bin/cat', 06:19:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:20 INFO - 'PWD': '/builds/slave/test', 06:19:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:20 INFO - 'SHELL': '/bin/bash', 06:19:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMyT1DU6zS/Listeners', 06:19:20 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 06:19:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:20 INFO - 'USER': 'cltbld', 06:19:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:20 INFO - 'XPC_FLAGS': '0x0', 06:19:20 INFO - 'XPC_SERVICE_NAME': '0', 06:19:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 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)) 06:19:21 INFO - Cleaning up... 06:19:21 INFO - Return code: 0 06:19:21 INFO - Running post-action listener: _resource_record_post_action 06:19:21 INFO - Running post-action listener: _start_resource_monitoring 06:19:21 INFO - Starting resource monitoring. 06:19:21 INFO - ##### 06:19:21 INFO - ##### Running install step. 06:19:21 INFO - ##### 06:19:21 INFO - Running pre-action listener: _resource_record_pre_action 06:19:21 INFO - Running main action method: install 06:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:21 INFO - Reading from file tmpfile_stdout 06:19:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:19:21 INFO - Reading from file tmpfile_stdout 06:19:21 INFO - Output received: 06:19:21 INFO - Usage: mozinstall [options] installer 06:19:21 INFO - Options: 06:19:21 INFO - -h, --help show this help message and exit 06:19:21 INFO - -d DEST, --destination=DEST 06:19:21 INFO - Directory to install application into. [default: 06:19:21 INFO - "/builds/slave/test"] 06:19:21 INFO - --app=APP Application being installed. [default: firefox] 06:19:21 INFO - mkdir: /builds/slave/test/build/application 06:19:21 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'] 06:19:21 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 06:19:52 INFO - Reading from file tmpfile_stdout 06:19:52 INFO - Output received: 06:19:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:19:52 INFO - Running post-action listener: _resource_record_post_action 06:19:52 INFO - ##### 06:19:52 INFO - ##### Running run-tests step. 06:19:52 INFO - ##### 06:19:52 INFO - Running pre-action listener: _resource_record_pre_action 06:19:52 INFO - Running main action method: run_tests 06:19:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:19:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:19:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:19:52 INFO - 2015-11-20 06:19:52.555 screenresolution[2536:24592] starting screenresolution argv=screenresolution get 06:19:52 INFO - 2015-11-20 06:19:52.558 screenresolution[2536:24592] Display 0: 1600x1200x32@60 06:19:52 INFO - 2015-11-20 06:19:52.564 screenresolution[2537:24594] starting screenresolution argv=screenresolution list 06:19:52 INFO - Available Modes on Display 0 06:19:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:19:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:19:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:19:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:19:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:19:52 INFO - Intel Iris: 06:19:52 INFO - Chipset Model: Intel Iris 06:19:52 INFO - Type: GPU 06:19:52 INFO - Bus: Built-In 06:19:52 INFO - VRAM (Dynamic, Max): 1536 MB 06:19:52 INFO - Vendor: Intel (0x8086) 06:19:52 INFO - Device ID: 0x0a2e 06:19:52 INFO - Revision ID: 0x0009 06:19:52 INFO - Displays: 06:19:52 INFO - Display: 06:19:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:19:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:19:52 INFO - Display Serial Number: 1600x1200 60 06:19:52 INFO - Main Display: Yes 06:19:52 INFO - Mirror: Off 06:19:52 INFO - Online: Yes 06:19:52 INFO - Rotation: Supported 06:19:52 INFO - Return code: 0 06:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:52 INFO - Python 2.7.3 06:19:52 INFO - Return code: 0 06:19:52 INFO - grabbing minidump binary from tooltool 06:19: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')]} 06:19:52 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 0x10fc039f0>, '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 0x10f962db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:52 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 06:19:52 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 06:19:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:52 INFO - Return code: 0 06:19:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:19:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:19:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--webServer', 'localhost'] in /builds/slave/test/build 06:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0016 --webServer localhost 06:19:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xPUomqCbMK/Render', 06:19:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:52 INFO - 'HOME': '/Users/cltbld', 06:19:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:52 INFO - 'LOGNAME': 'cltbld', 06:19:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:52 INFO - 'MOZ_NO_REMOTE': '1', 06:19:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:52 INFO - 'NO_EM_RESTART': '1', 06:19:52 INFO - 'PAGER': '/bin/cat', 06:19:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:52 INFO - 'PWD': '/builds/slave/test', 06:19:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:52 INFO - 'SHELL': '/bin/bash', 06:19:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMyT1DU6zS/Listeners', 06:19:52 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 06:19:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:52 INFO - 'USER': 'cltbld', 06:19:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:52 INFO - 'XPC_FLAGS': '0x0', 06:19:52 INFO - 'XPC_SERVICE_NAME': '0', 06:19:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--webServer', 'localhost'] with output_timeout 3600 06:19:53 INFO - mozversion INFO | application_buildid: 20151120041233 06:19:53 INFO - mozversion INFO | application_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 06:19:53 INFO - mozversion INFO | application_display_name: Nightly 06:19:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:53 INFO - mozversion INFO | application_name: Firefox 06:19:53 INFO - mozversion INFO | application_remotingname: firefox 06:19:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:19:53 INFO - mozversion INFO | application_vendor: Mozilla 06:19:53 INFO - mozversion INFO | application_version: 45.0a1 06:19:53 INFO - mozversion INFO | platform_buildid: 20151120041233 06:19:53 INFO - mozversion INFO | platform_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 06:19:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:19:53 INFO - mozversion INFO | platform_version: 45.0a1 06:19:53 INFO - 2015-11-20 06:19:53,111 DEBUG : using testdate: 1448029193 06:19:53 INFO - 2015-11-20 06:19:53,111 DEBUG : actual date: 1448029193 06:19:53 INFO - 2015-11-20 06:19:53,454 INFO : starting webserver on 'localhost:51088' 06:19:53 INFO - 2015-11-20 06:19:53,455 INFO : Starting test suite t-yosemite-r7-0016.e 06:19:53 INFO - 2015-11-20 06:19:53,455 INFO : Starting test dromaeo_css 06:19:53 INFO - 2015-11-20 06:19:53,455 DEBUG : operating with platform_type : mac_ 06:19:53 INFO - 2015-11-20 06:19:53,457 INFO : Initialising browser for dromaeo_css test... 06:19:53 INFO - 2015-11-20 06:19:53,469 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpvLYm7k/profile http://localhost:51088/getInfo.html 06:19:56 INFO - 2015-11-20 06:19:56,212 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:19:56 INFO - 2015-11-20 06:19:56,213 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:19:56 INFO - 2015-11-20 06:19:56,213 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:19:56 INFO - 2015-11-20 06:19:56,213 DEBUG : BROWSER_OUTPUT: __metrics 06:19:56 INFO - 2015-11-20 06:19:56,814 INFO : Browser initialized. 06:19:56 INFO - 2015-11-20 06:19:56,814 INFO : Running cycle 1/1 for dromaeo_css test... 06:19:56 INFO - 2015-11-20 06:19:56,814 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpvLYm7k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:20:08 INFO - 2015-11-20 06:20:08,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 237023232 06:20:08 INFO - 2015-11-20 06:20:08,690 DEBUG : BROWSER_OUTPUT: 06:20:58 INFO - 2015-11-20 06:20:58,382 DEBUG : BROWSER_OUTPUT: 1448029258378 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] 06:23:09 INFO - 2015-11-20 06:23:09,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51088/tests/dromaeo/cssquery-ext.html) 06:23:10 INFO - 2015-11-20 06:23:10,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 252862464 06:23:10 INFO - 2015-11-20 06:23:10,880 DEBUG : BROWSER_OUTPUT: 06:26:12 INFO - 2015-11-20 06:26:12,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/dromaeo/cssquery-ext.html (next: http://localhost:51088/tests/dromaeo/cssquery-jquery.html) 06:26:13 INFO - 2015-11-20 06:26:13,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 262381568 06:26:13 INFO - 2015-11-20 06:26:13,352 DEBUG : BROWSER_OUTPUT: 06:29:14 INFO - 2015-11-20 06:29:14,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51088/tests/dromaeo/cssquery-mootools.html) 06:29:15 INFO - 2015-11-20 06:29:15,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 264921088 06:29:15 INFO - 2015-11-20 06:29:15,536 DEBUG : BROWSER_OUTPUT: 06:32:17 INFO - 2015-11-20 06:32:17,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51088/tests/dromaeo/cssquery-prototype.html) 06:32:17 INFO - 2015-11-20 06:32:17,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 265404416 06:32:17 INFO - 2015-11-20 06:32:17,742 DEBUG : BROWSER_OUTPUT: 06:35:20 INFO - 2015-11-20 06:35:20,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51088/tests/dromaeo/cssquery-yui.html) 06:35:20 INFO - 2015-11-20 06:35:20,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 268763136 06:35:20 INFO - 2015-11-20 06:35:20,784 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/dromaeo/cssquery-yui.html (next: http://localhost:51088/tests/dromaeo/cssquery-dojo.html) 06:38:23 INFO - 2015-11-20 06:38:23,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 271073280 06:38:23 INFO - 2015-11-20 06:38:23,262 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,262 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:38:23 INFO - 2015-11-20 06:38:23,262 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:38:23 INFO - 2015-11-20 06:38:23,262 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:38:23 INFO - 2015-11-20 06:38:23,262 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:38:23 INFO - 2015-11-20 06:38:23,263 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3445.9655403445963;3518.8064656443903;3537.911552211196;3562.8040457774828;3577.445495948128;5183.2743415921805;5671.489565939065;5940.34656187819;5965.463108320256;6022.548308876835;5626.493615574597;5699.344575373833;5871.823845284637;5920.822375328737;6018.638881667092;5347.786088556453;5370.99999999999;5432.511074003339;5502.752376143083;5505.642133261345;5499.010178167928;5509.421510741355;5512.91730624041;5557.277553917985;5568.192612071247;5225.346831646044;5295.152775555893;5361.651492652984;5370.248165256867;5479.890402191953;5403.918941215885;5406.216098665711;5421.376541697677;5441.047816632113;5457.426970168115;5387.353517577876;5393.622446428752;5408.13469844823;5409.756560954727;5427.426046446526;4850.369451971221;5439.891202175934;5615.326160860682;5814.5057670098095;5963.850903727398;6281.654509002003;6282.120503129566;6296.338884417162;6297.118403423478;6321.6523091229965;6305.8108256752375;6358.904616430757;6360.173177486943;6375.234971803413;6381.234251889757;5915.792947246869;6026.186464827236;6044.848878778022;6128.403213820837;6146.678464130234;6506.707198176094;6528.183977002875;6538.346165383424;6538.509611779135;6569.540132190797;6125.265974675666;6275.121482992385;6303.464205542488;6325;6333.778317758856;5260.263563101169;6289.622622642656;6338.080978258219;6355.872882542323;6418.903716444257;6293.465055470245;6319.8104056878365;6332.778352757631;6357.364263573698;6365.522585806083;6198.969005154945;6333.556651034475;6337;6360.204974378203;6374.617522948638;5039.470855560114;5120.103981803244;5124.180131178993;5130.358705161855;5196.376434827769;4465.24090904547;4504.635066590001;4522.3668686383935;4526.547345265513;4593.448786145684;5668.234788303609;5805.245318108618;5863.2670916135485;5889.322727886262;5929.940700593025;6348.682565871688;6353.61878287295;6400.615963042233;6403.647799370986;6408.551401401857;5021;5868.471837534642;5940.46535811779;5949.732262048218;5970.194023806817;5392.811251606254;5396.4603539646505;5491.28613280279;5521.613487055867;5528.55771538276;6462.579932304385;6502.739890404331;6508.3491650835485;6549.0176473527445;6559.7376104955265;6301;6363.713632886439;6390.360963903572;6396.552241343062;6401.8719625608155;6046.606970546901;6357.205349331333;6422.614643121427;6442.2591401989375;6519.185101862267;5708.4862362387585;6285.560548840595;6336.936630633819;6359.936400635935;6429.32492088324;6216.813495595139;6409.262934762562;6409.583377080475;6413.583117097373;6424.261209960728;5968.104784282393;6181.196444462371;6307.716152773228;6308.936910630835;6315.147455093504;6300.149479820166;6320.5891617044745;6321.652309123042;6322.36776322364;6349.619022858643;5961.2846458425265;6072.757089716539;6185.505159587312;6218.689065546795;6231.096491008869;6173.166622505904;6243.906341404973;6248.968755156195;6292.339304373158;6323.177986861679;6167.198264225622;6222.16000839899;6233.2208473940755;6244.812655620339;6254.21822272216 06:38:23 INFO - 2015-11-20 06:38:23,263 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.8228349899438;572.6535446055136;575.6603603873714;594.7858770842496;618.5886385553607;40248.39627405588;40337;40542.7972860136;40615.39076913849;40705.3894191587;43885.68342949708;43955.78022109885;44280;44319.77840110803;44396.77801610987;9858.950705246481;9917.057879501472;9933.552990115462;9955.950220248926;9967.700968970943;9747.658831940884;9818.263630227726;9854.950725246365;9865.950670246675;9866.112049915506;8653.48079115252;8943.821123577525;9753.073458021512;9784.26618003649;9846.212303015778;9840.409575425498;9880.209583233323;9904.25718071144;9919.20646348294;9920.40477571348;9702.223822094216;9796.069373409515;9823.214142868554;9833.704988850346;9838.311318207729;40080.39879401811;40571.188576228604;40645.1870962582;40818.795906020576;41393.172136557405;3242.4649932761067;3258.8370581471067;3279.360524697685;3300.092474569489;3496.7727097738566;24950.251492455256;27635.756390962455;28510.429791404054;28851.84592616293;29049;2796.944061118766;2806.733360330765;2843;2900.419916016784;2976.940461190764;442637;445282.77358613326;445392;446351;446541;59386.10920836191;60989.39010609926;62587.68706156531;63971;64069.35930640727;69997.65001174962;70195.2980470199;70974;70984.2901570988;71068;15355.309011094527;15716.29276682552;15823.287952042187;15871.047737135808;16032.358705651877;10213.33613315132;10283.588656453807;11986.46060927243;12006.75986480283;12104.394780260951;20198.59602807965;20281;20531.665441746238;20631.277905273542;20669;7355.175308839481;8030.63479208536;8540.957295213484;8692.348073894484;8747.781305467413;945.5886689290181;952.5475399185332;957.262907561174;1102.818035024228;1111.994440027811;28447.719852606682;29237.415251694845;29756;30105.548416773767;30256.54615180774;984.4634674102488;1010.7416266747946;1088.5319312695617;1089.7983872983523;1091.1161958813386;15159;15316.540503784905;15495.690086198212;15769.369225231092;15894.76157857633;556558;560927;563572;571445;571450;56724.432755671914;57281.42718572761;57489.56276093047;57766.42233577611;57926;1438.3958737330556;1445.3568162167735;1465.2600436779358;1467.5670677150267;1602.8156761972523;30131.096067118022;30227;30392.544111838783;30556.388872222877;30607.54088688716;50305.99388012146;50645.24032139447;51192.488075120265;51200.719982000744;51253.74373128259;517694;519154;522098;522414;524792.3760381173;26838.86580567085;30645.927392541154;32910;33555.32889342151;33740.32519349649;43672.56327436685;52301;54614.72692636511;55730;57517.13724294055;41138.38292425556;41829.1634167321;41874.79062604668;42879.3568096485;42891.57108428876;41423.37864932089;41692;41760;41778;42457.726268212005;39523.604763953146;40545.1890962185;40859;41087.794561027;41352.966175845846;34479.13802154966;36465.63534364622;36843.17567399964;37037;37228.441573376964;25828.741712583385;27303.31741706394;27582.310442239104;27632.86183569069;27777.44445111046 06:38:23 INFO - 2015-11-20 06:38:23,266 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.17976833052313;358.7919006975953;365.60332039736886;366.976146550474;370.43323714716496;15963.441279555218;20010.29963951262;20833.479163020933;21345.573088538218;21480.677789833164;19993;20039.899800501014;20177.596448071028;20361.796382036177;20610.38168854933;5057.620678449112;5200.687958722479;5295.126304159809;5322.494363035506;5333.4399888011785;5165.63840531163;5657.094864821629;5806.564507661921;5810.970945145268;5811.244538210027;3894.104355998122;4690.390249267591;4930.827421040264;5783;5791.826245212629;4892.730899800509;5797.188393624896;5800.245968024172;5806;5806.332271788756;5419.864503387407;5518.392976772552;5558.333000039981;5567.164925261202;5568.693721845297;13008.804867926989;13163.934180329134;13221.603351899459;20968.05643746035;24991.875040624862;1913.6651086059883;1917.6068905874401;1990.4426760506935;2060.423081537172;2255.7405898321576;9989.75025624358;10101.444420556867;11496.655100347003;13631.045826792128;14456;1634.991825040867;1695.3727120965323;1761.031432712016;1793.246836328745;1804.1520485371855;100182;104316;105715;106018;106429;11160.716517600418;11183.384913829655;11186;11261.887381126247;11292.830607540893;13190.73618527624;13216.867831321755;13240.668983275495;13247.470101195844;13250.204987700768;8153.633086511121;8227.958860205781;8270.214329638675;8280.337572994145;8371.079181290053;8122.268995790289;8274.710385136492;8328.125546817619;8331.50010999342;8359.289460395812;3503.8787587972115;3567.625399333033;3838.712096592711;4377.8248870044845;4408.603225709701;1814.8911065336122;1866.011014162496;1875.6717574424695;1877.9436616901514;1885.6700077486385;378.10012171032764;390.6542709701877;881.7751473374377;949.4398305000083;952.9761755956018;11087.778244435227;11542.596009139808;11781.293122412682;11802.94098529519;21082.683759743617;908.255230710824;933.1927882381826;951.8001219743932;988.8516722491684;990.346371394876;10644.787104257872;10817.242793004572;10921.310836924324;10943.945280273547;11009.944950275198;580284;583746;593857;729899;730564;107937;113201;115025.84974150152;115880.84119158701;118417;1179.1333369973063;1216.1486959128645;1222.1139673736648;1223.6329101269584;1226.5093962415106;18023.2790688371;18234;18254.178561964476;18571.81428185701;18834.811651883305;51606.12954028388;52041.7397913008;52362;52490.475095248556;52557;71407.5718485617;73305;73595;74101.62949185219;74125.62937185279;9684.51577421112;9884.752881178028;9939.751506212113;9948.950255248677;10096.091351778376;19706.80293197107;19807.405777826687;20024.39926802198;20123.295684650966;20379.59240815205;15873.444429445375;15947.840521594635;16009.91995040064;16091;16458.42395516151;10005.299629026189;10071.143952764098;10190.490475476048;10220.182385409298;10362;10356.533955971849;10407.06336429725;10509.159267258754;10558.04977552024;10587.788244234918;16891.831081689517;17088.316467341167;17091.829081709024;17777.46667599974;17987.920724756033;17103.14484275806;17357.913210433868;17428.302867885144;17578.64842703113;17687.911560442117 06:38:23 INFO - 2015-11-20 06:38:23,267 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1512.8562786535276;1716.8884022538534;1843.612841303327;1861.004362665973;1944.2903340280802;7539.208383119762;7656.502327348719;8233.053198882131;8355.37334699897;8355.874661880069;8145.714899978502;8208.712695055674;8308.044574873891;8364.874526882102;8382.371322150833;2359.870207138611;2391.557561851063;2398.568257713611;2399.3761621978324;2405.3625789165885;2392.545416370884;2417.0331867253153;2431.7811396974357;2457.4716435966266;2462;2390.0917651292484;2391.820613453989;2421.455172586163;2421.4551725861716;2424.987875060622;2257.3792207143;2290.828187885907;2300.654901764732;2313.2713195343413;2317.4090606895134;2380.297812145421;2405.2183040511904;2426.235735743253;2427.7329493755674;2428.1865575032384;8476;8593.097724738875;8596.656133754643;8612.009618893844;8616.741497755078;5183.637145399824;5207.505286997767;5213.7393130343335;5256.710880901549;5272.920906186372;3493.2489514754448;3571.624979377154;3615.891523254307;3617.5116359291424;3624.9275014499826;1044.3107549017611;1055.456439933435;1059.5761695321855;1075.2150929821273;1075.7687097274124;11143.33140011602;11158.330500169935;11195;11209.551617935273;11212.831807522894;3928.9803550982633;4529.437344116341;4689.20283551797;4696.694714843593;4739.715617062987;9619.038096190465;9668.903310966942;9693.127618514367;9712.22302215821;9746.31775775689;5209.374875014947;5217;5222.190560463135;5245.501677340647;5247.527722504917;4164.1879833432795;4246.426732391149;4666.976665116653;4715.127701375257;4730.9763451182525;3088.7528997680133;3878.5151856017997;3900.8829735107993;3924.6664033557468;3933.803309834554;1109.4951796932376;1271.8235632040326;1277.6869666931661;1278.360819590205;1286.1897004887048;1031.742064483879;1068.9037986581245;1128.8927551882557;1132.7847708935276;1137.635956493914;7882.251186137308;7904.644291006918;7907.2488113629115;7919.960400197962;7920.049594048636;496.4340651657114;501.41084226034263;502.52762403340745;506.2204205523453;506.68079110160363;6056.697165141725;6095.542834287447;6102.115193296947;6131.294901086432;6136.2636483622255;9925.255605829592;10172.694819155437;10202.693919182437;10299.12457441111;10329.380237185793;9971.650992215238;10069.395836249849;10081.14310283634;10107.494625268708;10112.342697724624;7980.800479988046;8020.558869262247;8087.5551844647935;8101.311388532041;8169.959150204211;7593.354564862048;7622.771316860503;7634.9311096445435;7656.846863062819;7707.34487568563;7982.281594656509;8527.872081918653;8976.281897448058;9051.366404351633;9067.727968160965;9164.725058248263;9236.122568355995;9306.767330816783;9347.439153650803;9453.196478299422;6460.67696615158;6659.800205993828;6964.756233531802;7249.492535522463;7281.417486600953;7935.484193527403;7946.960265198868;7956.323712484504;7968.123506414174;7989.081255655442;7357.558546487228;7546;7547.773566793005;7593;7682.807929801576;7401.96299018523;7428.851422971402;7452.925470745223;7573.659185336784;7593.5823529706395;7548.811279718051;7558.093028836574;7568.924310756822;7586.431017673586;7594.924050759421;6734.057231987624;6851.623160726208;6875.7937261882225;6921.792346229621;6952;6999.545029573062;7005.124359455068;7039.331263529956;7065.0815393998455;7100.75736746057 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: |4;prototype.html;277.10771316361314;323.956265904103;327.497291657306;329.7576281433145;330.28987676495547;5592.490027692521;5850.824475265744;6976.755813546527;7038.099713077479;7228.674709638072;5927.940720592804;6119.785807496739;6816.625085620289;7199.6040217788;7218.999999999987;4169.60388763067;4908.460069392382;5049.293098966129;5060.392752869642;5172.172452407615;5097.260897169908;5107.719075450867;5167.250748641445;5168.01807656544;5175.8188463403785;5080.187170052793;5089.567386772129;5092.872678183038;5107.9744601277125;5148.510891465305;5089.54194122527;5092.949070509285;5093.286939828427;5095.490450954912;5096.617753668471;4181.519125300569;4260.510041345254;4287.914241715148;4288.69979101463;4289.935650965238;6761.222459417181;6775.254721980627;6803.197152754524;6816;6841.042254084432;5925.111233314994;5970.940290597126;5979.1464645959895;5983.521318294526;5998.640081595118;7346.889796653055;7561.962190189014;7564.886526702104;7585.734499292554;7617.00978872743;3917.7061720371084;4771.618270538349;4773.856784296442;4775.662814411936;4776.307435421879;7993.320567751748;8011.359091272684;8028.237317454832;8035.718749843727;8044.798880027987;4717.5282471753235;4793.161196790547;4821.7589120543835;4854.834839638532;4872.123017856819;4931.753412329369;4933.210686290176;4934.210526315772;4958.256261560723;4959.876003099879;5937.940620593825;5956.076808094752;5957.404259574095;5972.731227094791;5973.641581505123;7511.0566952350455;7633.427492938052;7635.618219089023;7680.846383072308;7703.499272547267;1696.3299496698735;1715.6911755884062;1717.931282748676;1718.5875389906582;1718.6390857919978;1063.2663462211049;1066.7493139112303;1081.453865797767;1084.5011294804322;1091.9508622112023;5896.911546326723;6461.19235095613;6534.497065674921;7148.392386647193;7234.204237533867;8032.4778889372;8058.315043221274;8094.51432914027;8111.229433203955;8127.3904457165945;6958.582485050913;7195.352418282275;7208.7476938307955;7217.458690598226;7231.855362892713;4220.599043090901;4249.87250382489;4251.9787401062795;4252.596003379674;4266.530681625019;8293.95853020743;8299.8340033199;8300.833983320299;8306.6677332906;8340.916590834015;7429.888551671729;7672.884906726404;8047.396445266629;8268.545230012407;8322.084570697218;6339.461145802658;8226.958865205635;8230.300424463987;8277.793055173548;8300.83398332042;7077.7168913242895;7225.602591857288;8010.359171266168;8017.759467215759;8022.759317220492;6725.630090345078;7809.882851757342;7859.410544209093;7886.369090472634;7921.207879212263;8208.46644968075;8210.548419836967;8242.423030387816;8265.256126948603;8272.83454330898;4738.644601654959;4812.975935120442;4863.3434486343895;4872.366592342973;4877.6829506081995;6332.778352757631;7111.2533184017;7166.319199676022;7979.241972012649;8002.079760827346;7687.2697093776005;7699.230076992256;7699.307062364414;7743.5353878767455;7767.766966990774;7434.59109748969;7640.656170472231;7652.617369131633;7663.314070904615;7671.53970761756;7476.140243872024;7479.850402991801;7505.887411688938;7545.773626791205;7549.584772837547;6100.847478813065;7329.413646908128;7463.552186868806;7670.501417407851;7681.961590192013;7439.032925719622;7478.887816682645;7484.588347640932;7496.850062998818;7498.287662672037 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: |5;yui.html;740.5852722475411;754.4040208235496;761.2577736706712;791.3431851563203;874.2918236228651;13497.797533037;16047.197640117976;16353.672926541476;16369;16377.18114094295;16649.25078371473;16742.58143546412;16746.078965656885;16754.74867876983;16816.32734690611;773.3465221887524;778.8364443466879;944.6363150187176;950.9714708558754;968.0416387776086;967.2020583019003;967.7870868408974;968.4334664221403;977.911987921087;978.5449765858874;1012.3217444312328;1017.1506791828832;1021.0963297481745;1022.1924679503221;1022.9335093218917;1006.8791744990612;1014.2899970021015;1017.9847302290472;1018.5671089786811;1020.7499162705147;755.1768572256212;759.6999185321822;760.5170716594947;762.3558093411059;763.4503157726429;14094;14121.08212966154;14167.78748318776;14219.50231741884;14274.072185308025;12328.260304381676;12451.626451206479;12552.560660376843;12630.49478020878;13166.539171128965;10310.793784124351;10396.012378824;10476.423796691179;10895.618653347174;11672.533098676044;3564.21587250807;3590.461430785377;3629.038304849217;3645.0340659725193;3720.3489389356755;71247;72623.91064134095;73075;73225.90161147587;73752.63123684347;9269.629214831466;9305.627774888928;9354.71935841926;9564.90435095654;9690.176335011603;20724;21067.8946605266;21201.257955971774;21252.78747212539;21282.574348512942;7398.815029624302;7435.442341824385;7509.098908131059;7701.768946931601;7835.882461762964;4118.814653340607;4147.771872547039;4152.688548358825;4344.869653910388;4381.255186618282;3399.983000084984;3414.778039427429;3424.298018906118;3455.8444869980913;3458.6714262145056;630.2720357986533;633.7053270229273;638.8115505925763;655.924568674599;663.8041777675597;515.4021335251091;539.692375346049;541.2503682399904;587.2649946341267;600.2916558460971;8776.824463510822;8796.604152813139;8913.598888050054;8943.686970955985;9009.729708108767;507.5127877237893;516.7519590596535;523.7549660005675;538.5449295345427;547.4689551135392;3584.713222942158;4098.4876890388705;4162.959260184954;4217.388478670637;4314.201872653569;105100;105120;105247.42128868074;105390;105980.47009764901;85641.28717425617;87891.12108878829;90690.54654726684;90851;91139;76204;76489.23510764822;76522.55648495832;77121;79001;8421.578921054046;8491.532965686947;8565.614547345509;8689.478631282143;8776.385653004229;42678.78660606677;51475.71310717262;52042;53161;53672.92654146817;67127.66436167984;69080;74252.62873685597;74378;74548;11176.608818691308;11488.885111148782;11557.47991340375;11639.53441862316;12140.210886292363;11579.247348922294;11800.468978895799;12229.327386993446;12275.69310767238;12692.555760548337;11532.94233528827;11593.6521904343;11672.824907626562;11831.881681183078;12265.080118990933;11633;11818.897088848305;11850.58522951727;11995.220310679779;12132.272063676208;11384.430778460877;12111.878881211427;12113.69715757113;12118.454669539715;12418.627441176779;9844.556994935101;9867.851982220416;10233.641822536176;10251.948740256252;10552.894471055499;9599.712008639752;10015.899841001497;10319.845202322122;10324.48377581103;10336 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: __startTimestamp1448030303258__endTimestamp 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:38:23 INFO - 2015-11-20 06:38:23,271 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:38:23 INFO - 2015-11-20 06:38:23,272 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,272 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5883.66 Median:6167.20 stddev:646.14 (10.5%) stddev-sans-first:619.18 06:38:23 INFO - 2015-11-20 06:38:23,273 DEBUG : BROWSER_OUTPUT: Values: 3446.0 3518.8 3537.9 3562.8 3577.4 5183.3 5671.5 5940.3 5965.5 6022.5 5626.5 5699.3 5871.8 5920.8 6018.6 5347.8 5371.0 5432.5 5502.8 5505.6 5499.0 5509.4 5512.9 5557.3 5568.2 5225.3 5295.2 5361.7 5370.2 5479.9 5403.9 5406.2 5421.4 5441.0 5457.4 5387.4 5393.6 5408.1 5409.8 5427.4 4850.4 5439.9 5615.3 5814.5 5963.9 6281.7 6282.1 6296.3 6297.1 6321.7 6305.8 6358.9 6360.2 6375.2 6381.2 5915.8 6026.2 6044.8 6128.4 6146.7 6506.7 6528.2 6538.3 6538.5 6569.5 6125.3 6275.1 6303.5 6325.0 6333.8 5260.3 6289.6 6338.1 6355.9 6418.9 6293.5 6319.8 6332.8 6357.4 6365.5 6199.0 6333.6 6337.0 6360.2 6374.6 5039.5 5120.1 5124.2 5130.4 5196.4 4465.2 4504.6 4522.4 4526.5 4593.4 5668.2 5805.2 5863.3 5889.3 5929.9 6348.7 6353.6 6400.6 6403.6 6408.6 5021.0 5868.5 5940.5 5949.7 5970.2 5392.8 5396.5 5491.3 5521.6 5528.6 6462.6 6502.7 6508.3 6549.0 6559.7 6301.0 6363.7 6390.4 6396.6 6401.9 6046.6 6357.2 6422.6 6442.3 6519.2 5708.5 6285.6 6336.9 6359.9 6429.3 6216.8 6409.3 6409.6 6413.6 6424.3 5968.1 6181.2 6307.7 6308.9 6315.1 6300.1 6320.6 6321.7 6322.4 6349.6 5961.3 6072.8 6185.5 6218.7 6231.1 6173.2 6243.9 6249.0 6292.3 6323.2 6167.2 6222.2 6233.2 6244.8 6254.2 06:38:23 INFO - 2015-11-20 06:38:23,274 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,274 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66350.71 Median:41803.58 stddev:136363.71 (326.2%) stddev-sans-first:136656.76 06:38:23 INFO - 2015-11-20 06:38:23,275 DEBUG : BROWSER_OUTPUT: Values: 553.8 572.7 575.7 594.8 618.6 40248.4 40337.0 40542.8 40615.4 40705.4 43885.7 43955.8 44280.0 44319.8 44396.8 9859.0 9917.1 9933.6 9956.0 9967.7 9747.7 9818.3 9855.0 9866.0 9866.1 8653.5 8943.8 9753.1 9784.3 9846.2 9840.4 9880.2 9904.3 9919.2 9920.4 9702.2 9796.1 9823.2 9833.7 9838.3 40080.4 40571.2 40645.2 40818.8 41393.2 3242.5 3258.8 3279.4 3300.1 3496.8 24950.3 27635.8 28510.4 28851.8 29049.0 2796.9 2806.7 2843.0 2900.4 2976.9 442637.0 445282.8 445392.0 446351.0 446541.0 59386.1 60989.4 62587.7 63971.0 64069.4 69997.7 70195.3 70974.0 70984.3 71068.0 15355.3 15716.3 15823.3 15871.0 16032.4 10213.3 10283.6 11986.5 12006.8 12104.4 20198.6 20281.0 20531.7 20631.3 20669.0 7355.2 8030.6 8541.0 8692.3 8747.8 945.6 952.5 957.3 1102.8 1112.0 28447.7 29237.4 29756.0 30105.5 30256.5 984.5 1010.7 1088.5 1089.8 1091.1 15159.0 15316.5 15495.7 15769.4 15894.8 556558.0 560927.0 563572.0 571445.0 571450.0 56724.4 57281.4 57489.6 57766.4 57926.0 1438.4 1445.4 1465.3 1467.6 1602.8 30131.1 30227.0 30392.5 30556.4 30607.5 50306.0 50645.2 51192.5 51200.7 51253.7 517694.0 519154.0 522098.0 522414.0 524792.4 26838.9 30645.9 32910.0 33555.3 33740.3 43672.6 52301.0 54614.7 55730.0 57517.1 41138.4 41829.2 41874.8 42879.4 42891.6 41423.4 41692.0 41760.0 41778.0 42457.7 39523.6 40545.2 40859.0 41087.8 41353.0 34479.1 36465.6 36843.2 37037.0 37228.4 25828.7 27303.3 27582.3 27632.9 27777.4 06:38:23 INFO - 2015-11-20 06:38:23,275 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,275 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:35611.06 Median:20032.15 stddev:106996.98 (534.1%) stddev-sans-first:107264.39 06:38:23 INFO - 2015-11-20 06:38:23,276 DEBUG : BROWSER_OUTPUT: Values: 358.2 358.8 365.6 367.0 370.4 15963.4 20010.3 20833.5 21345.6 21480.7 19993.0 20039.9 20177.6 20361.8 20610.4 5057.6 5200.7 5295.1 5322.5 5333.4 5165.6 5657.1 5806.6 5811.0 5811.2 3894.1 4690.4 4930.8 5783.0 5791.8 4892.7 5797.2 5800.2 5806.0 5806.3 5419.9 5518.4 5558.3 5567.2 5568.7 13008.8 13163.9 13221.6 20968.1 24991.9 1913.7 1917.6 1990.4 2060.4 2255.7 9989.8 10101.4 11496.7 13631.0 14456.0 1635.0 1695.4 1761.0 1793.2 1804.2 100182.0 104316.0 105715.0 106018.0 106429.0 11160.7 11183.4 11186.0 11261.9 11292.8 13190.7 13216.9 13240.7 13247.5 13250.2 8153.6 8228.0 8270.2 8280.3 8371.1 8122.3 8274.7 8328.1 8331.5 8359.3 3503.9 3567.6 3838.7 4377.8 4408.6 1814.9 1866.0 1875.7 1877.9 1885.7 378.1 390.7 881.8 949.4 953.0 11087.8 11542.6 11781.3 11802.9 21082.7 908.3 933.2 951.8 988.9 990.3 10644.8 10817.2 10921.3 10943.9 11009.9 580284.0 583746.0 593857.0 729899.0 730564.0 107937.0 113201.0 115025.8 115880.8 118417.0 1179.1 1216.1 1222.1 1223.6 1226.5 18023.3 18234.0 18254.2 18571.8 18834.8 51606.1 52041.7 52362.0 52490.5 52557.0 71407.6 73305.0 73595.0 74101.6 74125.6 9684.5 9884.8 9939.8 9949.0 10096.1 19706.8 19807.4 20024.4 20123.3 20379.6 15873.4 15947.8 16009.9 16091.0 16458.4 10005.3 10071.1 10190.5 10220.2 10362.0 10356.5 10407.1 10509.2 10558.0 10587.8 16891.8 17088.3 17091.8 17777.5 17987.9 17103.1 17357.9 17428.3 17578.6 17687.9 06:38:23 INFO - 2015-11-20 06:38:23,276 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,276 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5822.13 Median:5252.12 stddev:3052.40 (58.1%) stddev-sans-first:3043.77 06:38:23 INFO - 2015-11-20 06:38:23,277 DEBUG : BROWSER_OUTPUT: Values: 1512.9 1716.9 1843.6 1861.0 1944.3 7539.2 7656.5 8233.1 8355.4 8355.9 8145.7 8208.7 8308.0 8364.9 8382.4 2359.9 2391.6 2398.6 2399.4 2405.4 2392.5 2417.0 2431.8 2457.5 2462.0 2390.1 2391.8 2421.5 2421.5 2425.0 2257.4 2290.8 2300.7 2313.3 2317.4 2380.3 2405.2 2426.2 2427.7 2428.2 8476.0 8593.1 8596.7 8612.0 8616.7 5183.6 5207.5 5213.7 5256.7 5272.9 3493.2 3571.6 3615.9 3617.5 3624.9 1044.3 1055.5 1059.6 1075.2 1075.8 11143.3 11158.3 11195.0 11209.6 11212.8 3929.0 4529.4 4689.2 4696.7 4739.7 9619.0 9668.9 9693.1 9712.2 9746.3 5209.4 5217.0 5222.2 5245.5 5247.5 4164.2 4246.4 4667.0 4715.1 4731.0 3088.8 3878.5 3900.9 3924.7 3933.8 1109.5 1271.8 1277.7 1278.4 1286.2 1031.7 1068.9 1128.9 1132.8 1137.6 7882.3 7904.6 7907.2 7920.0 7920.0 496.4 501.4 502.5 506.2 506.7 6056.7 6095.5 6102.1 6131.3 6136.3 9925.3 10172.7 10202.7 10299.1 10329.4 9971.7 10069.4 10081.1 10107.5 10112.3 7980.8 8020.6 8087.6 8101.3 8170.0 7593.4 7622.8 7634.9 7656.8 7707.3 7982.3 8527.9 8976.3 9051.4 9067.7 9164.7 9236.1 9306.8 9347.4 9453.2 6460.7 6659.8 6964.8 7249.5 7281.4 7935.5 7947.0 7956.3 7968.1 7989.1 7357.6 7546.0 7547.8 7593.0 7682.8 7402.0 7428.9 7452.9 7573.7 7593.6 7548.8 7558.1 7568.9 7586.4 7594.9 6734.1 6851.6 6875.8 6921.8 6952.0 6999.5 7005.1 7039.3 7065.1 7100.8 06:38:23 INFO - 2015-11-20 06:38:23,277 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,277 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6128.16 Median:6828.83 stddev:2019.87 (29.6%) stddev-sans-first:1977.22 06:38:23 INFO - 2015-11-20 06:38:23,278 DEBUG : BROWSER_OUTPUT: Values: 277.1 324.0 327.5 329.8 330.3 5592.5 5850.8 6976.8 7038.1 7228.7 5927.9 6119.8 6816.6 7199.6 7219.0 4169.6 4908.5 5049.3 5060.4 5172.2 5097.3 5107.7 5167.3 5168.0 5175.8 5080.2 5089.6 5092.9 5108.0 5148.5 5089.5 5092.9 5093.3 5095.5 5096.6 4181.5 4260.5 4287.9 4288.7 4289.9 6761.2 6775.3 6803.2 6816.0 6841.0 5925.1 5970.9 5979.1 5983.5 5998.6 7346.9 7562.0 7564.9 7585.7 7617.0 3917.7 4771.6 4773.9 4775.7 4776.3 7993.3 8011.4 8028.2 8035.7 8044.8 4717.5 4793.2 4821.8 4854.8 4872.1 4931.8 4933.2 4934.2 4958.3 4959.9 5937.9 5956.1 5957.4 5972.7 5973.6 7511.1 7633.4 7635.6 7680.8 7703.5 1696.3 1715.7 1717.9 1718.6 1718.6 1063.3 1066.7 1081.5 1084.5 1092.0 5896.9 6461.2 6534.5 7148.4 7234.2 8032.5 8058.3 8094.5 8111.2 8127.4 6958.6 7195.4 7208.7 7217.5 7231.9 4220.6 4249.9 4252.0 4252.6 4266.5 8294.0 8299.8 8300.8 8306.7 8340.9 7429.9 7672.9 8047.4 8268.5 8322.1 6339.5 8227.0 8230.3 8277.8 8300.8 7077.7 7225.6 8010.4 8017.8 8022.8 6725.6 7809.9 7859.4 7886.4 7921.2 8208.5 8210.5 8242.4 8265.3 8272.8 4738.6 4813.0 4863.3 4872.4 4877.7 6332.8 7111.3 7166.3 7979.2 8002.1 7687.3 7699.2 7699.3 7743.5 7767.8 7434.6 7640.7 7652.6 7663.3 7671.5 7476.1 7479.9 7505.9 7545.8 7549.6 6100.8 7329.4 7463.6 7670.5 7682.0 7439.0 7478.9 7484.6 7496.9 7498.3 06:38:23 INFO - 2015-11-20 06:38:23,279 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,279 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19299.22 Median:4150.23 stddev:27656.46 (666.4%) stddev-sans-first:27698.94 06:38:23 INFO - 2015-11-20 06:38:23,280 DEBUG : BROWSER_OUTPUT: Values: 740.6 754.4 761.3 791.3 874.3 13497.8 16047.2 16353.7 16369.0 16377.2 16649.3 16742.6 16746.1 16754.7 16816.3 773.3 778.8 944.6 951.0 968.0 967.2 967.8 968.4 977.9 978.5 1012.3 1017.2 1021.1 1022.2 1022.9 1006.9 1014.3 1018.0 1018.6 1020.7 755.2 759.7 760.5 762.4 763.5 14094.0 14121.1 14167.8 14219.5 14274.1 12328.3 12451.6 12552.6 12630.5 13166.5 10310.8 10396.0 10476.4 10895.6 11672.5 3564.2 3590.5 3629.0 3645.0 3720.3 71247.0 72623.9 73075.0 73225.9 73752.6 9269.6 9305.6 9354.7 9564.9 9690.2 20724.0 21067.9 21201.3 21252.8 21282.6 7398.8 7435.4 7509.1 7701.8 7835.9 4118.8 4147.8 4152.7 4344.9 4381.3 3400.0 3414.8 3424.3 3455.8 3458.7 630.3 633.7 638.8 655.9 663.8 515.4 539.7 541.3 587.3 600.3 8776.8 8796.6 8913.6 8943.7 9009.7 507.5 516.8 523.8 538.5 547.5 3584.7 4098.5 4163.0 4217.4 4314.2 105100.0 105120.0 105247.4 105390.0 105980.5 85641.3 87891.1 90690.5 90851.0 91139.0 76204.0 76489.2 76522.6 77121.0 79001.0 8421.6 8491.5 8565.6 8689.5 8776.4 42678.8 51475.7 52042.0 53161.0 53672.9 67127.7 69080.0 74252.6 74378.0 74548.0 11176.6 11488.9 11557.5 11639.5 12140.2 11579.2 11800.5 12229.3 12275.7 12692.6 11532.9 11593.7 11672.8 11831.9 12265.1 11633.0 11818.9 11850.6 11995.2 12132.3 11384.4 12111.9 12113.7 12118.5 12418.6 9844.6 9867.9 10233.6 10251.9 10552.9 9599.7 10015.9 10319.8 10324.5 10336.0 06:38:23 INFO - 2015-11-20 06:38:23,280 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:38:23 INFO - 2015-11-20 06:38:23,280 DEBUG : BROWSER_OUTPUT: 06:38:23 INFO - 2015-11-20 06:38:23,777 INFO : Browser exited with error code: 0 06:38:23 INFO - 2015-11-20 06:38:23,804 INFO : Completed test dromaeo_css (00:18:30) 06:38:23 INFO - 2015-11-20 06:38:23,804 INFO : Starting test kraken 06:38:23 INFO - 2015-11-20 06:38:23,804 DEBUG : operating with platform_type : mac_ 06:38:23 INFO - 2015-11-20 06:38:23,804 INFO : Initialising browser for kraken test... 06:38:23 INFO - 2015-11-20 06:38:23,817 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpq8OlyZ/profile http://localhost:51088/getInfo.html 06:38:26 INFO - 2015-11-20 06:38:26,284 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:38:26 INFO - 2015-11-20 06:38:26,285 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:38:26 INFO - 2015-11-20 06:38:26,285 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:38:26 INFO - 2015-11-20 06:38:26,285 DEBUG : BROWSER_OUTPUT: __metrics 06:38:26 INFO - 2015-11-20 06:38:26,896 INFO : Browser initialized. 06:38:26 INFO - 2015-11-20 06:38:26,896 INFO : Running cycle 1/1 for kraken test... 06:38:26 INFO - 2015-11-20 06:38:26,896 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpq8OlyZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:38:38 INFO - 2015-11-20 06:38:38,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 236961792 06:38:38 INFO - 2015-11-20 06:38:38,931 DEBUG : BROWSER_OUTPUT: 06:38:41 INFO - 2015-11-20 06:38:41,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51088/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:42 INFO - 2015-11-20 06:38:42,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 249020416 06:38:42 INFO - 2015-11-20 06:38:42,290 DEBUG : BROWSER_OUTPUT: 06:38:44 INFO - 2015-11-20 06:38:44,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51088/tests/kraken/driver.html?testName=audio-dft) 06:38:45 INFO - 2015-11-20 06:38:45,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 258646016 06:38:45 INFO - 2015-11-20 06:38:45,454 DEBUG : BROWSER_OUTPUT: 06:38:48 INFO - 2015-11-20 06:38:48,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51088/tests/kraken/driver.html?testName=audio-fft) 06:38:49 INFO - 2015-11-20 06:38:49,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 260988928 06:38:49 INFO - 2015-11-20 06:38:49,465 DEBUG : BROWSER_OUTPUT: 06:38:51 INFO - 2015-11-20 06:38:51,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51088/tests/kraken/driver.html?testName=audio-oscillator) 06:38:51 INFO - 2015-11-20 06:38:51,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 262828032 06:38:51 INFO - 2015-11-20 06:38:51,893 DEBUG : BROWSER_OUTPUT: 06:38:53 INFO - 2015-11-20 06:38:53,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:54 INFO - 2015-11-20 06:38:54,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 264179712 06:38:54 INFO - 2015-11-20 06:38:54,424 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2015-11-20 06:38:57,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51088/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:57 INFO - 2015-11-20 06:38:57,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 262664192 06:38:57 INFO - 2015-11-20 06:38:57,866 DEBUG : BROWSER_OUTPUT: 06:39:00 INFO - 2015-11-20 06:39:00,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51088/tests/kraken/driver.html?testName=imaging-desaturate) 06:39:01 INFO - 2015-11-20 06:39:01,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 262848512 06:39:01 INFO - 2015-11-20 06:39:01,214 DEBUG : BROWSER_OUTPUT: 06:39:04 INFO - 2015-11-20 06:39:04,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51088/tests/kraken/driver.html?testName=json-parse-financial) 06:39:04 INFO - 2015-11-20 06:39:04,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 263147520 06:39:04 INFO - 2015-11-20 06:39:04,892 DEBUG : BROWSER_OUTPUT: 06:39:06 INFO - 2015-11-20 06:39:06,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:39:06 INFO - 2015-11-20 06:39:06,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 264142848 06:39:06 INFO - 2015-11-20 06:39:06,978 DEBUG : BROWSER_OUTPUT: 06:39:08 INFO - 2015-11-20 06:39:08,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51088/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:39:09 INFO - 2015-11-20 06:39:09,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 264314880 06:39:09 INFO - 2015-11-20 06:39:09,364 DEBUG : BROWSER_OUTPUT: 06:39:11 INFO - 2015-11-20 06:39:11,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:39:11 INFO - 2015-11-20 06:39:11,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 264581120 06:39:11 INFO - 2015-11-20 06:39:11,964 DEBUG : BROWSER_OUTPUT: 06:39:14 INFO - 2015-11-20 06:39:14,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:39:15 INFO - 2015-11-20 06:39:15,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 264105984 06:39:15 INFO - 2015-11-20 06:39:15,184 DEBUG : BROWSER_OUTPUT: 06:39:17 INFO - 2015-11-20 06:39:17,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:39:18 INFO - 2015-11-20 06:39:18,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 264118272 06:39:18 INFO - 2015-11-20 06:39:18,240 DEBUG : BROWSER_OUTPUT: 06:39:19 INFO - 2015-11-20 06:39:19,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51088/tests/kraken/driver.html?testName=ai-astar) 06:39:20 INFO - 2015-11-20 06:39:20,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 264400896 06:39:20 INFO - 2015-11-20 06:39:20,110 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,110 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:39:20 INFO - 2015-11-20 06:39:20,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;107;115;113;114;123;115;114;113;132 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;133;144;156;126;149;140;128;158;122 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |2;audio-dft;190;195;193;195;218;264;272;207;181;268 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |3;audio-fft;63;62;72;112;56;56;59;59;112;58 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;76;79;109;76;78;78;110;77;79;110 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;87;87;88;118;76;134;134;87;86 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;97;94;95;97;96;95;97;104;96 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;149;153;91;94;87;147;137;121;90;93 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;60;60;60;59;59;66;50;49 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;70;67;67;70;67;69;67;73;71 06:39:20 INFO - 2015-11-20 06:39:20,111 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;85;84;84;84;79;82;83;85 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;138;120;137;127;134;124;132;126;138;127 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;124;176;176;135;135;144;135;140;138;125 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;64;67;66;69;68;66;69;67;69 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,804 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: __startTimestamp1448030360108__endTimestamp 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,112 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:39:20 INFO - 2015-11-20 06:39:20,114 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:39:20 INFO - 2015-11-20 06:39:20,114 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,114 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.30 Median:115.00 stddev:6.78 (5.9%) stddev-sans-first:7.19 06:39:20 INFO - 2015-11-20 06:39:20,114 DEBUG : BROWSER_OUTPUT: Values: 117.0 107.0 115.0 113.0 114.0 123.0 115.0 114.0 113.0 132.0 06:39:20 INFO - 2015-11-20 06:39:20,114 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,114 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.30 Median:145.50 stddev:12.64 (8.7%) stddev-sans-first:13.17 06:39:20 INFO - 2015-11-20 06:39:20,114 DEBUG : BROWSER_OUTPUT: Values: 147.0 133.0 144.0 156.0 126.0 149.0 140.0 128.0 158.0 122.0 06:39:20 INFO - 2015-11-20 06:39:20,114 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:218.30 Median:212.50 stddev:35.73 (16.8%) stddev-sans-first:36.40 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: Values: 190.0 195.0 193.0 195.0 218.0 264.0 272.0 207.0 181.0 268.0 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:70.90 Median:59.00 stddev:22.15 (37.5%) stddev-sans-first:23.31 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 72.0 112.0 56.0 56.0 59.0 59.0 112.0 58.0 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.20 Median:77.50 stddev:15.54 (20.1%) stddev-sans-first:15.95 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: Values: 76.0 79.0 109.0 76.0 78.0 78.0 110.0 77.0 79.0 110.0 06:39:20 INFO - 2015-11-20 06:39:20,115 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:87.00 stddev:21.55 (24.8%) stddev-sans-first:22.52 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: Values: 88.0 87.0 87.0 88.0 118.0 76.0 134.0 134.0 87.0 86.0 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:96.60 Median:96.00 stddev:2.80 (2.9%) stddev-sans-first:2.91 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 94.0 95.0 97.0 96.0 95.0 97.0 104.0 96.0 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.20 Median:88.50 stddev:27.97 (31.6%) stddev-sans-first:27.03 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: Values: 149.0 153.0 91.0 94.0 87.0 147.0 137.0 121.0 90.0 93.0 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.50 stddev:4.99 (8.4%) stddev-sans-first:5.29 06:39:20 INFO - 2015-11-20 06:39:20,116 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 60.0 60.0 60.0 59.0 59.0 66.0 50.0 49.0 06:39:20 INFO - 2015-11-20 06:39:20,117 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,117 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.50 stddev:2.59 (3.7%) stddev-sans-first:2.18 06:39:20 INFO - 2015-11-20 06:39:20,117 DEBUG : BROWSER_OUTPUT: Values: 64.0 70.0 67.0 67.0 70.0 67.0 69.0 67.0 73.0 71.0 06:39:20 INFO - 2015-11-20 06:39:20,117 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,117 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.50 stddev:2.00 (2.4%) stddev-sans-first:1.94 06:39:20 INFO - 2015-11-20 06:39:20,117 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 85.0 84.0 84.0 84.0 79.0 82.0 83.0 85.0 06:39:20 INFO - 2015-11-20 06:39:20,117 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:133.00 stddev:6.38 (4.8%) stddev-sans-first:6.13 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: Values: 138.0 120.0 137.0 127.0 134.0 124.0 132.0 126.0 138.0 127.0 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:139.00 stddev:18.53 (13.3%) stddev-sans-first:18.36 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: Values: 124.0 176.0 176.0 135.0 135.0 144.0 135.0 140.0 138.0 125.0 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.66 (2.5%) stddev-sans-first:1.72 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 67.0 66.0 69.0 68.0 66.0 69.0 67.0 69.0 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:39:20 INFO - 2015-11-20 06:39:20,118 DEBUG : BROWSER_OUTPUT: 06:39:20 INFO - 2015-11-20 06:39:20,829 INFO : Browser exited with error code: 0 06:39:20 INFO - 2015-11-20 06:39:20,878 INFO : Completed test kraken (00:00:57) 06:39:20 INFO - 2015-11-20 06:39:20,878 INFO : Starting test v8_7 06:39:20 INFO - 2015-11-20 06:39:20,878 DEBUG : operating with platform_type : mac_ 06:39:20 INFO - 2015-11-20 06:39:20,878 INFO : Initialising browser for v8_7 test... 06:39:20 INFO - 2015-11-20 06:39:20,891 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmp8zXfQw/profile http://localhost:51088/getInfo.html 06:39:23 INFO - 2015-11-20 06:39:23,687 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:39:23 INFO - 2015-11-20 06:39:23,687 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:39:23 INFO - 2015-11-20 06:39:23,687 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:39:23 INFO - 2015-11-20 06:39:23,687 DEBUG : BROWSER_OUTPUT: __metrics 06:39:24 INFO - 2015-11-20 06:39:24,282 INFO : Browser initialized. 06:39:24 INFO - 2015-11-20 06:39:24,282 INFO : Running cycle 1/1 for v8_7 test... 06:39:24 INFO - 2015-11-20 06:39:24,282 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmp8zXfQw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:39:36 INFO - 2015-11-20 06:39:36,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 236883968 06:39:36 INFO - 2015-11-20 06:39:36,301 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51088/tests/v8_7/run.html (next: http://localhost:51088/tests/v8_7/run.html) 06:39:57 INFO - 2015-11-20 06:39:57,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 248700928 06:39:57 INFO - 2015-11-20 06:39:57,913 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,913 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:39:57 INFO - 2015-11-20 06:39:57,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:39:57 INFO - 2015-11-20 06:39:57,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:39:57 INFO - 2015-11-20 06:39:57,913 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:39:57 INFO - 2015-11-20 06:39:57,913 DEBUG : BROWSER_OUTPUT: |0;Richards;147.05882352941177 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;155.06280043417584 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4822.115384615385 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |4;RayTrace;940.7337723424271 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |5;Earley;724.112961622013 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |6;Boyer;15656.25 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |8;Splay;673.3333333333334 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4554.545454545455 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: __startTimestamp1448030397911__endTimestamp 06:39:57 INFO - 2015-11-20 06:39:57,914 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.06 Median:147.06 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: Values: 147.1 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:155.06 Median:155.06 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: Values: 155.1 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: Values: 280.0 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,915 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: Values: 4822.1 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:940.73 Median:940.73 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: Values: 940.7 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:724.11 Median:724.11 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: Values: 724.1 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15656.25 Median:15656.25 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: Values: 15656.3 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,916 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,917 DEBUG : BROWSER_OUTPUT: Values: 26868.4 06:39:57 INFO - 2015-11-20 06:39:57,918 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,918 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:673.33 Median:673.33 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,918 DEBUG : BROWSER_OUTPUT: Values: 673.3 06:39:57 INFO - 2015-11-20 06:39:57,918 DEBUG : BROWSER_OUTPUT: 06:39:57 INFO - 2015-11-20 06:39:57,918 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4554.55 Median:4554.55 stddev:0.00 (0.0%) 06:39:57 INFO - 2015-11-20 06:39:57,918 DEBUG : BROWSER_OUTPUT: Values: 4554.5 06:39:57 INFO - 2015-11-20 06:39:57,918 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:39:57 INFO - 2015-11-20 06:39:57,918 DEBUG : BROWSER_OUTPUT: 06:39:58 INFO - 2015-11-20 06:39:58,519 INFO : Browser exited with error code: 0 06:39:58 INFO - 2015-11-20 06:39:58,537 INFO : Completed test v8_7 (00:00:37) 06:39:59 INFO - 2015-11-20 06:39:59,010 INFO : Completed test suite (00:20:05) 06:39:59 INFO - 2015-11-20 06:39:59,010 DEBUG : Working with test: dromaeo_css 06:39:59 INFO - 2015-11-20 06:39:59,010 DEBUG : Generating results file: dromaeo_css 06:39:59 INFO - 2015-11-20 06:39:59,011 DEBUG : Working with test: kraken 06:39:59 INFO - 2015-11-20 06:39:59,011 DEBUG : Generating results file: kraken 06:39:59 INFO - 2015-11-20 06:39:59,011 INFO : javascript benchmark 06:39:59 INFO - 2015-11-20 06:39:59,012 DEBUG : Working with test: v8_7 06:39:59 INFO - 2015-11-20 06:39:59,012 DEBUG : Generating results file: v8_7 06:39:59 INFO - 2015-11-20 06:39:59,012 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:59 INFO - 2015-11-20 06:39:59,407 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 06:39:59 INFO - 2015-11-20 06:39:59,407 DEBUG : process_Request line: dromaeo_css 7700.44 graph.html#tests=[[72,1,61]] 06:39:59 INFO - 2015-11-20 06:39:59,408 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:59 INFO - 2015-11-20 06:39:59,432 DEBUG : process_Request line: kraken 1494.70 graph.html#tests=[[232,1,61]] 06:39:59 INFO - 2015-11-20 06:39:59,432 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:59 INFO - 2015-11-20 06:39:59,462 DEBUG : process_Request line: v8_7 21701.25 graph.html#tests=[[230,1,61]] 06:39:59 INFO - 2015-11-20 06:39:59,463 INFO : javascript benchmark 06:39:59 INFO - 2015-11-20 06:39:59,465 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3445.9655403445963, 3518.8064656443903, 3537.911552211196, 3562.8040457774828, 3577.445495948128, 5183.2743415921805, 5671.489565939065, 5940.34656187819, 5965.463108320256, 6022.548308876835, 5626.493615574597, 5699.344575373833, 5871.823845284637, 5920.822375328737, 6018.638881667092, 5347.786088556453, 5370.99999999999, 5432.511074003339, 5502.752376143083, 5505.642133261345, 5499.010178167928, 5509.421510741355, 5512.91730624041, 5557.277553917985, 5568.192612071247, 5225.346831646044, 5295.152775555893, 5361.651492652984, 5370.248165256867, 5479.890402191953, 5403.918941215885, 5406.216098665711, 5421.376541697677, 5441.047816632113, 5457.426970168115, 5387.353517577876, 5393.622446428752, 5408.13469844823, 5409.756560954727, 5427.426046446526, 4850.369451971221, 5439.891202175934, 5615.326160860682, 5814.5057670098095, 5963.850903727398, 6281.654509002003, 6282.120503129566, 6296.338884417162, 6297.118403423478, 6321.6523091229965, 6305.8108256752375, 6358.904616430757, 6360.173177486943, 6375.234971803413, 6381.234251889757, 5915.792947246869, 6026.186464827236, 6044.848878778022, 6128.403213820837, 6146.678464130234, 6506.707198176094, 6528.183977002875, 6538.346165383424, 6538.509611779135, 6569.540132190797, 6125.265974675666, 6275.121482992385, 6303.464205542488, 6325.0, 6333.778317758856, 5260.263563101169, 6289.622622642656, 6338.080978258219, 6355.872882542323, 6418.903716444257, 6293.465055470245, 6319.8104056878365, 6332.778352757631, 6357.364263573698, 6365.522585806083, 6198.969005154945, 6333.556651034475, 6337.0, 6360.204974378203, 6374.617522948638, 5039.470855560114, 5120.103981803244, 5124.180131178993, 5130.358705161855, 5196.376434827769, 4465.24090904547, 4504.635066590001, 4522.3668686383935, 4526.547345265513, 4593.448786145684, 5668.234788303609, 5805.245318108618, 5863.2670916135485, 5889.322727886262, 5929.940700593025, 6348.682565871688, 6353.61878287295, 6400.615963042233, 6403.647799370986, 6408.551401401857, 5021.0, 5868.471837534642, 5940.46535811779, 5949.732262048218, 5970.194023806817, 5392.811251606254, 5396.4603539646505, 5491.28613280279, 5521.613487055867, 5528.55771538276, 6462.579932304385, 6502.739890404331, 6508.3491650835485, 6549.0176473527445, 6559.7376104955265, 6301.0, 6363.713632886439, 6390.360963903572, 6396.552241343062, 6401.8719625608155, 6046.606970546901, 6357.205349331333, 6422.614643121427, 6442.2591401989375, 6519.185101862267, 5708.4862362387585, 6285.560548840595, 6336.936630633819, 6359.936400635935, 6429.32492088324, 6216.813495595139, 6409.262934762562, 6409.583377080475, 6413.583117097373, 6424.261209960728, 5968.104784282393, 6181.196444462371, 6307.716152773228, 6308.936910630835, 6315.147455093504, 6300.149479820166, 6320.5891617044745, 6321.652309123042, 6322.36776322364, 6349.619022858643, 5961.2846458425265, 6072.757089716539, 6185.505159587312, 6218.689065546795, 6231.096491008869, 6173.166622505904, 6243.906341404973, 6248.968755156195, 6292.339304373158, 6323.177986861679, 6167.198264225622, 6222.16000839899, 6233.2208473940755, 6244.812655620339, 6254.21822272216], "unit": "ms", "name": "dojo.html", "value": 5844.274573081021}, {"lowerIsBetter": false, "replicates": [553.8228349899438, 572.6535446055136, 575.6603603873714, 594.7858770842496, 618.5886385553607, 40248.39627405588, 40337.0, 40542.7972860136, 40615.39076913849, 40705.3894191587, 43885.68342949708, 43955.78022109885, 44280.0, 44319.77840110803, 44396.77801610987, 9858.950705246481, 9917.057879501472, 9933.552990115462, 9955.950220248926, 9967.700968970943, 9747.658831940884, 9818.263630227726, 9854.950725246365, 9865.950670246675, 9866.112049915506, 8653.48079115252, 8943.821123577525, 9753.073458021512, 9784.26618003649, 9846.212303015778, 9840.409575425498, 9880.209583233323, 9904.25718071144, 9919.20646348294, 9920.40477571348, 9702.223822094216, 9796.069373409515, 9823.214142868554, 9833.704988850346, 9838.311318207729, 40080.39879401811, 40571.188576228604, 40645.1870962582, 40818.795906020576, 41393.172136557405, 3242.4649932761067, 3258.8370581471067, 3279.360524697685, 3300.092474569489, 3496.7727097738566, 24950.251492455256, 27635.756390962455, 28510.429791404054, 28851.84592616293, 29049.0, 2796.944061118766, 2806.733360330765, 2843.0, 2900.419916016784, 2976.940461190764, 442637.0, 445282.77358613326, 445392.0, 446351.0, 446541.0, 59386.10920836191, 60989.39010609926, 62587.68706156531, 63971.0, 64069.35930640727, 69997.65001174962, 70195.2980470199, 70974.0, 70984.2901570988, 71068.0, 15355.309011094527, 15716.29276682552, 15823.287952042187, 15871.047737135808, 16032.358705651877, 10213.33613315132, 10283.588656453807, 11986.46060927243, 12006.75986480283, 12104.394780260951, 20198.59602807965, 20281.0, 20531.665441746238, 20631.277905273542, 20669.0, 7355.175308839481, 8030.63479208536, 8540.957295213484, 8692.348073894484, 8747.781305467413, 945.5886689290181, 952.5475399185332, 957.262907561174, 1102.818035024228, 1111.994440027811, 28447.719852606682, 29237.415251694845, 29756.0, 30105.548416773767, 30256.54615180774, 984.4634674102488, 1010.7416266747946, 1088.5319312695617, 1089.7983872983523, 1091.1161958813386, 15159.0, 15316.540503784905, 15495.690086198212, 15769.369225231092, 15894.76157857633, 556558.0, 560927.0, 563572.0, 571445.0, 571450.0, 56724.432755671914, 57281.42718572761, 57489.56276093047, 57766.42233577611, 57926.0, 1438.3958737330556, 1445.3568162167735, 1465.2600436779358, 1467.5670677150267, 1602.8156761972523, 30131.096067118022, 30227.0, 30392.544111838783, 30556.388872222877, 30607.54088688716, 50305.99388012146, 50645.24032139447, 51192.488075120265, 51200.719982000744, 51253.74373128259, 517694.0, 519154.0, 522098.0, 522414.0, 524792.3760381173, 26838.86580567085, 30645.927392541154, 32910.0, 33555.32889342151, 33740.32519349649, 43672.56327436685, 52301.0, 54614.72692636511, 55730.0, 57517.13724294055, 41138.38292425556, 41829.1634167321, 41874.79062604668, 42879.3568096485, 42891.57108428876, 41423.37864932089, 41692.0, 41760.0, 41778.0, 42457.726268212005, 39523.604763953146, 40545.1890962185, 40859.0, 41087.794561027, 41352.966175845846, 34479.13802154966, 36465.63534364622, 36843.17567399964, 37037.0, 37228.441573376964, 25828.741712583385, 27303.31741706394, 27582.310442239104, 27632.86183569069, 27777.44445111046], "unit": "ms", "name": "ext.html", "value": 20369.97051849804}, {"lowerIsBetter": false, "replicates": [358.17976833052313, 358.7919006975953, 365.60332039736886, 366.976146550474, 370.43323714716496, 15963.441279555218, 20010.29963951262, 20833.479163020933, 21345.573088538218, 21480.677789833164, 19993.0, 20039.899800501014, 20177.596448071028, 20361.796382036177, 20610.38168854933, 5057.620678449112, 5200.687958722479, 5295.126304159809, 5322.494363035506, 5333.4399888011785, 5165.63840531163, 5657.094864821629, 5806.564507661921, 5810.970945145268, 5811.244538210027, 3894.104355998122, 4690.390249267591, 4930.827421040264, 5783.0, 5791.826245212629, 4892.730899800509, 5797.188393624896, 5800.245968024172, 5806.0, 5806.332271788756, 5419.864503387407, 5518.392976772552, 5558.333000039981, 5567.164925261202, 5568.693721845297, 13008.804867926989, 13163.934180329134, 13221.603351899459, 20968.05643746035, 24991.875040624862, 1913.6651086059883, 1917.6068905874401, 1990.4426760506935, 2060.423081537172, 2255.7405898321576, 9989.75025624358, 10101.444420556867, 11496.655100347003, 13631.045826792128, 14456.0, 1634.991825040867, 1695.3727120965323, 1761.031432712016, 1793.246836328745, 1804.1520485371855, 100182.0, 104316.0, 105715.0, 106018.0, 106429.0, 11160.716517600418, 11183.384913829655, 11186.0, 11261.887381126247, 11292.830607540893, 13190.73618527624, 13216.867831321755, 13240.668983275495, 13247.470101195844, 13250.204987700768, 8153.633086511121, 8227.958860205781, 8270.214329638675, 8280.337572994145, 8371.079181290053, 8122.268995790289, 8274.710385136492, 8328.125546817619, 8331.50010999342, 8359.289460395812, 3503.8787587972115, 3567.625399333033, 3838.712096592711, 4377.8248870044845, 4408.603225709701, 1814.8911065336122, 1866.011014162496, 1875.6717574424695, 1877.9436616901514, 1885.6700077486385, 378.10012171032764, 390.6542709701877, 881.7751473374377, 949.4398305000083, 952.9761755956018, 11087.778244435227, 11542.596009139808, 11781.293122412682, 11802.94098529519, 21082.683759743617, 908.255230710824, 933.1927882381826, 951.8001219743932, 988.8516722491684, 990.346371394876, 10644.787104257872, 10817.242793004572, 10921.310836924324, 10943.945280273547, 11009.944950275198, 580284.0, 583746.0, 593857.0, 729899.0, 730564.0, 107937.0, 113201.0, 115025.84974150152, 115880.84119158701, 118417.0, 1179.1333369973063, 1216.1486959128645, 1222.1139673736648, 1223.6329101269584, 1226.5093962415106, 18023.2790688371, 18234.0, 18254.178561964476, 18571.81428185701, 18834.811651883305, 51606.12954028388, 52041.7397913008, 52362.0, 52490.475095248556, 52557.0, 71407.5718485617, 73305.0, 73595.0, 74101.62949185219, 74125.62937185279, 9684.51577421112, 9884.752881178028, 9939.751506212113, 9948.950255248677, 10096.091351778376, 19706.80293197107, 19807.405777826687, 20024.39926802198, 20123.295684650966, 20379.59240815205, 15873.444429445375, 15947.840521594635, 16009.91995040064, 16091.0, 16458.42395516151, 10005.299629026189, 10071.143952764098, 10190.490475476048, 10220.182385409298, 10362.0, 10356.533955971849, 10407.06336429725, 10509.159267258754, 10558.04977552024, 10587.788244234918, 16891.831081689517, 17088.316467341167, 17091.829081709024, 17777.46667599974, 17987.920724756033, 17103.14484275806, 17357.913210433868, 17428.302867885144, 17578.64842703113, 17687.911560442117], "unit": "ms", "name": "jquery.html", "value": 9616.025193995778}, {"lowerIsBetter": false, "replicates": [1512.8562786535276, 1716.8884022538534, 1843.612841303327, 1861.004362665973, 1944.2903340280802, 7539.208383119762, 7656.502327348719, 8233.053198882131, 8355.37334699897, 8355.874661880069, 8145.714899978502, 8208.712695055674, 8308.044574873891, 8364.874526882102, 8382.371322150833, 2359.870207138611, 2391.557561851063, 2398.568257713611, 2399.3761621978324, 2405.3625789165885, 2392.545416370884, 2417.0331867253153, 2431.7811396974357, 2457.4716435966266, 2462.0, 2390.0917651292484, 2391.820613453989, 2421.455172586163, 2421.4551725861716, 2424.987875060622, 2257.3792207143, 2290.828187885907, 2300.654901764732, 2313.2713195343413, 2317.4090606895134, 2380.297812145421, 2405.2183040511904, 2426.235735743253, 2427.7329493755674, 2428.1865575032384, 8476.0, 8593.097724738875, 8596.656133754643, 8612.009618893844, 8616.741497755078, 5183.637145399824, 5207.505286997767, 5213.7393130343335, 5256.710880901549, 5272.920906186372, 3493.2489514754448, 3571.624979377154, 3615.891523254307, 3617.5116359291424, 3624.9275014499826, 1044.3107549017611, 1055.456439933435, 1059.5761695321855, 1075.2150929821273, 1075.7687097274124, 11143.33140011602, 11158.330500169935, 11195.0, 11209.551617935273, 11212.831807522894, 3928.9803550982633, 4529.437344116341, 4689.20283551797, 4696.694714843593, 4739.715617062987, 9619.038096190465, 9668.903310966942, 9693.127618514367, 9712.22302215821, 9746.31775775689, 5209.374875014947, 5217.0, 5222.190560463135, 5245.501677340647, 5247.527722504917, 4164.1879833432795, 4246.426732391149, 4666.976665116653, 4715.127701375257, 4730.9763451182525, 3088.7528997680133, 3878.5151856017997, 3900.8829735107993, 3924.6664033557468, 3933.803309834554, 1109.4951796932376, 1271.8235632040326, 1277.6869666931661, 1278.360819590205, 1286.1897004887048, 1031.742064483879, 1068.9037986581245, 1128.8927551882557, 1132.7847708935276, 1137.635956493914, 7882.251186137308, 7904.644291006918, 7907.2488113629115, 7919.960400197962, 7920.049594048636, 496.4340651657114, 501.41084226034263, 502.52762403340745, 506.2204205523453, 506.68079110160363, 6056.697165141725, 6095.542834287447, 6102.115193296947, 6131.294901086432, 6136.2636483622255, 9925.255605829592, 10172.694819155437, 10202.693919182437, 10299.12457441111, 10329.380237185793, 9971.650992215238, 10069.395836249849, 10081.14310283634, 10107.494625268708, 10112.342697724624, 7980.800479988046, 8020.558869262247, 8087.5551844647935, 8101.311388532041, 8169.959150204211, 7593.354564862048, 7622.771316860503, 7634.9311096445435, 7656.846863062819, 7707.34487568563, 7982.281594656509, 8527.872081918653, 8976.281897448058, 9051.366404351633, 9067.727968160965, 9164.725058248263, 9236.122568355995, 9306.767330816783, 9347.439153650803, 9453.196478299422, 6460.67696615158, 6659.800205993828, 6964.756233531802, 7249.492535522463, 7281.417486600953, 7935.484193527403, 7946.960265198868, 7956.323712484504, 7968.123506414174, 7989.081255655442, 7357.558546487228, 7546.0, 7547.773566793005, 7593.0, 7682.807929801576, 7401.96299018523, 7428.851422971402, 7452.925470745223, 7573.659185336784, 7593.5823529706395, 7548.811279718051, 7558.093028836574, 7568.924310756822, 7586.431017673586, 7594.924050759421, 6734.057231987624, 6851.623160726208, 6875.7937261882225, 6921.792346229621, 6952.0, 6999.545029573062, 7005.124359455068, 7039.331263529956, 7065.0815393998455, 7100.75736746057], "unit": "ms", "name": "mootools.html", "value": 4677.3364140143685}, {"lowerIsBetter": false, "replicates": [277.10771316361314, 323.956265904103, 327.497291657306, 329.7576281433145, 330.28987676495547, 5592.490027692521, 5850.824475265744, 6976.755813546527, 7038.099713077479, 7228.674709638072, 5927.940720592804, 6119.785807496739, 6816.625085620289, 7199.6040217788, 7218.999999999987, 4169.60388763067, 4908.460069392382, 5049.293098966129, 5060.392752869642, 5172.172452407615, 5097.260897169908, 5107.719075450867, 5167.250748641445, 5168.01807656544, 5175.8188463403785, 5080.187170052793, 5089.567386772129, 5092.872678183038, 5107.9744601277125, 5148.510891465305, 5089.54194122527, 5092.949070509285, 5093.286939828427, 5095.490450954912, 5096.617753668471, 4181.519125300569, 4260.510041345254, 4287.914241715148, 4288.69979101463, 4289.935650965238, 6761.222459417181, 6775.254721980627, 6803.197152754524, 6816.0, 6841.042254084432, 5925.111233314994, 5970.940290597126, 5979.1464645959895, 5983.521318294526, 5998.640081595118, 7346.889796653055, 7561.962190189014, 7564.886526702104, 7585.734499292554, 7617.00978872743, 3917.7061720371084, 4771.618270538349, 4773.856784296442, 4775.662814411936, 4776.307435421879, 7993.320567751748, 8011.359091272684, 8028.237317454832, 8035.718749843727, 8044.798880027987, 4717.5282471753235, 4793.161196790547, 4821.7589120543835, 4854.834839638532, 4872.123017856819, 4931.753412329369, 4933.210686290176, 4934.210526315772, 4958.256261560723, 4959.876003099879, 5937.940620593825, 5956.076808094752, 5957.404259574095, 5972.731227094791, 5973.641581505123, 7511.0566952350455, 7633.427492938052, 7635.618219089023, 7680.846383072308, 7703.499272547267, 1696.3299496698735, 1715.6911755884062, 1717.931282748676, 1718.5875389906582, 1718.6390857919978, 1063.2663462211049, 1066.7493139112303, 1081.453865797767, 1084.5011294804322, 1091.9508622112023, 5896.911546326723, 6461.19235095613, 6534.497065674921, 7148.392386647193, 7234.204237533867, 8032.4778889372, 8058.315043221274, 8094.51432914027, 8111.229433203955, 8127.3904457165945, 6958.582485050913, 7195.352418282275, 7208.7476938307955, 7217.458690598226, 7231.855362892713, 4220.599043090901, 4249.87250382489, 4251.9787401062795, 4252.596003379674, 4266.530681625019, 8293.95853020743, 8299.8340033199, 8300.833983320299, 8306.6677332906, 8340.916590834015, 7429.888551671729, 7672.884906726404, 8047.396445266629, 8268.545230012407, 8322.084570697218, 6339.461145802658, 8226.958865205635, 8230.300424463987, 8277.793055173548, 8300.83398332042, 7077.7168913242895, 7225.602591857288, 8010.359171266168, 8017.759467215759, 8022.759317220492, 6725.630090345078, 7809.882851757342, 7859.410544209093, 7886.369090472634, 7921.207879212263, 8208.46644968075, 8210.548419836967, 8242.423030387816, 8265.256126948603, 8272.83454330898, 4738.644601654959, 4812.975935120442, 4863.3434486343895, 4872.366592342973, 4877.6829506081995, 6332.778352757631, 7111.2533184017, 7166.319199676022, 7979.241972012649, 8002.079760827346, 7687.2697093776005, 7699.230076992256, 7699.307062364414, 7743.5353878767455, 7767.766966990774, 7434.59109748969, 7640.656170472231, 7652.617369131633, 7663.314070904615, 7671.53970761756, 7476.140243872024, 7479.850402991801, 7505.887411688938, 7545.773626791205, 7549.584772837547, 6100.847478813065, 7329.413646908128, 7463.552186868806, 7670.501417407851, 7681.961590192013, 7439.032925719622, 7478.887816682645, 7484.588347640932, 7496.850062998818, 7498.287662672037], "unit": "ms", "name": "prototype.html", "value": 5439.737635521849}, {"lowerIsBetter": false, "replicates": [740.5852722475411, 754.4040208235496, 761.2577736706712, 791.3431851563203, 874.2918236228651, 13497.797533037, 16047.197640117976, 16353.672926541476, 16369.0, 16377.18114094295, 16649.25078371473, 16742.58143546412, 16746.078965656885, 16754.74867876983, 16816.32734690611, 773.3465221887524, 778.8364443466879, 944.6363150187176, 950.9714708558754, 968.0416387776086, 967.2020583019003, 967.7870868408974, 968.4334664221403, 977.911987921087, 978.5449765858874, 1012.3217444312328, 1017.1506791828832, 1021.0963297481745, 1022.1924679503221, 1022.9335093218917, 1006.8791744990612, 1014.2899970021015, 1017.9847302290472, 1018.5671089786811, 1020.7499162705147, 755.1768572256212, 759.6999185321822, 760.5170716594947, 762.3558093411059, 763.4503157726429, 14094.0, 14121.08212966154, 14167.78748318776, 14219.50231741884, 14274.072185308025, 12328.260304381676, 12451.626451206479, 12552.560660376843, 12630.49478020878, 13166.539171128965, 10310.793784124351, 10396.012378824, 10476.423796691179, 10895.618653347174, 11672.533098676044, 3564.21587250807, 3590.461430785377, 3629.038304849217, 3645.0340659725193, 3720.3489389356755, 71247.0, 72623.91064134095, 73075.0, 73225.90161147587, 73752.63123684347, 9269.629214831466, 9305.627774888928, 9354.71935841926, 9564.90435095654, 9690.176335011603, 20724.0, 21067.8946605266, 21201.257955971774, 21252.78747212539, 21282.574348512942, 7398.815029624302, 7435.442341824385, 7509.098908131059, 7701.768946931601, 7835.882461762964, 4118.814653340607, 4147.771872547039, 4152.688548358825, 4344.869653910388, 4381.255186618282, 3399.983000084984, 3414.778039427429, 3424.298018906118, 3455.8444869980913, 3458.6714262145056, 630.2720357986533, 633.7053270229273, 638.8115505925763, 655.924568674599, 663.8041777675597, 515.4021335251091, 539.692375346049, 541.2503682399904, 587.2649946341267, 600.2916558460971, 8776.824463510822, 8796.604152813139, 8913.598888050054, 8943.686970955985, 9009.729708108767, 507.5127877237893, 516.7519590596535, 523.7549660005675, 538.5449295345427, 547.4689551135392, 3584.713222942158, 4098.4876890388705, 4162.959260184954, 4217.388478670637, 4314.201872653569, 105100.0, 105120.0, 105247.42128868074, 105390.0, 105980.47009764901, 85641.28717425617, 87891.12108878829, 90690.54654726684, 90851.0, 91139.0, 76204.0, 76489.23510764822, 76522.55648495832, 77121.0, 79001.0, 8421.578921054046, 8491.532965686947, 8565.614547345509, 8689.478631282143, 8776.385653004229, 42678.78660606677, 51475.71310717262, 52042.0, 53161.0, 53672.92654146817, 67127.66436167984, 69080.0, 74252.62873685597, 74378.0, 74548.0, 11176.608818691308, 11488.885111148782, 11557.47991340375, 11639.53441862316, 12140.210886292363, 11579.247348922294, 11800.468978895799, 12229.327386993446, 12275.69310767238, 12692.555760548337, 11532.94233528827, 11593.6521904343, 11672.824907626562, 11831.881681183078, 12265.080118990933, 11633.0, 11818.897088848305, 11850.58522951727, 11995.220310679779, 12132.272063676208, 11384.430778460877, 12111.878881211427, 12113.69715757113, 12118.454669539715, 12418.627441176779, 9844.556994935101, 9867.851982220416, 10233.641822536176, 10251.948740256252, 10552.894471055499, 9599.712008639752, 10015.899841001497, 10319.845202322122, 10324.48377581103, 10336.0], "unit": "ms", "name": "yui.html", "value": 7157.565726572018}], "name": "dromaeo_css", "value": 7700.443018850867}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 107.0, 115.0, 113.0, 114.0, 123.0, 115.0, 114.0, 113.0, 132.0], "unit": "ms", "name": "ai-astar", "value": 116.3}, {"lowerIsBetter": true, "replicates": [147.0, 133.0, 144.0, 156.0, 126.0, 149.0, 140.0, 128.0, 158.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.3}, {"lowerIsBetter": true, "replicates": [190.0, 195.0, 193.0, 195.0, 218.0, 264.0, 272.0, 207.0, 181.0, 268.0], "unit": "ms", "name": "audio-dft", "value": 218.3}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 72.0, 112.0, 56.0, 56.0, 59.0, 59.0, 112.0, 58.0], "unit": "ms", "name": "audio-fft", "value": 70.9}, {"lowerIsBetter": true, "replicates": [76.0, 79.0, 109.0, 76.0, 78.0, 78.0, 110.0, 77.0, 79.0, 110.0], "unit": "ms", "name": "audio-oscillator", "value": 87.2}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 87.0, 88.0, 118.0, 76.0, 134.0, 134.0, 87.0, 86.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 98.5}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 94.0, 95.0, 97.0, 96.0, 95.0, 97.0, 104.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 96.6}, {"lowerIsBetter": true, "replicates": [149.0, 153.0, 91.0, 94.0, 87.0, 147.0, 137.0, 121.0, 90.0, 93.0], "unit": "ms", "name": "imaging-desaturate", "value": 116.2}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 66.0, 50.0, 49.0], "unit": "ms", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [64.0, 70.0, 67.0, 67.0, 70.0, 67.0, 69.0, 67.0, 73.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 84.0, 84.0, 84.0, 79.0, 82.0, 83.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [138.0, 120.0, 137.0, 127.0, 134.0, 124.0, 132.0, 126.0, 138.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [124.0, 176.0, 176.0, 135.0, 135.0, 144.0, 135.0, 140.0, 138.0, 125.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 67.0, 66.0, 69.0, 68.0, 66.0, 69.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1494.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.05882352941177], "unit": "score", "name": "Richards", "value": 240.05360000000005}, {"lowerIsBetter": false, "replicates": [155.06280043417584], "unit": "score", "name": "DeltaBlue", "value": 426.3949820000001}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "Decrypt", "value": 55.20004785643067}, {"lowerIsBetter": false, "replicates": [940.7337723424271], "unit": "score", "name": "RayTrace", "value": 786.6083070000002}, {"lowerIsBetter": false, "replicates": [724.112961622013], "unit": "score", "name": "Earley", "value": 920.3854029999999}, {"lowerIsBetter": false, "replicates": [15656.25], "unit": "score", "name": "Boyer", "value": 42.56849500998002}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [673.3333333333334], "unit": "score", "name": "Splay", "value": 121.02623762376237}, {"lowerIsBetter": false, "replicates": [4554.545454545455], "unit": "score", "name": "NavierStokes", "value": 325.8283433133734}], "name": "v8_7", "value": 21701.25368888768}]} 06:39:59 INFO - RETURN: dromaeo_css: 7700.44 06:39:59 INFO - RETURN: kraken: 1494.70 06:39:59 INFO - RETURN: v8_7: 21701.25 06:39:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,61]]", "result": "21701.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1494.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7700.44"}}} 06:39:59 INFO - Return code: 0 06:39:59 INFO - # TBPL SUCCESS # 06:39:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:39:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:39:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:39:59 INFO - 2015-11-20 06:39:59.573 screenresolution[2570:27834] starting screenresolution argv=screenresolution get 06:39:59 INFO - 2015-11-20 06:39:59.576 screenresolution[2570:27834] Display 0: 1600x1200x32@60 06:39:59 INFO - 2015-11-20 06:39:59.582 screenresolution[2571:27837] starting screenresolution argv=screenresolution list 06:39:59 INFO - Available Modes on Display 0 06:39:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:39:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:39:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:39:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:39:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:39:59 INFO - Intel Iris: 06:39:59 INFO - Chipset Model: Intel Iris 06:39:59 INFO - Type: GPU 06:39:59 INFO - Bus: Built-In 06:39:59 INFO - VRAM (Dynamic, Max): 1536 MB 06:39:59 INFO - Vendor: Intel (0x8086) 06:39:59 INFO - Device ID: 0x0a2e 06:39:59 INFO - Revision ID: 0x0009 06:39:59 INFO - Displays: 06:39:59 INFO - Display: 06:39:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:39:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:39:59 INFO - Display Serial Number: 1600x1200 60 06:39:59 INFO - Main Display: Yes 06:39:59 INFO - Mirror: Off 06:39:59 INFO - Online: Yes 06:39:59 INFO - Rotation: Supported 06:39:59 INFO - Return code: 0 06:39:59 INFO - Running post-action listener: _resource_record_post_action 06:39:59 INFO - Running post-run listener: _resource_record_post_run 06:40:00 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 2314240; Write bytes: 695130624; Read time: 34; Write time: 2205 06:40:00 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 342577664; Write bytes: 338867200; Read time: 27698; Write time: 608 06:40:00 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 2314240; Write bytes: 345892352; Read time: 34; Write time: 1561 06:40:00 INFO - Running post-run listener: _upload_blobber_files 06:40:00 INFO - Blob upload gear active. 06:40:00 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:40:00 INFO - Copying logs to upload dir... 06:40:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.143993 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-20 06:40:00.944117) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:40:00.947324) ========= 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.xPUomqCbMK/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.oMyT1DU6zS/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009512 build_url: 'https://queue.taskcluster.net/v1/task/JIJSHnNWR3G174Dj-_JmzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:40:00.970742) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:40:00.971183) ========= 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.xPUomqCbMK/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.oMyT1DU6zS/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005289 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:40:01.021910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 06:40:01.022633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 06:40:01.023502) ========= ========= Total master_lag: 0.22 =========