builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0010 starttime: 1447745061.55 results: success (0) buildid: 20151116220542 builduid: 3d0d4eb4476a4c559327afa15b3ee5cb revision: 2f103f5a44ffcbef4fc27617a6a6431b96699631 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.554623) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.555110) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.555453) ========= 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.VkfWibQBzF/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.4Jb2pSQKkk/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006069 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.624694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.625037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.736398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.736721) ========= 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.VkfWibQBzF/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.4Jb2pSQKkk/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005511 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.812927) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.813484) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.813890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:21.814257) ========= 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.VkfWibQBzF/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.4Jb2pSQKkk/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-16 23:24:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, :: Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.55M=0.002s 2015-11-16 23:24:22 (7.55 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.395984 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.236224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.236537) ========= 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.VkfWibQBzF/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.4Jb2pSQKkk/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.019801 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.290763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.291605) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2f103f5a44ffcbef4fc27617a6a6431b96699631 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2f103f5a44ffcbef4fc27617a6a6431b96699631 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-16 23:24:22,365 truncating revision to first 12 chars 2015-11-16 23:24:22,365 Setting DEBUG logging. 2015-11-16 23:24:22,365 attempt 1/10 2015-11-16 23:24:22,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/2f103f5a44ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 23:24:22,640 unpacking tar archive at: mozilla-inbound-2f103f5a44ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.892613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.893034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.925763) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.926216) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 23:24:22.926836) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-16 23:24:22.930493) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 23:24:23 INFO - MultiFileLogger online at 20151116 23:24:23 in /builds/slave/test 23:24:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 23:24:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:23 INFO - {'append_to_log': False, 23:24:23 INFO - 'base_work_dir': '/builds/slave/test', 23:24:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 23:24:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:23 INFO - 'branch': 'Mozilla-Inbound', 23:24:23 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:23 INFO - 'config_files': ('talos/mac_config.py',), 23:24:23 INFO - 'default_actions': ('clobber', 23:24:23 INFO - 'read-buildbot-config', 23:24:23 INFO - 'download-and-extract', 23:24:23 INFO - 'populate-webroot', 23:24:23 INFO - 'create-virtualenv', 23:24:23 INFO - 'install', 23:24:23 INFO - 'run-tests'), 23:24:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:23 INFO - 'download_minidump_stackwalk': True, 23:24:23 INFO - 'download_symbols': 'ondemand', 23:24:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:23 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:23 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:23 INFO - 'installer_path': 'installer.exe', 23:24:23 INFO - 'log_level': 'info', 23:24:23 INFO - 'log_name': 'talos', 23:24:23 INFO - 'log_to_console': True, 23:24:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:24:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:24:23 INFO - 'opt_config_files': (), 23:24:23 INFO - 'pip_index': False, 23:24:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:24:23 INFO - 'cmd': ('bash', 23:24:23 INFO - '-c', 23:24:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:24:23 INFO - 'enabled': True, 23:24:23 INFO - 'halt_on_failure': False, 23:24:23 INFO - 'name': 'check_screen_resolution'},), 23:24:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:24:23 INFO - 'cmd': ('bash', 23:24:23 INFO - '-c', 23:24:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:24:23 INFO - 'enabled': True, 23:24:23 INFO - 'halt_on_failure': False, 23:24:23 INFO - 'name': 'check_screen_resolution'},), 23:24:23 INFO - 'run_cmd_checks_enabled': True, 23:24:23 INFO - 'sps_profile': False, 23:24:23 INFO - 'sps_profile_interval': 0, 23:24:23 INFO - 'suite': 'dromaeojs', 23:24:23 INFO - 'system_bits': '64', 23:24:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:23 INFO - 'title': 't-yosemite-r5-0010', 23:24:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:23 INFO - 'use_talos_json': True, 23:24:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:23 INFO - 'work_dir': 'build'} 23:24:23 INFO - ##### 23:24:23 INFO - ##### Running clobber step. 23:24:23 INFO - ##### 23:24:23 INFO - Running pre-action listener: _resource_record_pre_action 23:24:23 INFO - Running main action method: clobber 23:24:23 INFO - rmtree: /builds/slave/test/build 23:24:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:25 INFO - Running post-action listener: _resource_record_post_action 23:24:25 INFO - ##### 23:24:25 INFO - ##### Running read-buildbot-config step. 23:24:25 INFO - ##### 23:24:25 INFO - Running pre-action listener: _resource_record_pre_action 23:24:25 INFO - Running main action method: read_buildbot_config 23:24:25 INFO - Using buildbot properties: 23:24:25 INFO - { 23:24:25 INFO - "properties": { 23:24:25 INFO - "buildnumber": 3441, 23:24:25 INFO - "product": "firefox", 23:24:25 INFO - "script_repo_revision": "production", 23:24:25 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 23:24:25 INFO - "repository": "", 23:24:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 23:24:25 INFO - "buildid": "20151116220542", 23:24:25 INFO - "slavename": "t-yosemite-r5-0010", 23:24:25 INFO - "pgo_build": "False", 23:24:25 INFO - "basedir": "/builds/slave/test", 23:24:25 INFO - "project": "", 23:24:25 INFO - "platform": "yosemite", 23:24:25 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 23:24:25 INFO - "slavebuilddir": "test", 23:24:25 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 23:24:25 INFO - "branch": "mozilla-inbound", 23:24:25 INFO - "repo_path": "integration/mozilla-inbound", 23:24:25 INFO - "stage_platform": "macosx64", 23:24:25 INFO - "builduid": "3d0d4eb4476a4c559327afa15b3ee5cb", 23:24:25 INFO - "revision": "2f103f5a44ffcbef4fc27617a6a6431b96699631" 23:24:25 INFO - }, 23:24:25 INFO - "sourcestamp": { 23:24:25 INFO - "repository": "", 23:24:25 INFO - "hasPatch": false, 23:24:25 INFO - "project": "", 23:24:25 INFO - "branch": "mozilla-inbound-macosx64-talos", 23:24:25 INFO - "changes": [ 23:24:25 INFO - { 23:24:25 INFO - "category": null, 23:24:25 INFO - "files": [ 23:24:25 INFO - { 23:24:25 INFO - "url": null, 23:24:25 INFO - "name": "https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 23:24:25 INFO - } 23:24:25 INFO - ], 23:24:25 INFO - "repository": "", 23:24:25 INFO - "rev": "2f103f5a44ffcbef4fc27617a6a6431b96699631", 23:24:25 INFO - "who": "mbrubeck@mozilla.com", 23:24:25 INFO - "when": 1447745059, 23:24:25 INFO - "number": 6670393, 23:24:25 INFO - "comments": "Bug 1223366 - Update event.buttons on GDK_BUTTON_RELEASE [r=karlt]", 23:24:25 INFO - "project": "", 23:24:25 INFO - "at": "Mon 16 Nov 2015 23:24:19", 23:24:25 INFO - "branch": "mozilla-inbound-macosx64-talos", 23:24:25 INFO - "revlink": "", 23:24:25 INFO - "properties": [ 23:24:25 INFO - [ 23:24:25 INFO - "buildid", 23:24:25 INFO - "20151116220542", 23:24:25 INFO - "Change" 23:24:25 INFO - ], 23:24:25 INFO - [ 23:24:25 INFO - "builduid", 23:24:25 INFO - "3d0d4eb4476a4c559327afa15b3ee5cb", 23:24:25 INFO - "Change" 23:24:25 INFO - ], 23:24:25 INFO - [ 23:24:25 INFO - "pgo_build", 23:24:25 INFO - "False", 23:24:25 INFO - "Change" 23:24:25 INFO - ] 23:24:25 INFO - ], 23:24:25 INFO - "revision": "2f103f5a44ffcbef4fc27617a6a6431b96699631" 23:24:25 INFO - } 23:24:25 INFO - ], 23:24:25 INFO - "revision": "2f103f5a44ffcbef4fc27617a6a6431b96699631" 23:24:25 INFO - } 23:24:25 INFO - } 23:24:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 23:24:25 INFO - Running post-action listener: _resource_record_post_action 23:24:25 INFO - ##### 23:24:25 INFO - ##### Running download-and-extract step. 23:24:25 INFO - ##### 23:24:25 INFO - Running pre-action listener: _resource_record_pre_action 23:24:25 INFO - Running main action method: download_and_extract 23:24:25 INFO - mkdir: /builds/slave/test/build/tests 23:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:25 INFO - https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:24:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/test_packages.json 23:24:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/test_packages.json 23:24:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:24:25 INFO - Downloaded 1149 bytes. 23:24:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:24:25 INFO - Using the following test package requirements: 23:24:25 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:24:25 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:24:25 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 23:24:25 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:24:25 INFO - u'jsshell-mac.zip'], 23:24:25 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:24:25 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 23:24:25 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:24:25 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:24:25 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 23:24:25 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:24:25 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 23:24:25 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:24:25 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 23:24:25 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:24:25 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:24:25 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 23:24:25 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:25 INFO - https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:24:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:24:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:24:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/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 23:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/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 23:24:27 INFO - Downloaded 17465208 bytes. 23:24:27 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 23:24:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:24:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:24:33 INFO - Return code: 0 23:24:33 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 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:33 INFO - https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/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 23:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/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 23:24:42 INFO - Downloaded 17465208 bytes. 23:24:42 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 23:24:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:24:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:24:47 INFO - Return code: 0 23:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:47 INFO - https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:24:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:24:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:24:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/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 23:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/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 23:24:48 INFO - Downloaded 11131693 bytes. 23:24:48 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 23:24:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:24:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 23:24:49 INFO - Return code: 0 23:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:49 INFO - https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 23:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeS6xquyQHennq4-_6ifXw/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 23:24:52 INFO - Downloaded 108800175 bytes. 23:24:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:24:52 INFO - mkdir: /builds/slave/test/properties 23:24:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:52 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:52 INFO - Contents: 23:24:52 INFO - build_url:https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:24:52 INFO - Running post-action listener: _resource_record_post_action 23:24:52 INFO - Running post-action listener: set_extra_try_arguments 23:24:52 INFO - ##### 23:24:52 INFO - ##### Running populate-webroot step. 23:24:52 INFO - ##### 23:24:52 INFO - Running pre-action listener: _resource_record_pre_action 23:24:52 INFO - Running main action method: populate_webroot 23:24:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 23:24:52 INFO - '../fennec_ids.txt'], 23:24:52 INFO - 'tests': ['tcheck2']}, 23:24:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:52 INFO - '--tppagecycles', 23:24:52 INFO - '7'], 23:24:52 INFO - 'tests': ['tsvgm']}}, 23:24:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:24:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:24:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:24:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:52 INFO - 'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:52 INFO - 'tests': ['damp', 'tps']}, 23:24:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:52 INFO - 'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['damp', 'tps']}, 23:24:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:24:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:52 INFO - 'other': {'tests': ['a11yr', 23:24:52 INFO - 'ts_paint', 23:24:52 INFO - 'tpaint', 23:24:52 INFO - 'sessionrestore', 23:24:52 INFO - 'sessionrestore_no_auto_restore']}, 23:24:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['a11yr', 23:24:52 INFO - 'ts_paint', 23:24:52 INFO - 'tpaint', 23:24:52 INFO - 'sessionrestore', 23:24:52 INFO - 'sessionrestore_no_auto_restore']}, 23:24:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['a11yr', 23:24:52 INFO - 'ts_paint', 23:24:52 INFO - 'tpaint', 23:24:52 INFO - 'sessionrestore', 23:24:52 INFO - 'sessionrestore_no_auto_restore']}, 23:24:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['a11yr', 23:24:52 INFO - 'ts_paint', 23:24:52 INFO - 'tpaint', 23:24:52 INFO - 'sessionrestore', 23:24:52 INFO - 'sessionrestore_no_auto_restore']}, 23:24:52 INFO - 'other_l64': {'tests': ['a11yr', 23:24:52 INFO - 'ts_paint', 23:24:52 INFO - 'tpaint', 23:24:52 INFO - 'sessionrestore', 23:24:52 INFO - 'sessionrestore_no_auto_restore']}, 23:24:52 INFO - 'other_nol64': {'tests': ['a11yr', 23:24:52 INFO - 'ts_paint', 23:24:52 INFO - 'tpaint', 23:24:52 INFO - 'sessionrestore', 23:24:52 INFO - 'sessionrestore_no_auto_restore']}, 23:24:52 INFO - 'svgr': {'tests': ['tsvgx', 23:24:52 INFO - 'tsvgr_opacity', 23:24:52 INFO - 'tart', 23:24:52 INFO - 'tscrollx', 23:24:52 INFO - 'cart']}, 23:24:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['tsvgx', 23:24:52 INFO - 'tsvgr_opacity', 23:24:52 INFO - 'tart', 23:24:52 INFO - 'tscrollx', 23:24:52 INFO - 'cart']}, 23:24:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:52 INFO - 'tests': ['tp5o']}, 23:24:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:52 INFO - 'talos_options': ['--e10s'], 23:24:52 INFO - 'tests': ['tp5o']}, 23:24:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:52 INFO - 'talos_options': ['--xperf_path', 23:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:52 INFO - 'tests': ['tp5n']}, 23:24:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:52 INFO - 'talos_options': ['--e10s', 23:24:52 INFO - '--xperf_path', 23:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:52 INFO - 'tests': ['tp5n']}}, 23:24:52 INFO - 'talos.zip': {'path': '', 23:24:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:52 INFO - Running post-action listener: _resource_record_post_action 23:24:52 INFO - ##### 23:24:52 INFO - ##### Running create-virtualenv step. 23:24:52 INFO - ##### 23:24:52 INFO - Running pre-action listener: _resource_record_pre_action 23:24:52 INFO - Running main action method: create_virtualenv 23:24:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:24:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:52 INFO - Using real prefix '/tools/python27' 23:24:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:56 INFO - Installing pip.................done. 23:24:56 INFO - Return code: 0 23:24:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:56 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 0x10168f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10166c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015b29f0>, '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 0x101312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015a68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:24:56 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 23:24:56 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 23:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/Render', 23:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:56 INFO - 'HOME': '/Users/cltbld', 23:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:56 INFO - 'LOGNAME': 'cltbld', 23:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:56 INFO - 'MOZ_NO_REMOTE': '1', 23:24:56 INFO - 'NO_EM_RESTART': '1', 23:24:56 INFO - 'PAGER': '/bin/cat', 23:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:56 INFO - 'PWD': '/builds/slave/test', 23:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:56 INFO - 'SHELL': '/bin/bash', 23:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Jb2pSQKkk/Listeners', 23:24:56 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 23:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:56 INFO - 'USER': 'cltbld', 23:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:56 INFO - 'XPC_FLAGS': '0x0', 23:24:56 INFO - 'XPC_SERVICE_NAME': '0', 23:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:24:57 INFO - Cleaning up... 23:24:57 INFO - Return code: 0 23:24:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:57 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 0x10168f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10166c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015b29f0>, '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 0x101312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015a68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:24:57 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 23:24:57 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 23:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/Render', 23:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:57 INFO - 'HOME': '/Users/cltbld', 23:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:57 INFO - 'LOGNAME': 'cltbld', 23:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:57 INFO - 'MOZ_NO_REMOTE': '1', 23:24:57 INFO - 'NO_EM_RESTART': '1', 23:24:57 INFO - 'PAGER': '/bin/cat', 23:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:57 INFO - 'PWD': '/builds/slave/test', 23:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:57 INFO - 'SHELL': '/bin/bash', 23:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Jb2pSQKkk/Listeners', 23:24:57 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 23:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:57 INFO - 'USER': 'cltbld', 23:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:57 INFO - 'XPC_FLAGS': '0x0', 23:24:57 INFO - 'XPC_SERVICE_NAME': '0', 23:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:57 INFO - Downloading/unpacking psutil>=0.7.1 23:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:24:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:59 INFO - Installing collected packages: psutil 23:24:59 INFO - Running setup.py install for psutil 23:24:59 INFO - building 'psutil._psutil_osx' extension 23:24:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 23:25:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 23:25:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 23:25:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 23:25:00 INFO - building 'psutil._psutil_posix' extension 23:25:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 23:25:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:25:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:25:00 INFO - ^ 23:25:00 INFO - 1 warning generated. 23:25:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 23:25:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:25:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:25:00 INFO - Successfully installed psutil 23:25:00 INFO - Cleaning up... 23:25:00 INFO - Return code: 0 23:25:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:25: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')]} 23:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25: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')]} 23:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25: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', '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 0x10168f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10166c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015b29f0>, '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 0x101312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015a68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:25: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:25: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 mozsystemmonitor==0.0.0 23:25:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/Render', 23:25:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:00 INFO - 'HOME': '/Users/cltbld', 23:25:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:00 INFO - 'LOGNAME': 'cltbld', 23:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:00 INFO - 'MOZ_NO_REMOTE': '1', 23:25:00 INFO - 'NO_EM_RESTART': '1', 23:25:00 INFO - 'PAGER': '/bin/cat', 23:25:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:00 INFO - 'PWD': '/builds/slave/test', 23:25:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:00 INFO - 'SHELL': '/bin/bash', 23:25:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Jb2pSQKkk/Listeners', 23:25:00 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 23:25:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:00 INFO - 'USER': 'cltbld', 23:25:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:00 INFO - 'XPC_FLAGS': '0x0', 23:25:00 INFO - 'XPC_SERVICE_NAME': '0', 23:25:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:25:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:25:03 INFO - Installing collected packages: mozsystemmonitor 23:25:03 INFO - Running setup.py install for mozsystemmonitor 23:25:03 INFO - Successfully installed mozsystemmonitor 23:25:03 INFO - Cleaning up... 23:25:03 INFO - Return code: 0 23:25:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:03 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 0x10168f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10166c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015b29f0>, '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 0x101312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015a68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:25:03 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 23:25:03 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 23:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/Render', 23:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:03 INFO - 'HOME': '/Users/cltbld', 23:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:03 INFO - 'LOGNAME': 'cltbld', 23:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:03 INFO - 'MOZ_NO_REMOTE': '1', 23:25:03 INFO - 'NO_EM_RESTART': '1', 23:25:03 INFO - 'PAGER': '/bin/cat', 23:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:03 INFO - 'PWD': '/builds/slave/test', 23:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:03 INFO - 'SHELL': '/bin/bash', 23:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Jb2pSQKkk/Listeners', 23:25:03 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 23:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:03 INFO - 'USER': 'cltbld', 23:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:03 INFO - 'XPC_FLAGS': '0x0', 23:25:03 INFO - 'XPC_SERVICE_NAME': '0', 23:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:04 INFO - Downloading/unpacking blobuploader==1.2.4 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25:07 INFO - Downloading blobuploader-1.2.4.tar.gz 23:25:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:25:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:25:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:08 INFO - Downloading docopt-0.6.1.tar.gz 23:25:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:25:08 INFO - Installing collected packages: blobuploader, requests, docopt 23:25:08 INFO - Running setup.py install for blobuploader 23:25:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:25:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:25:08 INFO - Running setup.py install for requests 23:25:09 INFO - Running setup.py install for docopt 23:25:09 INFO - Successfully installed blobuploader requests docopt 23:25:09 INFO - Cleaning up... 23:25:09 INFO - Return code: 0 23:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:09 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 0x10168f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10166c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015b29f0>, '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 0x101312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015a68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:25:09 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 23:25:09 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 23:25:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/Render', 23:25:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:09 INFO - 'HOME': '/Users/cltbld', 23:25:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:09 INFO - 'LOGNAME': 'cltbld', 23:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:09 INFO - 'MOZ_NO_REMOTE': '1', 23:25:09 INFO - 'NO_EM_RESTART': '1', 23:25:09 INFO - 'PAGER': '/bin/cat', 23:25:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:09 INFO - 'PWD': '/builds/slave/test', 23:25:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:09 INFO - 'SHELL': '/bin/bash', 23:25:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Jb2pSQKkk/Listeners', 23:25:09 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 23:25:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:09 INFO - 'USER': 'cltbld', 23:25:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:09 INFO - 'XPC_FLAGS': '0x0', 23:25:09 INFO - 'XPC_SERVICE_NAME': '0', 23:25:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-5a3WiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-zA2TdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-HPIGGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-2Q0n19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-0Wr6FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-NbJQFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-Mc0ud4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-G5x3bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-5pkVrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-wP681a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-9qhvsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-4DDAFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:12 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-RueoT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:12 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-NswgtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:12 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-W2vzmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:12 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-M0RitL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:12 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-4myqYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:25:12 INFO - Running setup.py install for manifestparser 23:25:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:25:12 INFO - Running setup.py install for mozcrash 23:25:13 INFO - Running setup.py install for mozdebug 23:25:13 INFO - Running setup.py install for mozdevice 23:25:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:25:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:25:13 INFO - Running setup.py install for mozfile 23:25:13 INFO - Running setup.py install for mozhttpd 23:25:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:25:13 INFO - Running setup.py install for mozinfo 23:25:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:25:13 INFO - Running setup.py install for mozInstall 23:25:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Running setup.py install for mozleak 23:25:14 INFO - Running setup.py install for mozlog 23:25:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Running setup.py install for moznetwork 23:25:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Running setup.py install for mozprocess 23:25:14 INFO - Running setup.py install for mozprofile 23:25:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:25:14 INFO - Running setup.py install for mozrunner 23:25:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:25:15 INFO - Running setup.py install for mozscreenshot 23:25:15 INFO - Running setup.py install for moztest 23:25:15 INFO - Running setup.py install for mozversion 23:25:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:25:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:25:15 INFO - Cleaning up... 23:25:15 INFO - Return code: 0 23:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 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 0x10168f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10166c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015b29f0>, '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 0x101312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015a68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:25:15 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 23:25:15 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 23:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/Render', 23:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:15 INFO - 'HOME': '/Users/cltbld', 23:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:15 INFO - 'LOGNAME': 'cltbld', 23:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:15 INFO - 'MOZ_NO_REMOTE': '1', 23:25:15 INFO - 'NO_EM_RESTART': '1', 23:25:15 INFO - 'PAGER': '/bin/cat', 23:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:15 INFO - 'PWD': '/builds/slave/test', 23:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:15 INFO - 'SHELL': '/bin/bash', 23:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Jb2pSQKkk/Listeners', 23:25:15 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 23:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:15 INFO - 'USER': 'cltbld', 23:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:15 INFO - 'XPC_FLAGS': '0x0', 23:25:15 INFO - 'XPC_SERVICE_NAME': '0', 23:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:15 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-ZtCcSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25: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)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:16 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-mn8m7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25: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)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:16 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-V3iWcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25: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)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:16 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-UMpaOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25: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)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:16 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-gGparo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25: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)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:16 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-7tgOhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:16 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-JT6Fyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:16 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-VPOVoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:16 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-Z29Iil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:17 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-26pFjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25: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)) 23:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:17 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-iEhUWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25: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)) 23:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:17 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-0kCKEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25: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)) 23:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:17 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-FBxcHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25: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)) 23:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:17 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-EFSbEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25: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)) 23:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:17 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-Qvy_az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25: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)) 23:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:17 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-BeEAv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:17 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-UIQ4Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:25:17 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)) 23:25:17 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)) 23:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:25:17 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)) 23:25:17 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)) 23:25:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25: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 23:25:20 INFO - Downloading blessings-1.5.1.tar.gz 23:25: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 23:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:25:20 INFO - Installing collected packages: blessings 23:25:20 INFO - Running setup.py install for blessings 23:25:20 INFO - Successfully installed blessings 23:25:20 INFO - Cleaning up... 23:25:20 INFO - Return code: 0 23:25:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:21 INFO - Reading from file tmpfile_stdout 23:25:21 INFO - Current package versions: 23:25:21 INFO - blessings == 1.5.1 23:25:21 INFO - blobuploader == 1.2.4 23:25:21 INFO - docopt == 0.6.1 23:25:21 INFO - manifestparser == 1.1 23:25:21 INFO - mozInstall == 1.12 23:25:21 INFO - mozcrash == 0.16 23:25:21 INFO - mozdebug == 0.1 23:25:21 INFO - mozdevice == 0.47 23:25:21 INFO - mozfile == 1.2 23:25:21 INFO - mozhttpd == 0.7 23:25:21 INFO - mozinfo == 0.9 23:25:21 INFO - mozleak == 0.1 23:25:21 INFO - mozlog == 3.0 23:25:21 INFO - moznetwork == 0.27 23:25:21 INFO - mozprocess == 0.22 23:25:21 INFO - mozprofile == 0.27 23:25:21 INFO - mozrunner == 6.11 23:25:21 INFO - mozscreenshot == 0.1 23:25:21 INFO - mozsystemmonitor == 0.0 23:25:21 INFO - moztest == 0.7 23:25:21 INFO - mozversion == 1.4 23:25:21 INFO - psutil == 3.1.1 23:25:21 INFO - requests == 1.2.3 23:25:21 INFO - wsgiref == 0.1.2 23:25:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10168f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10166c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015b29f0>, '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 0x101312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015a68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/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.4Jb2pSQKkk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:25:21 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 23:25:21 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 23:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/Render', 23:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:21 INFO - 'HOME': '/Users/cltbld', 23:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:21 INFO - 'LOGNAME': 'cltbld', 23:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:21 INFO - 'MOZ_NO_REMOTE': '1', 23:25:21 INFO - 'NO_EM_RESTART': '1', 23:25:21 INFO - 'PAGER': '/bin/cat', 23:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:21 INFO - 'PWD': '/builds/slave/test', 23:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:21 INFO - 'SHELL': '/bin/bash', 23:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Jb2pSQKkk/Listeners', 23:25:21 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 23:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:21 INFO - 'USER': 'cltbld', 23:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:21 INFO - 'XPC_FLAGS': '0x0', 23:25:21 INFO - 'XPC_SERVICE_NAME': '0', 23:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25: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)) 23:25: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)) 23:25: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)) 23:25: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)) 23:25: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)) 23:25: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)) 23:25: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)) 23:25: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)) 23:25: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)) 23:25: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)) 23:25: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)) 23:25:21 INFO - Cleaning up... 23:25:21 INFO - Return code: 0 23:25:21 INFO - Running post-action listener: _resource_record_post_action 23:25:21 INFO - Running post-action listener: _start_resource_monitoring 23:25:21 INFO - Starting resource monitoring. 23:25:21 INFO - ##### 23:25:21 INFO - ##### Running install step. 23:25:21 INFO - ##### 23:25:21 INFO - Running pre-action listener: _resource_record_pre_action 23:25:21 INFO - Running main action method: install 23:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:21 INFO - Reading from file tmpfile_stdout 23:25:21 INFO - Detecting whether we're running mozinstall >=1.0... 23:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:25:21 INFO - Reading from file tmpfile_stdout 23:25:21 INFO - Output received: 23:25:21 INFO - Usage: mozinstall [options] installer 23:25:21 INFO - Options: 23:25:21 INFO - -h, --help show this help message and exit 23:25:21 INFO - -d DEST, --destination=DEST 23:25:21 INFO - Directory to install application into. [default: 23:25:21 INFO - "/builds/slave/test"] 23:25:21 INFO - --app=APP Application being installed. [default: firefox] 23:25:21 INFO - mkdir: /builds/slave/test/build/application 23:25: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'] 23:25: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 23:25:59 INFO - Reading from file tmpfile_stdout 23:25:59 INFO - Output received: 23:25:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:25:59 INFO - Running post-action listener: _resource_record_post_action 23:25:59 INFO - ##### 23:25:59 INFO - ##### Running run-tests step. 23:25:59 INFO - ##### 23:25:59 INFO - Running pre-action listener: _resource_record_pre_action 23:25:59 INFO - Running main action method: run_tests 23:25:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:25:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:25:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:25:59 INFO - 2015-11-16 23:25:59.332 screenresolution[1924:11178] starting screenresolution argv=screenresolution get 23:25:59 INFO - 2015-11-16 23:25:59.335 screenresolution[1924:11178] Display 0: 1600x1200x32@60 23:25:59 INFO - 2015-11-16 23:25:59.341 screenresolution[1925:11180] starting screenresolution argv=screenresolution list 23:25:59 INFO - Available Modes on Display 0 23:25:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:25:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:25:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:25:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:25:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:25:59 INFO - Intel HD Graphics 3000: 23:25:59 INFO - Chipset Model: Intel HD Graphics 3000 23:25:59 INFO - Type: GPU 23:25:59 INFO - Bus: Built-In 23:25:59 INFO - VRAM (Total): 512 MB 23:25:59 INFO - VRAM (Dynamic, Max): 10 23:25:59 INFO - Vendor: Intel (0x8086) 23:25:59 INFO - Device ID: 0x0116 23:25:59 INFO - Revision ID: 0x0009 23:25:59 INFO - Displays: 23:25:59 INFO - Display: 23:25:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:25:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:25:59 INFO - Display Serial Number: 1600x1200 60 23:25:59 INFO - Main Display: Yes 23:25:59 INFO - Mirror: Off 23:25:59 INFO - Online: Yes 23:25:59 INFO - Rotation: Supported 23:25:59 INFO - Return code: 0 23:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:25:59 INFO - Python 2.7.3 23:25:59 INFO - Return code: 0 23:25:59 INFO - grabbing minidump binary from tooltool 23:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:59 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 0x1015b29f0>, '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 0x101312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015a68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:25:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:25:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 23:25:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:25:59 INFO - Return code: 0 23:25:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:25:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:25:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:25:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:25:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0010', '--webServer', 'localhost'] in /builds/slave/test/build 23:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0010 --webServer localhost 23:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VkfWibQBzF/Render', 23:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:59 INFO - 'HOME': '/Users/cltbld', 23:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:59 INFO - 'LOGNAME': 'cltbld', 23:25:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:25:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:59 INFO - 'MOZ_NO_REMOTE': '1', 23:25:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:25:59 INFO - 'NO_EM_RESTART': '1', 23:25:59 INFO - 'PAGER': '/bin/cat', 23:25:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:59 INFO - 'PWD': '/builds/slave/test', 23:25:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:59 INFO - 'SHELL': '/bin/bash', 23:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Jb2pSQKkk/Listeners', 23:25:59 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 23:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:59 INFO - 'USER': 'cltbld', 23:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:59 INFO - 'XPC_FLAGS': '0x0', 23:25:59 INFO - 'XPC_SERVICE_NAME': '0', 23:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:25:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0010', '--webServer', 'localhost'] with output_timeout 3600 23:25:59 INFO - mozversion INFO | application_buildid: 20151116220542 23:25:59 INFO - mozversion INFO | application_changeset: 2f103f5a44ffcbef4fc27617a6a6431b96699631 23:25:59 INFO - mozversion INFO | application_display_name: Nightly 23:25:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:25:59 INFO - mozversion INFO | application_name: Firefox 23:25:59 INFO - mozversion INFO | application_remotingname: firefox 23:25:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:25:59 INFO - mozversion INFO | application_vendor: Mozilla 23:25:59 INFO - mozversion INFO | application_version: 45.0a1 23:25:59 INFO - mozversion INFO | platform_buildid: 20151116220542 23:25:59 INFO - mozversion INFO | platform_changeset: 2f103f5a44ffcbef4fc27617a6a6431b96699631 23:25:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:25:59 INFO - mozversion INFO | platform_version: 45.0a1 23:25:59 INFO - 2015-11-16 23:25:59,951 DEBUG : using testdate: 1447745159 23:25:59 INFO - 2015-11-16 23:25:59,951 DEBUG : actual date: 1447745159 23:25:59 INFO - 2015-11-16 23:25:59,960 INFO : starting webserver on 'localhost:49504' 23:25:59 INFO - 2015-11-16 23:25:59,962 INFO : Starting test suite t-yosemite-r5-0010 23:25:59 INFO - 2015-11-16 23:25:59,962 INFO : Starting test dromaeo_css 23:25:59 INFO - 2015-11-16 23:25:59,962 DEBUG : operating with platform_type : mac_ 23:25:59 INFO - 2015-11-16 23:25:59,963 INFO : Initialising browser for dromaeo_css test... 23:25:59 INFO - 2015-11-16 23:25:59,991 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmpjTPVLt/profile http://localhost:49504/getInfo.html 23:26:02 INFO - 2015-11-16 23:26:02,868 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:26:02 INFO - 2015-11-16 23:26:02,868 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:26:02 INFO - 2015-11-16 23:26:02,869 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:26:02 INFO - 2015-11-16 23:26:02,869 DEBUG : BROWSER_OUTPUT: __metrics 23:26:02 INFO - 2015-11-16 23:26:02,887 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:26:03 INFO - 2015-11-16 23:26:03,616 INFO : Browser initialized. 23:26:03 INFO - 2015-11-16 23:26:03,617 INFO : Running cycle 1/1 for dromaeo_css test... 23:26:03 INFO - 2015-11-16 23:26:03,617 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmpjTPVLt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:26:15 INFO - 2015-11-16 23:26:15,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 230219776 23:26:15 INFO - 2015-11-16 23:26:15,640 DEBUG : BROWSER_OUTPUT: 23:27:08 INFO - 2015-11-16 23:27:08,086 DEBUG : BROWSER_OUTPUT: 1447745228083 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:29:18 INFO - 2015-11-16 23:29:18,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49504/tests/dromaeo/cssquery-ext.html) 23:29:19 INFO - 2015-11-16 23:29:19,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 385970176 23:29:19 INFO - 2015-11-16 23:29:19,795 DEBUG : BROWSER_OUTPUT: 23:32:22 INFO - 2015-11-16 23:32:22,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/dromaeo/cssquery-ext.html (next: http://localhost:49504/tests/dromaeo/cssquery-jquery.html) 23:32:23 INFO - 2015-11-16 23:32:23,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 382201856 23:32:23 INFO - 2015-11-16 23:32:23,185 DEBUG : BROWSER_OUTPUT: 23:35:25 INFO - 2015-11-16 23:35:25,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49504/tests/dromaeo/cssquery-mootools.html) 23:35:26 INFO - 2015-11-16 23:35:26,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 347099136 23:35:26 INFO - 2015-11-16 23:35:26,012 DEBUG : BROWSER_OUTPUT: 23:38:28 INFO - 2015-11-16 23:38:28,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49504/tests/dromaeo/cssquery-prototype.html) 23:38:28 INFO - 2015-11-16 23:38:28,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 333176832 23:38:28 INFO - 2015-11-16 23:38:28,597 DEBUG : BROWSER_OUTPUT: 23:41:31 INFO - 2015-11-16 23:41:31,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49504/tests/dromaeo/cssquery-yui.html) 23:41:32 INFO - 2015-11-16 23:41:32,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 332713984 23:41:32 INFO - 2015-11-16 23:41:32,565 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/dromaeo/cssquery-yui.html (next: http://localhost:49504/tests/dromaeo/cssquery-dojo.html) 23:44:35 INFO - 2015-11-16 23:44:35,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 373927936 23:44:35 INFO - 2015-11-16 23:44:35,833 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,834 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:44:35 INFO - 2015-11-16 23:44:35,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:44:35 INFO - 2015-11-16 23:44:35,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:44:35 INFO - 2015-11-16 23:44:35,834 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:44:35 INFO - 2015-11-16 23:44:35,835 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3133.420317241309;3143.6856314368565;3198.680131986801;3214.3571285742855;3267.55887955126;4951.727654978984;5053.848384548461;5185.714785686786;5237.502437268458;5237.8690532736655;5186.740662966856;5191.169412893938;5201.661891977028;5245.632805703603;5246.7638956246965;4753.572178503934;4837.008413275279;4846.951530484703;4893.4617192108835;4925.08885856116;4841.3222148899185;4844.370231869852;4914.410270767513;4917.532834380728;4933.629977751683;4856.927146092811;4884.731339776311;4891.14404979129;4891.339669144673;4924.138275801738;4737;4817.951820481803;4826.348442960208;4847.733374664392;4961.3798275215595;4795.688280261772;4821.445533763627;4837.661363704542;4912.754362281871;4965.180745177042;5095.745212739348;5135.332406787131;5164.948350516484;5201.141811601119;5217.47825217479;5082.2122571001555;5230.267762513251;5280.445553216934;5389.9759045781175;5482.588805839578;5452.781888724447;5453;5454.8909021819345;5465.617406781527;5549.806791539839;5100.413452452941;5129.948700512984;5134;5134.178531435027;5197.506236907488;5560.2493663355735;5599.440055994368;5622.6345287557;5632.831015069554;5715.514181294553;5396.811111611075;5403.648762830403;5418.376886658085;5452.345718513804;5461.399246082928;5517.503424691797;5567.2762540870235;5570;5575;5583.106702927512;5424.864378390572;5437.918431223535;5438.728063596884;5462.044142275086;5526.198701188386;5314.229436731653;5403;5416.10634245353;5446.945530544723;5452.073147564924;4091;4164.75011499311;4173.478315210598;4206.3690446432665;4240.745555266632;3825.7130715195913;3875.0893540018074;3882.107115363482;3904.082540602956;3910.843566257318;5004.774785134678;5065.56942659878;5082.059818933435;5116.590672746172;5138.743062846843;5412.783488660488;5468.863278418072;5577.498025177753;5595.440455954372;5602.879424115112;5115.693058416507;5117.769700363493;5127.205283181038;5151.175811870083;5186.507281808223;4692.366530518405;4810.39870016248;4822.734749588806;4854.368932038883;4861.562459378602;5657.688827114548;5666.376698563155;5670.546356291405;5681.034224181899;5749.942500575108;5458.8908221834545;5459.317585301837;5478.671279723229;5543.667379957215;5556.638818476786;5576.470235327637;5595.860103497445;5596.5242954347705;5611.663300202001;5670.688112153871;5374;5374.919376209282;5470.015397228378;5494.313210848644;5546.389897111234;5369.838904832861;5513.476219759116;5516.834494965157;5535.8892822144135;5574.665520068809;5295.7087360195555;5413.70224637633;5443;5465.07093794048;5511.173324001432;5211.973940130275;5403.351597808131;5407.405185429679;5489.4236105209975;5492.752826122914;5335.253064571041;5391.487808658171;5401.729913504388;5408.918866217088;5436.401995780382;5466.945330546802;5470.64440811346;5486.6982315973;5496.780128794803;5504.669719816824;5191.169412893919;5205.401378841481;5262.842114736564;5325.068113080273;5394.649347792381 23:44:35 INFO - 2015-11-16 23:44:35,839 DEBUG : BROWSER_OUTPUT: |1;ext.html;531.893621275745;544.0452006728193;549.5630973376166;560.1122221279272;560.249265983582;29382.2654433639;30364.848175759118;38239;38296.425553616646;38476.61523384765;40877.182456350856;40918.38622420666;40918.59081409185;40949.385759213634;41235;7906.644201010969;8851.601677924493;8949.507777072258;8952.597133129026;8971.05803890592;8072.919270807305;8202.630881610341;10638;10719;10789.568417263301;10185.439800810953;10543.525541350618;10624.043836054754;10685.2520323577;10793.406362650052;8193.221643943876;10506.159507239403;10541.683749487527;10680.893191068106;10712.25014249003;7868.095169055575;10618.36289822613;10668.093212076983;10802.621908233252;10835;37266.44100338497;37306.81346593277;37337.439938400945;37814;37831;2888.465633857743;2909.258139174518;2918.664353599342;2977.8064425812254;3039.118655589876;26529;26972.73027269722;27103.593446098323;27217.047403340985;27573.31066723348;2303.8156947444163;2373.1456675596773;2388.6775285336603;2475.356407334088;2494.2517244826663;282276;282297;282566.99999999796;282597;282728;48311.5168848307;49850.501494985314;55556.16665750017;56002.15996760052;56535;62181;63649.363506364345;63708;63780.36219637837;64504.67747661232;13112.672183195496;13504.662383440493;13521.526746564019;13530.323483825769;13672.52146174879;9977.551010204557;10027.348222365523;10083.445410502492;10088.899111008795;10095.899041009643;17809.376671816422;17817.752757307124;17922.014289214218;17926;18139.72790408145;7657;7859.799256208271;7867.960660196777;7897.3287270581495;7983.800404989922;899.3794281945437;928.178561972659;1011.1253765492796;1018.4195008844887;1023.3143793658118;26838.194854154408;27084.1874743758;27130;27245.182644520697;27531.696196456553;967.3228739882111;1015.3248090020202;1075.6772968109535;1080.36258607422;1113.571275059108;13959.511417100555;14026.929865350608;14240.148780658448;14321.498747543787;14434.639134021523;313967;318836;320641;321458;321713;43959.560404395546;44201.77899110484;50367;51581;52073;1305.719270356859;1337.585348541955;1349.757043732118;1352.4184600621827;1355.4442678501766;25954.740452595233;26127.869360653076;26454;26511.60232596474;26619.33451663724;41077.79461102675;41927.37108943307;42141;46424.767876160404;47600;195573;198891;199888.01119888478;200551;201885;29079.418411631224;29194.56208156922;29497.280435130277;29512.852435737685;29535.704642954155;36879;37340.813295933345;38149;38218.235635287696;39154.6084539151;32381.83809081034;33817.15457113592;34105;34166.487502686985;34587.4811877817;33706.66293337035;33847.66152338544;34044.148896277795;34388;34467.13832154216;33743.83128084344;34422.48366274558;34839;34857.302853942274;35273.64726352703;28500.42999140047;29748.85125574445;29938.70061299359;30007.54988675128;30272.69727302787;22610.66084008774;22633.66049509226;22716.4320891979;23125.88437057871;23326.416839579146 23:44:35 INFO - 2015-11-16 23:44:35,839 DEBUG : BROWSER_OUTPUT: |2;jquery.html;322.30864795014696;323.4711247110973;328.5055990733945;329.76092333058534;337.5679130712687;13674.453021879113;14445.277736113205;17745.822541774578;18175.363862264825;18526.07369631518;13899.79150312746;14909.32908019139;17677;17839;17892.46322610324;4573.451185857702;5296.073187192245;5298.761555730001;5319.281896943901;5354.625176237665;3820.0640842993366;3937.822797974098;5176.404713457963;5265.921011184835;5353.0899747043095;5562.499375056244;5697.43025697429;5717.685527295997;5755.482006619403;5798.507126894219;5674.602777805555;5697.633221722669;5706.77172913083;5732.369439361667;5741.024025915604;4959.603231741452;4977.303177555145;4978.4025916890205;4984;5028.974855125701;21674;22009.33971980843;22264.443388915246;22581.322560323217;22604.660930086062;1909.8567607429359;1941.6407964526609;1961.3723608445302;2088.592724418739;2112.324056301984;9039.322050846147;13101.148425352418;13309.201447913156;13424.261665608388;13528.391222394917;1142.4973011874831;1462.7293950619169;1488.2038109611306;1516.113073851798;1537.1699282387497;56442.43557564454;59375.70312148455;59900;60029.99999999956;60174;6268.937310626927;6390.456811171102;6419.358064193637;6423.357664233633;6437.420632143036;7085.539439936388;7226.458015648847;7243.384312333405;7323.560586364729;7340.119185697644;5017.84946451607;5057.72182529957;5069.264956581275;5121.206213036985;5122.359705036871;5138.254953031864;5240.135377662643;5260.368755749335;5268.894622107537;5301.655392399482;2801.8038737288603;2820.1680504251294;2849.871755770995;2863.527517959555;2865.469888070672;969.6024629901707;970.8834939807127;989.9010098990187;1012.549415510091;1044.738815296176;380.2300341807806;404.51660265982457;422.2483978518242;430.95474975127786;451.60935790540947;10943.945280273547;11031.724206894893;11269.887301127048;11688.766224675628;11943.104267179997;399.1398536154592;420.3190830853975;432.84201266537485;439.5736135948125;440.81926410172315;5724.599278050579;6196.969015154896;6203.565750397429;6207.5654704171175;6210.099535567318;562954;563409;570936;575647;584797;70514.2948570518;71313;71972;72051.63974180096;73421;488.2115383655371;493.9580135688507;495.2521692244736;496.42166875590254;497.8133200049981;10488.895111048792;10588.417637030037;10766.73083172927;10784.191185661264;10803.189760767817;33642.327153457285;33668;34232.82883585666;34936.825315873255;36377.81811090928;48696.5130348692;48835.755821220664;48922;48937.2659410102;49259;5968.910466342922;5999.580029398075;6072.967595508686;6089.238845144357;6091.543134264859;11046.171537134587;11616.767664646492;11619.6514104577;11621.825672614748;11817.822732658846;9813;10123.493825308558;10259.384436933808;10260.58957641686;10275.948620256851;9796.412215267106;9833.115019648267;9903.45530995802;9904.405735655884;9941.453220072965;10110.646127385506;10261.17910567138;10483.633072842415;10489.842652360068;10493;5553.777848885999;5567.888642227052;5618;5778.739956701875;6072.605280656743;9813.607455701978;9848.704538863845;9971.700848974542;10046.69859904204;10059.295849290773 23:44:35 INFO - 2015-11-16 23:44:35,842 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1436.6911114110464;1744.4243399678107;1757.077534294496;1757.8857374270672;1778.7776527934009;6878.380945714891;7041.436685065195;7051.365377116065;7128.465365097625;7136.892946605805;7039.57762534247;7065.823354416142;7087.822804429892;7142.464315176357;7176.5335253208505;2067.1627990663806;2086.321945367758;2104.2214380679093;2110.757262914769;2110.8944552772377;2103.663413853776;2112.3629187379825;2118.3962570667363;2119.544297975935;2138.7433507979063;1897.7343171955938;1936.244864502845;1943.7084437334372;2037.6943458481273;2043.3869839048225;1989.6120256549978;2000.1799262302459;2028.8072633099905;2031.8069783370556;2056.5372791122027;2076.3874656976227;2096.5073207796154;2103.2112957640884;2154.450615093141;2155.5257843274453;6371.299157092716;6463.709133088975;6925.549839260482;7203.063601731741;7259.491835571512;4492.101579684044;4505.053938672882;4560.429946256718;4571.474280457756;4583.793729282191;2753.366725653091;2834.036427614621;2835.2344866885824;2868.3259434033193;2870.8277503349864;899.7390756680555;914.1452741686478;934.5374039850318;944.3436811416069;956.7608097975506;9046.81906361869;9129.817403651956;9134.543272836332;9146.77133071672;9152.130547597968;3826.6747326477002;3868.729188956746;3900.7269491135917;3910.9217815644097;3913.178232571192;8059.717909873127;8153.347732181412;8154.06228283755;8156.9184308156155;8193.09875913649;4329.177456283296;4386.254336762758;4388.824447022147;4403.427554417905;4408.625266852289;3977.343738283209;4014.959850401517;4017.055991841915;4022.1151346703678;4023.4970628671417;3399.490076488497;3400.2179498715436;3402.727781777452;3410.334984677964;3470.930581388358;1047.7904419116207;1052.0531521630594;1059.3220338983058;1071.3678929431674;1077.9514921828536;945.4091193004373;963.1283688262134;976.0532283684814;1021.8416145497459;1259.552858735136;6956.304369563003;6962.060121883582;6973.05863708403;6987.371136597731;7046.1192350956135;412.6616174736747;416.11990639797216;418.2555052007432;419.58251539717565;439.7801099450275;5004.099262132779;5488.56091512678;5513.779448822002;5520.889582208333;5578.944210557924;8218.137095604994;8384.790380240544;8412.116727743622;8468;8570.571471426403;8201.876971845428;8338;8418.957905210435;8429.831403372022;8458.407911446262;6828.078209441761;6931.0643063186835;6951.131108611424;6974.4420446364165;6995.825104372431;6662.866742665023;6674.399304062657;6726.125603671491;6763.458923286224;6768.08630834831;7677.270659287359;7679.692812287446;7752.224777522202;7777.533347999138;7822.100458447124;7909.327707144727;7925.405594580545;7941.166177551274;7970.721024764105;8010.759677209693;6108.664023478574;6416.807495775134;6433.453156481564;6441.3880681335195;6522.478201743754;6823.692933817891;6988.825279368057;6989.33601307875;6994.090768200102;7116.679749411393;6425.293217745951;6496.317886622026;6521.250056243593;6635;6644.501662375438;6458.063580780855;6458.677066146768;6471.870562588628;6514.446272066927;6609.008648702733;6616.933830661825;6641.734330626721;6659.334066593302;6715.7985260442265;6754.324567543206;5881;6007.249093863267;6024.33732289439;6048.637081775108;6057.909131362945;6061.181740464981;6086.087086936995;6118.908216376669;6144.41628045335;6168.722407491584 23:44:35 INFO - 2015-11-16 23:44:35,844 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.16537270565;313.81484923894897;314.4481435081432;315.8894386964563;319.19085119222774;5986.940130598693;6038.215032045828;6109.480694140998;6167.290761562422;6268.84327891803;5952.166696662471;6081.665508397036;6185.381461853813;6189.597676151058;6196.628202307865;4766.952330476685;4767.833125840605;4833.3716616839765;4841.56425921667;4849.24836650318;4595.747233902134;4697.084068606623;4711.693739906912;4722.244440889458;4791.976040119795;4489.102179564084;4686.9531304687025;4695.436547614291;4744.359511465959;4810.831620893269;4723.76381180943;4747.52524747526;4752.382190315271;4777.259524773665;4807.975960120195;4065.410515475269;4078.2455245779624;4102.835886564534;4110.568390319003;4112.465379500676;5983.431574000463;5985.371535988702;6009.729562169713;6024.337322894478;6039.54703397247;5128.358955130609;5304.098303288411;5317.760700768475;5347.679139251657;5364.383095943977;6403;6412.102305677209;6413.903791443132;6460.160179176724;6460.93539064608;4209.705320627558;4322.719023263509;4388.495323037828;4412.84555040572;4427.623651989585;6623.172103487064;6797.694103765342;6824.317568243186;6877.1747390313485;6894.586324820527;4372.475302963601;4492.865214043584;4498.775061246924;4508.233600287959;4549.431321084864;4564.064366804863;4564.589186973122;4566.0411313623845;4570.428696412949;4570.771461426982;5076.847694569169;5192.143296356059;5207.3230480037355;5219.451957544479;5304.071787437183;6471.805845824632;6480.740770369227;6488.870222595521;6543.411093001652;6564.507661925375;1545.2273863068465;1565.2877940537028;1566.1229711361673;1567.7883485729508;1568.6235303527299;990.8513722941473;990.9256805739599;1009.9899001009895;1019.4698756646651;1027.2706378471219;6176.505879529716;6182.258129024546;6183.319834818167;6184.010558310649;6251.218597675291;6724.462043036546;6726.730930762715;6750.7299708012115;6774.525783195129;6784.287649796799;5985.970070149709;6170.043643235216;6177.227846519185;6196.132541444202;6251.906221406683;3592.0481072515804;3628.600853906068;3631.5642122944887;3639.1448009717697;3662.761920475214;6931.584104953719;6943.89584156238;6952.965235173791;7006.614636194956;7029.859402811915;6620.172478440195;6825.69284382204;6830.59016459014;6835.384815366541;6912.516123871281;6924.446044316443;6927.064846245793;6935.6878940447805;7004.264552221944;7021.613811240431;6723.092382528492;6723.9327606725265;6762.459003279824;6804.9319506804295;6814.829629259309;6358.427741503287;6550.213974323112;6605.603663780189;6607.174103237096;6668.766593169215;6968.128983877015;7038.3665470107935;7042.366187043191;7042.753503627553;7045.753398631228;4262.296721040993;4276.144771045741;4287.356896465555;4300;4305.892352691208;6645.833854153685;6709.463242940651;6739.730410783513;6742.4943129266485;6754.290799466182;6536.3136870627895;6561.1470508833545;6587.505937054836;6602.372774586406;6626.304238054935;6492.610443373413;6512.446442052478;6517.674116294261;6633.867322653617;6638.236602790741;6254.843628909313;6381.968090159519;6401.487880969418;6435.163428754232;6525.673716314261;6579.046038324321;6582.17722784652;6635.734570617315;6636.004599309949;6667.033280174251;6422.325655806073;6425.518086143651;6431.324710905287;6462.127612772216;6492.610443373413 23:44:35 INFO - 2015-11-16 23:44:35,847 DEBUG : BROWSER_OUTPUT: |5;yui.html;701.9754308599199;732.4726197138062;753.1639879733498;759.4835511851942;821.4947807098632;13195.538156164535;13342.799858002138;13351.532696355629;13373.732525349487;13459.932700336485;11468.541258349656;12419.882210601045;12522.060845436583;12554.183978041421;12662.556810511634;842.191496163682;850.5832142250315;860.3805260212637;863.2187869977649;863.3826813828111;807.7132617920641;841.9494830310201;848.5078654380444;855.6620135046653;855.985656996458;894.2354287084546;901.6663834381288;902.9232515236213;903.2367649336301;904.6019751309435;886.8093359927647;897.470492409475;900.3607438718452;902.7066203483894;908.5184852028402;665.1419668627465;665.354606032148;666.4368608525788;667.2960027171332;669.859329540797;11900.58347957826;12099.213551119148;12114.515419383215;12119.272843629411;12290.692732681666;9478.763030924212;9550.665726699532;9596.280278979104;9682.70951871445;10094.394336339843;8628.26659733917;8749.650013999433;8786.472811631322;8873.822523549492;8896.555172241362;2956.9260768480744;3023.1686286271233;3034.484137696597;3044.436779195834;3067.156531953708;46506.06987860224;46649.533504665196;47077;47260.763696181646;48016.27975580404;7618.5809780461495;7639.427042971799;7749.147593764681;7878.409119316074;7951.483153594998;16421.42525011619;16428.83571164297;16436.260368283456;16556.917215413847;16645.83354166443;6452.548321617535;6757.087793147961;6800.353966373186;6813.649181616133;7054.188768291712;3531.5585551806025;3670.834812433447;3700.0564855961557;3783.2055268393397;3787.154581882495;2695.7304269572887;2733.6309598204384;2752.2431331383627;2754.944901102007;2782.8469434181316;404.79557823299047;411.8579090213871;415.3131906435857;418.3891518383134;421.23756001637133;478.8252287914956;488.4992882295604;528.3659608469775;546;563.7491316364178;6989.4187274574815;7318.286265654733;7330.96334518324;7373.446991475661;7573.318401343906;447.33570647588306;464.74671304139326;475.96665264824617;530.8115618955293;575.6373484704609;3157.936841263208;3482.9303413932084;3535.699465545406;3589.10272431892;4058.2492238935893;52391.476085239425;53569;54114.72942635261;54254;54819.725901370235;42358.8985547778;42798.57201427946;45307.320390194174;50052;50745;44811.77594112008;45732.77133614311;45913.770431148296;46028.539714603095;46250.768746156056;7772.45592808498;7938.28555429991;8053.83892322162;8224.588770561568;8305.127961563949;33220.33559328848;33408.665913340556;33980.49029264612;34109.14727131841;34511.4823277646;43754.562454375045;45854.770726146155;46304;46629;46715;7259.709611615687;7412;7498.287662672037;7595.810104747426;7862.606869656609;10283.794324113325;10741.194410419093;10936.394098227725;11194.832077519006;11691.240069395462;9346.53267336644;9488.95255523718;9764.707058788248;10059.39643621385;10081.798364032531;9753.268504862306;9895.554700038372;9909.702708918743;10263.538140783534;10295.588176472857;9993.450360230258;10063.849042264226;10357.63748268807;10462.738431539272;10866.348019118877;8701.956490217508;8702.347323950855;8951.776205594912;9028;9217.723468295962;8198.775125157727;8622.2671072957;8878.903305162125;8999.235065019546;9083.678805412272 23:44:35 INFO - 2015-11-16 23:44:35,847 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:44:35 INFO - 2015-11-16 23:44:35,847 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:44:35 INFO - 2015-11-16 23:44:35,847 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1046 23:44:35 INFO - 2015-11-16 23:44:35,848 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:44:35 INFO - 2015-11-16 23:44:35,848 DEBUG : BROWSER_OUTPUT: __startTimestamp1447746275833__endTimestamp 23:44:35 INFO - 2015-11-16 23:44:35,848 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,848 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:44:35 INFO - 2015-11-16 23:44:35,848 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:44:35 INFO - 2015-11-16 23:44:35,848 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,848 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5144.61 Median:5295.71 stddev:526.97 (10.0%) stddev-sans-first:504.42 23:44:35 INFO - 2015-11-16 23:44:35,849 DEBUG : BROWSER_OUTPUT: Values: 3133.4 3143.7 3198.7 3214.4 3267.6 4951.7 5053.8 5185.7 5237.5 5237.9 5186.7 5191.2 5201.7 5245.6 5246.8 4753.6 4837.0 4847.0 4893.5 4925.1 4841.3 4844.4 4914.4 4917.5 4933.6 4856.9 4884.7 4891.1 4891.3 4924.1 4737.0 4818.0 4826.3 4847.7 4961.4 4795.7 4821.4 4837.7 4912.8 4965.2 5095.7 5135.3 5164.9 5201.1 5217.5 5082.2 5230.3 5280.4 5390.0 5482.6 5452.8 5453.0 5454.9 5465.6 5549.8 5100.4 5129.9 5134.0 5134.2 5197.5 5560.2 5599.4 5622.6 5632.8 5715.5 5396.8 5403.6 5418.4 5452.3 5461.4 5517.5 5567.3 5570.0 5575.0 5583.1 5424.9 5437.9 5438.7 5462.0 5526.2 5314.2 5403.0 5416.1 5446.9 5452.1 4091.0 4164.8 4173.5 4206.4 4240.7 3825.7 3875.1 3882.1 3904.1 3910.8 5004.8 5065.6 5082.1 5116.6 5138.7 5412.8 5468.9 5577.5 5595.4 5602.9 5115.7 5117.8 5127.2 5151.2 5186.5 4692.4 4810.4 4822.7 4854.4 4861.6 5657.7 5666.4 5670.5 5681.0 5749.9 5458.9 5459.3 5478.7 5543.7 5556.6 5576.5 5595.9 5596.5 5611.7 5670.7 5374.0 5374.9 5470.0 5494.3 5546.4 5369.8 5513.5 5516.8 5535.9 5574.7 5295.7 5413.7 5443.0 5465.1 5511.2 5212.0 5403.4 5407.4 5489.4 5492.8 5335.3 5391.5 5401.7 5408.9 5436.4 5466.9 5470.6 5486.7 5496.8 5504.7 5191.2 5205.4 5262.8 5325.1 5394.6 23:44:35 INFO - 2015-11-16 23:44:35,849 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,849 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43020.19 Median:29524.28 stddev:71135.42 (240.9%) stddev-sans-first:71263.44 23:44:35 INFO - 2015-11-16 23:44:35,849 DEBUG : BROWSER_OUTPUT: Values: 531.9 544.0 549.6 560.1 560.2 29382.3 30364.8 38239.0 38296.4 38476.6 40877.2 40918.4 40918.6 40949.4 41235.0 7906.6 8851.6 8949.5 8952.6 8971.1 8072.9 8202.6 10638.0 10719.0 10789.6 10185.4 10543.5 10624.0 10685.3 10793.4 8193.2 10506.2 10541.7 10680.9 10712.3 7868.1 10618.4 10668.1 10802.6 10835.0 37266.4 37306.8 37337.4 37814.0 37831.0 2888.5 2909.3 2918.7 2977.8 3039.1 26529.0 26972.7 27103.6 27217.0 27573.3 2303.8 2373.1 2388.7 2475.4 2494.3 282276.0 282297.0 282567.0 282597.0 282728.0 48311.5 49850.5 55556.2 56002.2 56535.0 62181.0 63649.4 63708.0 63780.4 64504.7 13112.7 13504.7 13521.5 13530.3 13672.5 9977.6 10027.3 10083.4 10088.9 10095.9 17809.4 17817.8 17922.0 17926.0 18139.7 7657.0 7859.8 7868.0 7897.3 7983.8 899.4 928.2 1011.1 1018.4 1023.3 26838.2 27084.2 27130.0 27245.2 27531.7 967.3 1015.3 1075.7 1080.4 1113.6 13959.5 14026.9 14240.1 14321.5 14434.6 313967.0 318836.0 320641.0 321458.0 321713.0 43959.6 44201.8 50367.0 51581.0 52073.0 1305.7 1337.6 1349.8 1352.4 1355.4 25954.7 26127.9 26454.0 26511.6 26619.3 41077.8 41927.4 42141.0 46424.8 47600.0 195573.0 198891.0 199888.0 200551.0 201885.0 29079.4 29194.6 29497.3 29512.9 29535.7 36879.0 37340.8 38149.0 38218.2 39154.6 32381.8 33817.2 34105.0 34166.5 34587.5 33706.7 33847.7 34044.1 34388.0 34467.1 33743.8 34422.5 34839.0 34857.3 35273.6 28500.4 29748.9 29938.7 30007.5 30272.7 22610.7 22633.7 22716.4 23125.9 23326.4 23:44:35 INFO - 2015-11-16 23:44:35,849 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,851 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27909.40 Median:24876.48 stddev:93555.99 (376.1%) stddev-sans-first:93795.50 23:44:35 INFO - 2015-11-16 23:44:35,851 DEBUG : BROWSER_OUTPUT: Values: 322.3 323.5 328.5 329.8 337.6 13674.5 14445.3 17745.8 18175.4 18526.1 13899.8 14909.3 17677.0 17839.0 17892.5 4573.5 5296.1 5298.8 5319.3 5354.6 3820.1 3937.8 5176.4 5265.9 5353.1 5562.5 5697.4 5717.7 5755.5 5798.5 5674.6 5697.6 5706.8 5732.4 5741.0 4959.6 4977.3 4978.4 4984.0 5029.0 21674.0 22009.3 22264.4 22581.3 22604.7 1909.9 1941.6 1961.4 2088.6 2112.3 9039.3 13101.1 13309.2 13424.3 13528.4 1142.5 1462.7 1488.2 1516.1 1537.2 56442.4 59375.7 59900.0 60030.0 60174.0 6268.9 6390.5 6419.4 6423.4 6437.4 7085.5 7226.5 7243.4 7323.6 7340.1 5017.8 5057.7 5069.3 5121.2 5122.4 5138.3 5240.1 5260.4 5268.9 5301.7 2801.8 2820.2 2849.9 2863.5 2865.5 969.6 970.9 989.9 1012.5 1044.7 380.2 404.5 422.2 431.0 451.6 10943.9 11031.7 11269.9 11688.8 11943.1 399.1 420.3 432.8 439.6 440.8 5724.6 6197.0 6203.6 6207.6 6210.1 562954.0 563409.0 570936.0 575647.0 584797.0 70514.3 71313.0 71972.0 72051.6 73421.0 488.2 494.0 495.3 496.4 497.8 10488.9 10588.4 10766.7 10784.2 10803.2 33642.3 33668.0 34232.8 34936.8 36377.8 48696.5 48835.8 48922.0 48937.3 49259.0 5968.9 5999.6 6073.0 6089.2 6091.5 11046.2 11616.8 11619.7 11621.8 11817.8 9813.0 10123.5 10259.4 10260.6 10275.9 9796.4 9833.1 9903.5 9904.4 9941.5 10110.6 10261.2 10483.6 10489.8 10493.0 5553.8 5567.9 5618.0 5778.7 6072.6 9813.6 9848.7 9971.7 10046.7 10059.3 23:44:35 INFO - 2015-11-16 23:44:35,851 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,851 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5015.04 Median:6429.37 stddev:2576.19 (40.1%) stddev-sans-first:2569.38 23:44:35 INFO - 2015-11-16 23:44:35,853 DEBUG : BROWSER_OUTPUT: Values: 1436.7 1744.4 1757.1 1757.9 1778.8 6878.4 7041.4 7051.4 7128.5 7136.9 7039.6 7065.8 7087.8 7142.5 7176.5 2067.2 2086.3 2104.2 2110.8 2110.9 2103.7 2112.4 2118.4 2119.5 2138.7 1897.7 1936.2 1943.7 2037.7 2043.4 1989.6 2000.2 2028.8 2031.8 2056.5 2076.4 2096.5 2103.2 2154.5 2155.5 6371.3 6463.7 6925.5 7203.1 7259.5 4492.1 4505.1 4560.4 4571.5 4583.8 2753.4 2834.0 2835.2 2868.3 2870.8 899.7 914.1 934.5 944.3 956.8 9046.8 9129.8 9134.5 9146.8 9152.1 3826.7 3868.7 3900.7 3910.9 3913.2 8059.7 8153.3 8154.1 8156.9 8193.1 4329.2 4386.3 4388.8 4403.4 4408.6 3977.3 4015.0 4017.1 4022.1 4023.5 3399.5 3400.2 3402.7 3410.3 3470.9 1047.8 1052.1 1059.3 1071.4 1078.0 945.4 963.1 976.1 1021.8 1259.6 6956.3 6962.1 6973.1 6987.4 7046.1 412.7 416.1 418.3 419.6 439.8 5004.1 5488.6 5513.8 5520.9 5578.9 8218.1 8384.8 8412.1 8468.0 8570.6 8201.9 8338.0 8419.0 8429.8 8458.4 6828.1 6931.1 6951.1 6974.4 6995.8 6662.9 6674.4 6726.1 6763.5 6768.1 7677.3 7679.7 7752.2 7777.5 7822.1 7909.3 7925.4 7941.2 7970.7 8010.8 6108.7 6416.8 6433.5 6441.4 6522.5 6823.7 6988.8 6989.3 6994.1 7116.7 6425.3 6496.3 6521.3 6635.0 6644.5 6458.1 6458.7 6471.9 6514.4 6609.0 6616.9 6641.7 6659.3 6715.8 6754.3 5881.0 6007.2 6024.3 6048.6 6057.9 6061.2 6086.1 6118.9 6144.4 6168.7 23:44:35 INFO - 2015-11-16 23:44:35,853 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,853 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5423.98 Median:6184.70 stddev:1671.33 (27.0%) stddev-sans-first:1631.27 23:44:35 INFO - 2015-11-16 23:44:35,854 DEBUG : BROWSER_OUTPUT: Values: 305.2 313.8 314.4 315.9 319.2 5986.9 6038.2 6109.5 6167.3 6268.8 5952.2 6081.7 6185.4 6189.6 6196.6 4767.0 4767.8 4833.4 4841.6 4849.2 4595.7 4697.1 4711.7 4722.2 4792.0 4489.1 4687.0 4695.4 4744.4 4810.8 4723.8 4747.5 4752.4 4777.3 4808.0 4065.4 4078.2 4102.8 4110.6 4112.5 5983.4 5985.4 6009.7 6024.3 6039.5 5128.4 5304.1 5317.8 5347.7 5364.4 6403.0 6412.1 6413.9 6460.2 6460.9 4209.7 4322.7 4388.5 4412.8 4427.6 6623.2 6797.7 6824.3 6877.2 6894.6 4372.5 4492.9 4498.8 4508.2 4549.4 4564.1 4564.6 4566.0 4570.4 4570.8 5076.8 5192.1 5207.3 5219.5 5304.1 6471.8 6480.7 6488.9 6543.4 6564.5 1545.2 1565.3 1566.1 1567.8 1568.6 990.9 990.9 1010.0 1019.5 1027.3 6176.5 6182.3 6183.3 6184.0 6251.2 6724.5 6726.7 6750.7 6774.5 6784.3 5986.0 6170.0 6177.2 6196.1 6251.9 3592.0 3628.6 3631.6 3639.1 3662.8 6931.6 6943.9 6953.0 7006.6 7029.9 6620.2 6825.7 6830.6 6835.4 6912.5 6924.4 6927.1 6935.7 7004.3 7021.6 6723.1 6723.9 6762.5 6804.9 6814.8 6358.4 6550.2 6605.6 6607.2 6668.8 6968.1 7038.4 7042.4 7042.8 7045.8 4262.3 4276.1 4287.4 4300.0 4305.9 6645.8 6709.5 6739.7 6742.5 6754.3 6536.3 6561.1 6587.5 6602.4 6626.3 6492.6 6512.4 6517.7 6633.9 6638.2 6254.8 6382.0 6401.5 6435.2 6525.7 6579.0 6582.2 6635.7 6636.0 6667.0 6422.3 6425.5 6431.3 6462.1 6492.6 23:44:35 INFO - 2015-11-16 23:44:35,854 DEBUG : BROWSER_OUTPUT: 23:44:35 INFO - 2015-11-16 23:44:35,854 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12804.52 Median:529.59 stddev:15443.27 (2916.1%) stddev-sans-first:15459.85 23:44:35 INFO - 2015-11-16 23:44:35,856 DEBUG : BROWSER_OUTPUT: Values: 702.0 732.5 753.2 759.5 821.5 13195.5 13342.8 13351.5 13373.7 13459.9 11468.5 12419.9 12522.1 12554.2 12662.6 842.2 850.6 860.4 863.2 863.4 807.7 841.9 848.5 855.7 856.0 894.2 901.7 902.9 903.2 904.6 886.8 897.5 900.4 902.7 908.5 665.1 665.4 666.4 667.3 669.9 11900.6 12099.2 12114.5 12119.3 12290.7 9478.8 9550.7 9596.3 9682.7 10094.4 8628.3 8749.7 8786.5 8873.8 8896.6 2956.9 3023.2 3034.5 3044.4 3067.2 46506.1 46649.5 47077.0 47260.8 48016.3 7618.6 7639.4 7749.1 7878.4 7951.5 16421.4 16428.8 16436.3 16556.9 16645.8 6452.5 6757.1 6800.4 6813.6 7054.2 3531.6 3670.8 3700.1 3783.2 3787.2 2695.7 2733.6 2752.2 2754.9 2782.8 404.8 411.9 415.3 418.4 421.2 478.8 488.5 528.4 546.0 563.7 6989.4 7318.3 7331.0 7373.4 7573.3 447.3 464.7 476.0 530.8 575.6 3157.9 3482.9 3535.7 3589.1 4058.2 52391.5 53569.0 54114.7 54254.0 54819.7 42358.9 42798.6 45307.3 50052.0 50745.0 44811.8 45732.8 45913.8 46028.5 46250.8 7772.5 7938.3 8053.8 8224.6 8305.1 33220.3 33408.7 33980.5 34109.1 34511.5 43754.6 45854.8 46304.0 46629.0 46715.0 7259.7 7412.0 7498.3 7595.8 7862.6 10283.8 10741.2 10936.4 11194.8 11691.2 9346.5 9489.0 9764.7 10059.4 10081.8 9753.3 9895.6 9909.7 10263.5 10295.6 9993.5 10063.8 10357.6 10462.7 10866.3 8702.0 8702.3 8951.8 9028.0 9217.7 8198.8 8622.3 8878.9 8999.2 9083.7 23:44:35 INFO - 2015-11-16 23:44:35,856 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:44:35 INFO - 2015-11-16 23:44:35,856 DEBUG : BROWSER_OUTPUT: 23:44:36 INFO - 2015-11-16 23:44:36,502 INFO : Browser exited with error code: 0 23:44:36 INFO - 2015-11-16 23:44:36,529 INFO : Completed test dromaeo_css (00:18:36) 23:44:36 INFO - 2015-11-16 23:44:36,529 INFO : Starting test kraken 23:44:36 INFO - 2015-11-16 23:44:36,529 DEBUG : operating with platform_type : mac_ 23:44:36 INFO - 2015-11-16 23:44:36,529 INFO : Initialising browser for kraken test... 23:44:36 INFO - 2015-11-16 23:44:36,546 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmp39uRIu/profile http://localhost:49504/getInfo.html 23:44:38 INFO - 2015-11-16 23:44:38,893 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:44:38 INFO - 2015-11-16 23:44:38,893 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:44:38 INFO - 2015-11-16 23:44:38,893 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:44:38 INFO - 2015-11-16 23:44:38,893 DEBUG : BROWSER_OUTPUT: __metrics 23:44:38 INFO - 2015-11-16 23:44:38,910 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:44:39 INFO - 2015-11-16 23:44:39,562 INFO : Browser initialized. 23:44:39 INFO - 2015-11-16 23:44:39,562 INFO : Running cycle 1/1 for kraken test... 23:44:39 INFO - 2015-11-16 23:44:39,562 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmp39uRIu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:44:51 INFO - 2015-11-16 23:44:51,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 229838848 23:44:51 INFO - 2015-11-16 23:44:51,563 DEBUG : BROWSER_OUTPUT: 23:44:54 INFO - 2015-11-16 23:44:54,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49504/tests/kraken/driver.html?testName=audio-beat-detection) 23:44:54 INFO - 2015-11-16 23:44:54,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 286298112 23:44:54 INFO - 2015-11-16 23:44:54,675 DEBUG : BROWSER_OUTPUT: 23:44:57 INFO - 2015-11-16 23:44:57,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49504/tests/kraken/driver.html?testName=audio-dft) 23:44:57 INFO - 2015-11-16 23:44:57,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 297390080 23:44:57 INFO - 2015-11-16 23:44:57,913 DEBUG : BROWSER_OUTPUT: 23:45:00 INFO - 2015-11-16 23:45:00,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49504/tests/kraken/driver.html?testName=audio-fft) 23:45:01 INFO - 2015-11-16 23:45:01,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 279937024 23:45:01 INFO - 2015-11-16 23:45:01,470 DEBUG : BROWSER_OUTPUT: 23:45:03 INFO - 2015-11-16 23:45:03,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49504/tests/kraken/driver.html?testName=audio-oscillator) 23:45:04 INFO - 2015-11-16 23:45:04,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 281751552 23:45:04 INFO - 2015-11-16 23:45:04,070 DEBUG : BROWSER_OUTPUT: 23:45:06 INFO - 2015-11-16 23:45:06,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49504/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:45:06 INFO - 2015-11-16 23:45:06,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 283029504 23:45:06 INFO - 2015-11-16 23:45:06,843 DEBUG : BROWSER_OUTPUT: 23:45:09 INFO - 2015-11-16 23:45:09,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49504/tests/kraken/driver.html?testName=imaging-darkroom) 23:45:10 INFO - 2015-11-16 23:45:10,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 284635136 23:45:10 INFO - 2015-11-16 23:45:10,475 DEBUG : BROWSER_OUTPUT: 23:45:13 INFO - 2015-11-16 23:45:13,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49504/tests/kraken/driver.html?testName=imaging-desaturate) 23:45:14 INFO - 2015-11-16 23:45:14,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 284758016 23:45:14 INFO - 2015-11-16 23:45:14,255 DEBUG : BROWSER_OUTPUT: 23:45:17 INFO - 2015-11-16 23:45:17,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49504/tests/kraken/driver.html?testName=json-parse-financial) 23:45:17 INFO - 2015-11-16 23:45:17,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 284188672 23:45:17 INFO - 2015-11-16 23:45:17,676 DEBUG : BROWSER_OUTPUT: 23:45:19 INFO - 2015-11-16 23:45:19,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49504/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:45:19 INFO - 2015-11-16 23:45:19,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 319647744 23:45:19 INFO - 2015-11-16 23:45:19,833 DEBUG : BROWSER_OUTPUT: 23:45:21 INFO - 2015-11-16 23:45:21,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49504/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:45:22 INFO - 2015-11-16 23:45:22,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 319217664 23:45:22 INFO - 2015-11-16 23:45:22,292 DEBUG : BROWSER_OUTPUT: 23:45:24 INFO - 2015-11-16 23:45:24,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49504/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:45:24 INFO - 2015-11-16 23:45:24,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 325976064 23:45:24 INFO - 2015-11-16 23:45:24,976 DEBUG : BROWSER_OUTPUT: 23:45:27 INFO - 2015-11-16 23:45:27,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:45:28 INFO - 2015-11-16 23:45:28,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 327884800 23:45:28 INFO - 2015-11-16 23:45:28,123 DEBUG : BROWSER_OUTPUT: 23:45:30 INFO - 2015-11-16 23:45:30,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:45:31 INFO - 2015-11-16 23:45:31,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 326524928 23:45:31 INFO - 2015-11-16 23:45:31,312 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49504/tests/kraken/driver.html?testName=ai-astar) 23:45:33 INFO - 2015-11-16 23:45:33,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 387207168 23:45:33 INFO - 2015-11-16 23:45:33,298 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,299 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:45:33 INFO - 2015-11-16 23:45:33,299 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:45:33 INFO - 2015-11-16 23:45:33,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:45:33 INFO - 2015-11-16 23:45:33,300 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:45:33 INFO - 2015-11-16 23:45:33,300 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;106;103;107;107;108;98;105;108;107 23:45:33 INFO - 2015-11-16 23:45:33,300 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;131;150;164;126;150;147;129;165;132 23:45:33 INFO - 2015-11-16 23:45:33,300 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;162;163;162;164;163;160;159 23:45:33 INFO - 2015-11-16 23:45:33,300 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;81;88;84;67;70;84;81;83;67 23:45:33 INFO - 2015-11-16 23:45:33,301 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;98;134;88;89;89;130;88;89;136 23:45:33 INFO - 2015-11-16 23:45:33,301 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;119;114;120;120;114;119;117;117;119 23:45:33 INFO - 2015-11-16 23:45:33,301 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;127;126;126;126;125;126;131;126;125;125 23:45:33 INFO - 2015-11-16 23:45:33,301 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;96;100;94;95;93;101;102;94;102 23:45:33 INFO - 2015-11-16 23:45:33,301 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;61;60;61;61;61;69;60;60 23:45:33 INFO - 2015-11-16 23:45:33,301 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;70;69;69;70;69;70;70;70 23:45:33 INFO - 2015-11-16 23:45:33,302 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;86;86;87;86;87;87;88;88;88 23:45:33 INFO - 2015-11-16 23:45:33,302 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;124;124;132;129;124;132;124;125;124 23:45:33 INFO - 2015-11-16 23:45:33,302 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;143;155;153;155;143;153;153;152;143 23:45:33 INFO - 2015-11-16 23:45:33,302 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;70;71;71;71;71;73;71;72 23:45:33 INFO - 2015-11-16 23:45:33,302 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:45:33 INFO - 2015-11-16 23:45:33,303 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:45:33 INFO - 2015-11-16 23:45:33,303 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,920 23:45:33 INFO - 2015-11-16 23:45:33,303 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:45:33 INFO - 2015-11-16 23:45:33,304 DEBUG : BROWSER_OUTPUT: __startTimestamp1447746333298__endTimestamp 23:45:33 INFO - 2015-11-16 23:45:33,305 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,305 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:45:33 INFO - 2015-11-16 23:45:33,305 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:45:33 INFO - 2015-11-16 23:45:33,305 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,305 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.50 Median:107.00 stddev:3.03 (2.8%) stddev-sans-first:3.21 23:45:33 INFO - 2015-11-16 23:45:33,306 DEBUG : BROWSER_OUTPUT: Values: 106.0 106.0 103.0 107.0 107.0 108.0 98.0 105.0 108.0 107.0 23:45:33 INFO - 2015-11-16 23:45:33,306 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,306 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.90 Median:150.00 stddev:14.52 (9.7%) stddev-sans-first:14.93 23:45:33 INFO - 2015-11-16 23:45:33,306 DEBUG : BROWSER_OUTPUT: Values: 155.0 131.0 150.0 164.0 126.0 150.0 147.0 129.0 165.0 132.0 23:45:33 INFO - 2015-11-16 23:45:33,306 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,306 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 23:45:33 INFO - 2015-11-16 23:45:33,307 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 162.0 163.0 162.0 164.0 163.0 160.0 159.0 23:45:33 INFO - 2015-11-16 23:45:33,307 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,307 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.80 Median:82.00 stddev:7.79 (9.5%) stddev-sans-first:8.06 23:45:33 INFO - 2015-11-16 23:45:33,307 DEBUG : BROWSER_OUTPUT: Values: 73.0 81.0 88.0 84.0 67.0 70.0 84.0 81.0 83.0 67.0 23:45:33 INFO - 2015-11-16 23:45:33,307 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,307 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:88.50 stddev:20.65 (23.3%) stddev-sans-first:21.85 23:45:33 INFO - 2015-11-16 23:45:33,308 DEBUG : BROWSER_OUTPUT: Values: 100.0 98.0 134.0 88.0 89.0 89.0 130.0 88.0 89.0 136.0 23:45:33 INFO - 2015-11-16 23:45:33,308 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,308 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:119.00 stddev:2.33 (2.0%) stddev-sans-first:2.35 23:45:33 INFO - 2015-11-16 23:45:33,308 DEBUG : BROWSER_OUTPUT: Values: 120.0 119.0 114.0 120.0 120.0 114.0 119.0 117.0 117.0 119.0 23:45:33 INFO - 2015-11-16 23:45:33,308 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,308 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:126.30 Median:126.00 stddev:1.77 (1.4%) stddev-sans-first:1.86 23:45:33 INFO - 2015-11-16 23:45:33,309 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 126.0 126.0 125.0 126.0 131.0 126.0 125.0 125.0 23:45:33 INFO - 2015-11-16 23:45:33,309 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,309 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.10 Median:94.00 stddev:3.70 (3.9%) stddev-sans-first:3.75 23:45:33 INFO - 2015-11-16 23:45:33,309 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 100.0 94.0 95.0 93.0 101.0 102.0 94.0 102.0 23:45:33 INFO - 2015-11-16 23:45:33,309 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,309 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.00 stddev:2.68 (4.4%) stddev-sans-first:2.83 23:45:33 INFO - 2015-11-16 23:45:33,310 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 60.0 61.0 61.0 61.0 69.0 60.0 60.0 23:45:33 INFO - 2015-11-16 23:45:33,310 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,310 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 23:45:33 INFO - 2015-11-16 23:45:33,310 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 70.0 69.0 69.0 70.0 69.0 70.0 70.0 70.0 23:45:33 INFO - 2015-11-16 23:45:33,310 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,310 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 23:45:33 INFO - 2015-11-16 23:45:33,311 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 86.0 87.0 86.0 87.0 87.0 88.0 88.0 88.0 23:45:33 INFO - 2015-11-16 23:45:33,311 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,311 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:125.00 stddev:3.37 (2.7%) stddev-sans-first:3.54 23:45:33 INFO - 2015-11-16 23:45:33,313 DEBUG : BROWSER_OUTPUT: Values: 125.0 124.0 124.0 132.0 129.0 124.0 132.0 124.0 125.0 124.0 23:45:33 INFO - 2015-11-16 23:45:33,313 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,313 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:153.00 stddev:5.63 (3.7%) stddev-sans-first:5.34 23:45:33 INFO - 2015-11-16 23:45:33,313 DEBUG : BROWSER_OUTPUT: Values: 142.0 143.0 155.0 153.0 155.0 143.0 153.0 153.0 152.0 143.0 23:45:33 INFO - 2015-11-16 23:45:33,313 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,313 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 23:45:33 INFO - 2015-11-16 23:45:33,314 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 70.0 71.0 71.0 71.0 71.0 73.0 71.0 72.0 23:45:33 INFO - 2015-11-16 23:45:33,314 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:45:33 INFO - 2015-11-16 23:45:33,314 DEBUG : BROWSER_OUTPUT: 23:45:33 INFO - 2015-11-16 23:45:33,968 INFO : Browser exited with error code: 0 23:45:34 INFO - 2015-11-16 23:45:34,017 INFO : Completed test kraken (00:00:57) 23:45:34 INFO - 2015-11-16 23:45:34,017 INFO : Starting test v8_7 23:45:34 INFO - 2015-11-16 23:45:34,017 DEBUG : operating with platform_type : mac_ 23:45:34 INFO - 2015-11-16 23:45:34,018 INFO : Initialising browser for v8_7 test... 23:45:34 INFO - 2015-11-16 23:45:34,033 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmp8e_pjp/profile http://localhost:49504/getInfo.html 23:45:36 INFO - 2015-11-16 23:45:36,178 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:45:36 INFO - 2015-11-16 23:45:36,178 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:45:36 INFO - 2015-11-16 23:45:36,178 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:45:36 INFO - 2015-11-16 23:45:36,178 DEBUG : BROWSER_OUTPUT: __metrics 23:45:36 INFO - 2015-11-16 23:45:36,196 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:45:36 INFO - 2015-11-16 23:45:36,862 INFO : Browser initialized. 23:45:36 INFO - 2015-11-16 23:45:36,863 INFO : Running cycle 1/1 for v8_7 test... 23:45:36 INFO - 2015-11-16 23:45:36,863 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmp8e_pjp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:45:48 INFO - 2015-11-16 23:45:48,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 229543936 23:45:48 INFO - 2015-11-16 23:45:48,779 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49504/tests/v8_7/run.html (next: http://localhost:49504/tests/v8_7/run.html) 23:46:10 INFO - 2015-11-16 23:46:10,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 695885824 23:46:10 INFO - 2015-11-16 23:46:10,504 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,504 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:46:10 INFO - 2015-11-16 23:46:10,504 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: |0;Richards;168.26518593303047 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;198.96538002387584 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: |2;Encrypt;326.2642740619902 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5797.687861271676 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1901.1406844106464 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: |5;Earley;923.3610341643582 23:46:10 INFO - 2015-11-16 23:46:10,505 DEBUG : BROWSER_OUTPUT: |6;Boyer;12935.897435897436 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: |7;RegExp;29342.85714285714 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: |8;Splay;646.4906632324534 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: __startTimestamp1447746370499__endTimestamp 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:46:10 INFO - 2015-11-16 23:46:10,506 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.27 Median:168.27 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: Values: 168.3 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:198.97 Median:198.97 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: Values: 199.0 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:326.26 Median:326.26 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: Values: 326.3 23:46:10 INFO - 2015-11-16 23:46:10,507 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: Values: 5797.7 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1901.14 Median:1901.14 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: Values: 1901.1 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:923.36 Median:923.36 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: Values: 923.4 23:46:10 INFO - 2015-11-16 23:46:10,508 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12935.90 Median:12935.90 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: Values: 12935.9 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29342.86 Median:29342.86 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: Values: 29342.9 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:646.49 Median:646.49 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: Values: 646.5 23:46:10 INFO - 2015-11-16 23:46:10,509 DEBUG : BROWSER_OUTPUT: 23:46:10 INFO - 2015-11-16 23:46:10,510 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 23:46:10 INFO - 2015-11-16 23:46:10,510 DEBUG : BROWSER_OUTPUT: Values: 5803.5 23:46:10 INFO - 2015-11-16 23:46:10,510 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:46:10 INFO - 2015-11-16 23:46:10,510 DEBUG : BROWSER_OUTPUT: 23:46:11 INFO - 2015-11-16 23:46:11,192 INFO : Browser exited with error code: 0 23:46:11 INFO - 2015-11-16 23:46:11,212 INFO : Completed test v8_7 (00:00:37) 23:46:11 INFO - 2015-11-16 23:46:11,608 INFO : Completed test suite (00:20:11) 23:46:11 INFO - 2015-11-16 23:46:11,608 DEBUG : Working with test: dromaeo_css 23:46:11 INFO - 2015-11-16 23:46:11,608 DEBUG : Generating results file: dromaeo_css 23:46:11 INFO - 2015-11-16 23:46:11,608 DEBUG : Working with test: kraken 23:46:11 INFO - 2015-11-16 23:46:11,609 DEBUG : Generating results file: kraken 23:46:11 INFO - 2015-11-16 23:46:11,609 INFO : javascript benchmark 23:46:11 INFO - 2015-11-16 23:46:11,609 DEBUG : Working with test: v8_7 23:46:11 INFO - 2015-11-16 23:46:11,609 DEBUG : Generating results file: v8_7 23:46:11 INFO - 2015-11-16 23:46:11,609 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:46:11 INFO - 2015-11-16 23:46:11,663 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 23:46:11 INFO - 2015-11-16 23:46:11,663 DEBUG : process_Request line: dromaeo_css 6397.48 graph.html#tests=[[72,63,55]] 23:46:11 INFO - 2015-11-16 23:46:11,663 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:46:11 INFO - 2015-11-16 23:46:11,688 DEBUG : process_Request line: kraken 1500.10 graph.html#tests=[[232,63,55]] 23:46:11 INFO - 2015-11-16 23:46:11,688 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:46:11 INFO - 2015-11-16 23:46:11,710 DEBUG : process_Request line: v8_7 18180.98 graph.html#tests=[[230,63,55]] 23:46:11 INFO - 2015-11-16 23:46:11,711 INFO : javascript benchmark 23:46:11 INFO - 2015-11-16 23:46:11,713 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [322.30864795014696, 323.4711247110973, 328.5055990733945, 329.76092333058534, 337.5679130712687, 13674.453021879113, 14445.277736113205, 17745.822541774578, 18175.363862264825, 18526.07369631518, 13899.79150312746, 14909.32908019139, 17677.0, 17839.0, 17892.46322610324, 4573.451185857702, 5296.073187192245, 5298.761555730001, 5319.281896943901, 5354.625176237665, 3820.0640842993366, 3937.822797974098, 5176.404713457963, 5265.921011184835, 5353.0899747043095, 5562.499375056244, 5697.43025697429, 5717.685527295997, 5755.482006619403, 5798.507126894219, 5674.602777805555, 5697.633221722669, 5706.77172913083, 5732.369439361667, 5741.024025915604, 4959.603231741452, 4977.303177555145, 4978.4025916890205, 4984.0, 5028.974855125701, 21674.0, 22009.33971980843, 22264.443388915246, 22581.322560323217, 22604.660930086062, 1909.8567607429359, 1941.6407964526609, 1961.3723608445302, 2088.592724418739, 2112.324056301984, 9039.322050846147, 13101.148425352418, 13309.201447913156, 13424.261665608388, 13528.391222394917, 1142.4973011874831, 1462.7293950619169, 1488.2038109611306, 1516.113073851798, 1537.1699282387497, 56442.43557564454, 59375.70312148455, 59900.0, 60029.99999999956, 60174.0, 6268.937310626927, 6390.456811171102, 6419.358064193637, 6423.357664233633, 6437.420632143036, 7085.539439936388, 7226.458015648847, 7243.384312333405, 7323.560586364729, 7340.119185697644, 5017.84946451607, 5057.72182529957, 5069.264956581275, 5121.206213036985, 5122.359705036871, 5138.254953031864, 5240.135377662643, 5260.368755749335, 5268.894622107537, 5301.655392399482, 2801.8038737288603, 2820.1680504251294, 2849.871755770995, 2863.527517959555, 2865.469888070672, 969.6024629901707, 970.8834939807127, 989.9010098990187, 1012.549415510091, 1044.738815296176, 380.2300341807806, 404.51660265982457, 422.2483978518242, 430.95474975127786, 451.60935790540947, 10943.945280273547, 11031.724206894893, 11269.887301127048, 11688.766224675628, 11943.104267179997, 399.1398536154592, 420.3190830853975, 432.84201266537485, 439.5736135948125, 440.81926410172315, 5724.599278050579, 6196.969015154896, 6203.565750397429, 6207.5654704171175, 6210.099535567318, 562954.0, 563409.0, 570936.0, 575647.0, 584797.0, 70514.2948570518, 71313.0, 71972.0, 72051.63974180096, 73421.0, 488.2115383655371, 493.9580135688507, 495.2521692244736, 496.42166875590254, 497.8133200049981, 10488.895111048792, 10588.417637030037, 10766.73083172927, 10784.191185661264, 10803.189760767817, 33642.327153457285, 33668.0, 34232.82883585666, 34936.825315873255, 36377.81811090928, 48696.5130348692, 48835.755821220664, 48922.0, 48937.2659410102, 49259.0, 5968.910466342922, 5999.580029398075, 6072.967595508686, 6089.238845144357, 6091.543134264859, 11046.171537134587, 11616.767664646492, 11619.6514104577, 11621.825672614748, 11817.822732658846, 9813.0, 10123.493825308558, 10259.384436933808, 10260.58957641686, 10275.948620256851, 9796.412215267106, 9833.115019648267, 9903.45530995802, 9904.405735655884, 9941.453220072965, 10110.646127385506, 10261.17910567138, 10483.633072842415, 10489.842652360068, 10493.0, 5553.777848885999, 5567.888642227052, 5618.0, 5778.739956701875, 6072.605280656743, 9813.607455701978, 9848.704538863845, 9971.700848974542, 10046.69859904204, 10059.295849290773], "dojo.html": [3133.420317241309, 3143.6856314368565, 3198.680131986801, 3214.3571285742855, 3267.55887955126, 4951.727654978984, 5053.848384548461, 5185.714785686786, 5237.502437268458, 5237.8690532736655, 5186.740662966856, 5191.169412893938, 5201.661891977028, 5245.632805703603, 5246.7638956246965, 4753.572178503934, 4837.008413275279, 4846.951530484703, 4893.4617192108835, 4925.08885856116, 4841.3222148899185, 4844.370231869852, 4914.410270767513, 4917.532834380728, 4933.629977751683, 4856.927146092811, 4884.731339776311, 4891.14404979129, 4891.339669144673, 4924.138275801738, 4737.0, 4817.951820481803, 4826.348442960208, 4847.733374664392, 4961.3798275215595, 4795.688280261772, 4821.445533763627, 4837.661363704542, 4912.754362281871, 4965.180745177042, 5095.745212739348, 5135.332406787131, 5164.948350516484, 5201.141811601119, 5217.47825217479, 5082.2122571001555, 5230.267762513251, 5280.445553216934, 5389.9759045781175, 5482.588805839578, 5452.781888724447, 5453.0, 5454.8909021819345, 5465.617406781527, 5549.806791539839, 5100.413452452941, 5129.948700512984, 5134.0, 5134.178531435027, 5197.506236907488, 5560.2493663355735, 5599.440055994368, 5622.6345287557, 5632.831015069554, 5715.514181294553, 5396.811111611075, 5403.648762830403, 5418.376886658085, 5452.345718513804, 5461.399246082928, 5517.503424691797, 5567.2762540870235, 5570.0, 5575.0, 5583.106702927512, 5424.864378390572, 5437.918431223535, 5438.728063596884, 5462.044142275086, 5526.198701188386, 5314.229436731653, 5403.0, 5416.10634245353, 5446.945530544723, 5452.073147564924, 4091.0, 4164.75011499311, 4173.478315210598, 4206.3690446432665, 4240.745555266632, 3825.7130715195913, 3875.0893540018074, 3882.107115363482, 3904.082540602956, 3910.843566257318, 5004.774785134678, 5065.56942659878, 5082.059818933435, 5116.590672746172, 5138.743062846843, 5412.783488660488, 5468.863278418072, 5577.498025177753, 5595.440455954372, 5602.879424115112, 5115.693058416507, 5117.769700363493, 5127.205283181038, 5151.175811870083, 5186.507281808223, 4692.366530518405, 4810.39870016248, 4822.734749588806, 4854.368932038883, 4861.562459378602, 5657.688827114548, 5666.376698563155, 5670.546356291405, 5681.034224181899, 5749.942500575108, 5458.8908221834545, 5459.317585301837, 5478.671279723229, 5543.667379957215, 5556.638818476786, 5576.470235327637, 5595.860103497445, 5596.5242954347705, 5611.663300202001, 5670.688112153871, 5374.0, 5374.919376209282, 5470.015397228378, 5494.313210848644, 5546.389897111234, 5369.838904832861, 5513.476219759116, 5516.834494965157, 5535.8892822144135, 5574.665520068809, 5295.7087360195555, 5413.70224637633, 5443.0, 5465.07093794048, 5511.173324001432, 5211.973940130275, 5403.351597808131, 5407.405185429679, 5489.4236105209975, 5492.752826122914, 5335.253064571041, 5391.487808658171, 5401.729913504388, 5408.918866217088, 5436.401995780382, 5466.945330546802, 5470.64440811346, 5486.6982315973, 5496.780128794803, 5504.669719816824, 5191.169412893919, 5205.401378841481, 5262.842114736564, 5325.068113080273, 5394.649347792381], "mootools.html": [1436.6911114110464, 1744.4243399678107, 1757.077534294496, 1757.8857374270672, 1778.7776527934009, 6878.380945714891, 7041.436685065195, 7051.365377116065, 7128.465365097625, 7136.892946605805, 7039.57762534247, 7065.823354416142, 7087.822804429892, 7142.464315176357, 7176.5335253208505, 2067.1627990663806, 2086.321945367758, 2104.2214380679093, 2110.757262914769, 2110.8944552772377, 2103.663413853776, 2112.3629187379825, 2118.3962570667363, 2119.544297975935, 2138.7433507979063, 1897.7343171955938, 1936.244864502845, 1943.7084437334372, 2037.6943458481273, 2043.3869839048225, 1989.6120256549978, 2000.1799262302459, 2028.8072633099905, 2031.8069783370556, 2056.5372791122027, 2076.3874656976227, 2096.5073207796154, 2103.2112957640884, 2154.450615093141, 2155.5257843274453, 6371.299157092716, 6463.709133088975, 6925.549839260482, 7203.063601731741, 7259.491835571512, 4492.101579684044, 4505.053938672882, 4560.429946256718, 4571.474280457756, 4583.793729282191, 2753.366725653091, 2834.036427614621, 2835.2344866885824, 2868.3259434033193, 2870.8277503349864, 899.7390756680555, 914.1452741686478, 934.5374039850318, 944.3436811416069, 956.7608097975506, 9046.81906361869, 9129.817403651956, 9134.543272836332, 9146.77133071672, 9152.130547597968, 3826.6747326477002, 3868.729188956746, 3900.7269491135917, 3910.9217815644097, 3913.178232571192, 8059.717909873127, 8153.347732181412, 8154.06228283755, 8156.9184308156155, 8193.09875913649, 4329.177456283296, 4386.254336762758, 4388.824447022147, 4403.427554417905, 4408.625266852289, 3977.343738283209, 4014.959850401517, 4017.055991841915, 4022.1151346703678, 4023.4970628671417, 3399.490076488497, 3400.2179498715436, 3402.727781777452, 3410.334984677964, 3470.930581388358, 1047.7904419116207, 1052.0531521630594, 1059.3220338983058, 1071.3678929431674, 1077.9514921828536, 945.4091193004373, 963.1283688262134, 976.0532283684814, 1021.8416145497459, 1259.552858735136, 6956.304369563003, 6962.060121883582, 6973.05863708403, 6987.371136597731, 7046.1192350956135, 412.6616174736747, 416.11990639797216, 418.2555052007432, 419.58251539717565, 439.7801099450275, 5004.099262132779, 5488.56091512678, 5513.779448822002, 5520.889582208333, 5578.944210557924, 8218.137095604994, 8384.790380240544, 8412.116727743622, 8468.0, 8570.571471426403, 8201.876971845428, 8338.0, 8418.957905210435, 8429.831403372022, 8458.407911446262, 6828.078209441761, 6931.0643063186835, 6951.131108611424, 6974.4420446364165, 6995.825104372431, 6662.866742665023, 6674.399304062657, 6726.125603671491, 6763.458923286224, 6768.08630834831, 7677.270659287359, 7679.692812287446, 7752.224777522202, 7777.533347999138, 7822.100458447124, 7909.327707144727, 7925.405594580545, 7941.166177551274, 7970.721024764105, 8010.759677209693, 6108.664023478574, 6416.807495775134, 6433.453156481564, 6441.3880681335195, 6522.478201743754, 6823.692933817891, 6988.825279368057, 6989.33601307875, 6994.090768200102, 7116.679749411393, 6425.293217745951, 6496.317886622026, 6521.250056243593, 6635.0, 6644.501662375438, 6458.063580780855, 6458.677066146768, 6471.870562588628, 6514.446272066927, 6609.008648702733, 6616.933830661825, 6641.734330626721, 6659.334066593302, 6715.7985260442265, 6754.324567543206, 5881.0, 6007.249093863267, 6024.33732289439, 6048.637081775108, 6057.909131362945, 6061.181740464981, 6086.087086936995, 6118.908216376669, 6144.41628045335, 6168.722407491584], "ext.html": [531.893621275745, 544.0452006728193, 549.5630973376166, 560.1122221279272, 560.249265983582, 29382.2654433639, 30364.848175759118, 38239.0, 38296.425553616646, 38476.61523384765, 40877.182456350856, 40918.38622420666, 40918.59081409185, 40949.385759213634, 41235.0, 7906.644201010969, 8851.601677924493, 8949.507777072258, 8952.597133129026, 8971.05803890592, 8072.919270807305, 8202.630881610341, 10638.0, 10719.0, 10789.568417263301, 10185.439800810953, 10543.525541350618, 10624.043836054754, 10685.2520323577, 10793.406362650052, 8193.221643943876, 10506.159507239403, 10541.683749487527, 10680.893191068106, 10712.25014249003, 7868.095169055575, 10618.36289822613, 10668.093212076983, 10802.621908233252, 10835.0, 37266.44100338497, 37306.81346593277, 37337.439938400945, 37814.0, 37831.0, 2888.465633857743, 2909.258139174518, 2918.664353599342, 2977.8064425812254, 3039.118655589876, 26529.0, 26972.73027269722, 27103.593446098323, 27217.047403340985, 27573.31066723348, 2303.8156947444163, 2373.1456675596773, 2388.6775285336603, 2475.356407334088, 2494.2517244826663, 282276.0, 282297.0, 282566.99999999796, 282597.0, 282728.0, 48311.5168848307, 49850.501494985314, 55556.16665750017, 56002.15996760052, 56535.0, 62181.0, 63649.363506364345, 63708.0, 63780.36219637837, 64504.67747661232, 13112.672183195496, 13504.662383440493, 13521.526746564019, 13530.323483825769, 13672.52146174879, 9977.551010204557, 10027.348222365523, 10083.445410502492, 10088.899111008795, 10095.899041009643, 17809.376671816422, 17817.752757307124, 17922.014289214218, 17926.0, 18139.72790408145, 7657.0, 7859.799256208271, 7867.960660196777, 7897.3287270581495, 7983.800404989922, 899.3794281945437, 928.178561972659, 1011.1253765492796, 1018.4195008844887, 1023.3143793658118, 26838.194854154408, 27084.1874743758, 27130.0, 27245.182644520697, 27531.696196456553, 967.3228739882111, 1015.3248090020202, 1075.6772968109535, 1080.36258607422, 1113.571275059108, 13959.511417100555, 14026.929865350608, 14240.148780658448, 14321.498747543787, 14434.639134021523, 313967.0, 318836.0, 320641.0, 321458.0, 321713.0, 43959.560404395546, 44201.77899110484, 50367.0, 51581.0, 52073.0, 1305.719270356859, 1337.585348541955, 1349.757043732118, 1352.4184600621827, 1355.4442678501766, 25954.740452595233, 26127.869360653076, 26454.0, 26511.60232596474, 26619.33451663724, 41077.79461102675, 41927.37108943307, 42141.0, 46424.767876160404, 47600.0, 195573.0, 198891.0, 199888.01119888478, 200551.0, 201885.0, 29079.418411631224, 29194.56208156922, 29497.280435130277, 29512.852435737685, 29535.704642954155, 36879.0, 37340.813295933345, 38149.0, 38218.235635287696, 39154.6084539151, 32381.83809081034, 33817.15457113592, 34105.0, 34166.487502686985, 34587.4811877817, 33706.66293337035, 33847.66152338544, 34044.148896277795, 34388.0, 34467.13832154216, 33743.83128084344, 34422.48366274558, 34839.0, 34857.302853942274, 35273.64726352703, 28500.42999140047, 29748.85125574445, 29938.70061299359, 30007.54988675128, 30272.69727302787, 22610.66084008774, 22633.66049509226, 22716.4320891979, 23125.88437057871, 23326.416839579146], "prototype.html": [305.16537270565, 313.81484923894897, 314.4481435081432, 315.8894386964563, 319.19085119222774, 5986.940130598693, 6038.215032045828, 6109.480694140998, 6167.290761562422, 6268.84327891803, 5952.166696662471, 6081.665508397036, 6185.381461853813, 6189.597676151058, 6196.628202307865, 4766.952330476685, 4767.833125840605, 4833.3716616839765, 4841.56425921667, 4849.24836650318, 4595.747233902134, 4697.084068606623, 4711.693739906912, 4722.244440889458, 4791.976040119795, 4489.102179564084, 4686.9531304687025, 4695.436547614291, 4744.359511465959, 4810.831620893269, 4723.76381180943, 4747.52524747526, 4752.382190315271, 4777.259524773665, 4807.975960120195, 4065.410515475269, 4078.2455245779624, 4102.835886564534, 4110.568390319003, 4112.465379500676, 5983.431574000463, 5985.371535988702, 6009.729562169713, 6024.337322894478, 6039.54703397247, 5128.358955130609, 5304.098303288411, 5317.760700768475, 5347.679139251657, 5364.383095943977, 6403.0, 6412.102305677209, 6413.903791443132, 6460.160179176724, 6460.93539064608, 4209.705320627558, 4322.719023263509, 4388.495323037828, 4412.84555040572, 4427.623651989585, 6623.172103487064, 6797.694103765342, 6824.317568243186, 6877.1747390313485, 6894.586324820527, 4372.475302963601, 4492.865214043584, 4498.775061246924, 4508.233600287959, 4549.431321084864, 4564.064366804863, 4564.589186973122, 4566.0411313623845, 4570.428696412949, 4570.771461426982, 5076.847694569169, 5192.143296356059, 5207.3230480037355, 5219.451957544479, 5304.071787437183, 6471.805845824632, 6480.740770369227, 6488.870222595521, 6543.411093001652, 6564.507661925375, 1545.2273863068465, 1565.2877940537028, 1566.1229711361673, 1567.7883485729508, 1568.6235303527299, 990.8513722941473, 990.9256805739599, 1009.9899001009895, 1019.4698756646651, 1027.2706378471219, 6176.505879529716, 6182.258129024546, 6183.319834818167, 6184.010558310649, 6251.218597675291, 6724.462043036546, 6726.730930762715, 6750.7299708012115, 6774.525783195129, 6784.287649796799, 5985.970070149709, 6170.043643235216, 6177.227846519185, 6196.132541444202, 6251.906221406683, 3592.0481072515804, 3628.600853906068, 3631.5642122944887, 3639.1448009717697, 3662.761920475214, 6931.584104953719, 6943.89584156238, 6952.965235173791, 7006.614636194956, 7029.859402811915, 6620.172478440195, 6825.69284382204, 6830.59016459014, 6835.384815366541, 6912.516123871281, 6924.446044316443, 6927.064846245793, 6935.6878940447805, 7004.264552221944, 7021.613811240431, 6723.092382528492, 6723.9327606725265, 6762.459003279824, 6804.9319506804295, 6814.829629259309, 6358.427741503287, 6550.213974323112, 6605.603663780189, 6607.174103237096, 6668.766593169215, 6968.128983877015, 7038.3665470107935, 7042.366187043191, 7042.753503627553, 7045.753398631228, 4262.296721040993, 4276.144771045741, 4287.356896465555, 4300.0, 4305.892352691208, 6645.833854153685, 6709.463242940651, 6739.730410783513, 6742.4943129266485, 6754.290799466182, 6536.3136870627895, 6561.1470508833545, 6587.505937054836, 6602.372774586406, 6626.304238054935, 6492.610443373413, 6512.446442052478, 6517.674116294261, 6633.867322653617, 6638.236602790741, 6254.843628909313, 6381.968090159519, 6401.487880969418, 6435.163428754232, 6525.673716314261, 6579.046038324321, 6582.17722784652, 6635.734570617315, 6636.004599309949, 6667.033280174251, 6422.325655806073, 6425.518086143651, 6431.324710905287, 6462.127612772216, 6492.610443373413], "yui.html": [701.9754308599199, 732.4726197138062, 753.1639879733498, 759.4835511851942, 821.4947807098632, 13195.538156164535, 13342.799858002138, 13351.532696355629, 13373.732525349487, 13459.932700336485, 11468.541258349656, 12419.882210601045, 12522.060845436583, 12554.183978041421, 12662.556810511634, 842.191496163682, 850.5832142250315, 860.3805260212637, 863.2187869977649, 863.3826813828111, 807.7132617920641, 841.9494830310201, 848.5078654380444, 855.6620135046653, 855.985656996458, 894.2354287084546, 901.6663834381288, 902.9232515236213, 903.2367649336301, 904.6019751309435, 886.8093359927647, 897.470492409475, 900.3607438718452, 902.7066203483894, 908.5184852028402, 665.1419668627465, 665.354606032148, 666.4368608525788, 667.2960027171332, 669.859329540797, 11900.58347957826, 12099.213551119148, 12114.515419383215, 12119.272843629411, 12290.692732681666, 9478.763030924212, 9550.665726699532, 9596.280278979104, 9682.70951871445, 10094.394336339843, 8628.26659733917, 8749.650013999433, 8786.472811631322, 8873.822523549492, 8896.555172241362, 2956.9260768480744, 3023.1686286271233, 3034.484137696597, 3044.436779195834, 3067.156531953708, 46506.06987860224, 46649.533504665196, 47077.0, 47260.763696181646, 48016.27975580404, 7618.5809780461495, 7639.427042971799, 7749.147593764681, 7878.409119316074, 7951.483153594998, 16421.42525011619, 16428.83571164297, 16436.260368283456, 16556.917215413847, 16645.83354166443, 6452.548321617535, 6757.087793147961, 6800.353966373186, 6813.649181616133, 7054.188768291712, 3531.5585551806025, 3670.834812433447, 3700.0564855961557, 3783.2055268393397, 3787.154581882495, 2695.7304269572887, 2733.6309598204384, 2752.2431331383627, 2754.944901102007, 2782.8469434181316, 404.79557823299047, 411.8579090213871, 415.3131906435857, 418.3891518383134, 421.23756001637133, 478.8252287914956, 488.4992882295604, 528.3659608469775, 546.0, 563.7491316364178, 6989.4187274574815, 7318.286265654733, 7330.96334518324, 7373.446991475661, 7573.318401343906, 447.33570647588306, 464.74671304139326, 475.96665264824617, 530.8115618955293, 575.6373484704609, 3157.936841263208, 3482.9303413932084, 3535.699465545406, 3589.10272431892, 4058.2492238935893, 52391.476085239425, 53569.0, 54114.72942635261, 54254.0, 54819.725901370235, 42358.8985547778, 42798.57201427946, 45307.320390194174, 50052.0, 50745.0, 44811.77594112008, 45732.77133614311, 45913.770431148296, 46028.539714603095, 46250.768746156056, 7772.45592808498, 7938.28555429991, 8053.83892322162, 8224.588770561568, 8305.127961563949, 33220.33559328848, 33408.665913340556, 33980.49029264612, 34109.14727131841, 34511.4823277646, 43754.562454375045, 45854.770726146155, 46304.0, 46629.0, 46715.0, 7259.709611615687, 7412.0, 7498.287662672037, 7595.810104747426, 7862.606869656609, 10283.794324113325, 10741.194410419093, 10936.394098227725, 11194.832077519006, 11691.240069395462, 9346.53267336644, 9488.95255523718, 9764.707058788248, 10059.39643621385, 10081.798364032531, 9753.268504862306, 9895.554700038372, 9909.702708918743, 10263.538140783534, 10295.588176472857, 9993.450360230258, 10063.849042264226, 10357.63748268807, 10462.738431539272, 10866.348019118877, 8701.956490217508, 8702.347323950855, 8951.776205594912, 9028.0, 9217.723468295962, 8198.775125157727, 8622.2671072957, 8878.903305162125, 8999.235065019546, 9083.678805412272]}, "summary": {"lowerIsBetter": false, "suite": 6397.480552091002, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6830.145446066292, "unit": "ms", "value": 6830.145446066292}, "dojo.html": {"lowerIsBetter": false, "filtered": 5113.095187426448, "unit": "ms", "value": 5113.095187426448}, "mootools.html": {"lowerIsBetter": false, "filtered": 4050.9152074700282, "unit": "ms", "value": 4050.9152074700282}, "ext.html": {"lowerIsBetter": false, "filtered": 17484.027845988625, "unit": "ms", "value": 17484.027845988625}, "prototype.html": {"lowerIsBetter": false, "filtered": 4860.7710821525625, "unit": "ms", "value": 4860.7710821525625}, "yui.html": {"lowerIsBetter": false, "filtered": 5701.66162949099, "unit": "ms", "value": 5701.66162949099}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0010"}, "testrun": {"date": 1447745159, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116220542", "branch": "Mozilla-Inbound", "revision": "2f103f5a44ffcbef4fc27617a6a6431b96699631"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 161.0, 162.0, 163.0, 162.0, 164.0, 163.0, 160.0, 159.0], "ai-astar": [106.0, 106.0, 103.0, 107.0, 107.0, 108.0, 98.0, 105.0, 108.0, 107.0], "imaging-gaussian-blur": [120.0, 119.0, 114.0, 120.0, 120.0, 114.0, 119.0, 117.0, 117.0, 119.0], "audio-beat-detection": [155.0, 131.0, 150.0, 164.0, 126.0, 150.0, 147.0, 129.0, 165.0, 132.0], "json-stringify-tinderbox": [70.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 70.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [142.0, 143.0, 155.0, 153.0, 155.0, 143.0, 153.0, 153.0, 152.0, 143.0], "json-parse-financial": [61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 69.0, 60.0, 60.0], "stanford-crypto-sha256-iterative": [71.0, 72.0, 70.0, 71.0, 71.0, 71.0, 71.0, 73.0, 71.0, 72.0], "audio-fft": [73.0, 81.0, 88.0, 84.0, 67.0, 70.0, 84.0, 81.0, 83.0, 67.0], "imaging-darkroom": [127.0, 126.0, 126.0, 126.0, 125.0, 126.0, 131.0, 126.0, 125.0, 125.0], "stanford-crypto-ccm": [125.0, 124.0, 124.0, 132.0, 129.0, 124.0, 132.0, 124.0, 125.0, 124.0], "audio-oscillator": [100.0, 98.0, 134.0, 88.0, 89.0, 89.0, 130.0, 88.0, 89.0, 136.0], "stanford-crypto-aes": [87.0, 86.0, 86.0, 87.0, 86.0, 87.0, 87.0, 88.0, 88.0, 88.0], "imaging-desaturate": [94.0, 96.0, 100.0, 94.0, 95.0, 93.0, 101.0, 102.0, 94.0, 102.0]}, "summary": {"lowerIsBetter": true, "suite": 1500.1, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 77.8, "unit": "ms", "value": 77.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.2, "unit": "ms", "value": 149.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.9, "unit": "ms", "value": 144.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 126.3, "unit": "ms", "value": 126.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 126.3, "unit": "ms", "value": 126.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.5, "unit": "ms", "value": 61.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.1, "unit": "ms", "value": 104.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 105.5, "unit": "ms", "value": 105.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.6, "unit": "ms", "value": 161.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.3, "unit": "ms", "value": 71.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 117.9, "unit": "ms", "value": 117.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.0, "unit": "ms", "value": 87.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 97.1, "unit": "ms", "value": 97.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0010"}, "testrun": {"date": 1447745159, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116220542", "branch": "Mozilla-Inbound", "revision": "2f103f5a44ffcbef4fc27617a6a6431b96699631"}}, {"talos_counters": {}, "results": {"DeltaBlue": [198.96538002387584], "Encrypt": [326.2642740619902], "NavierStokes": [5803.468208092486], "Decrypt": [5797.687861271676], "Splay": [646.4906632324534], "Richards": [168.26518593303047], "RegExp": [29342.85714285714], "Earley": [923.3610341643582], "Boyer": [12935.897435897436], "RayTrace": [1901.1406844106464]}, "summary": {"lowerIsBetter": false, "suite": 18180.97572197725, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 332.30906799999985, "unit": "score", "value": 332.30906799999985}, "Encrypt": {"lowerIsBetter": false, "filtered": 815.844765, "unit": "score", "value": 815.844765}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.70916334661337, "unit": "score", "value": 255.70916334661337}, "Decrypt": {"lowerIsBetter": false, "filtered": 45.91157826520441, "unit": "score", "value": 45.91157826520441}, "Splay": {"lowerIsBetter": false, "filtered": 126.05131772908364, "unit": "score", "value": 126.05131772908364}, "RegExp": {"lowerIsBetter": false, "filtered": 31.046226874391458, "unit": "score", "value": 31.046226874391458}, "Richards": {"lowerIsBetter": false, "filtered": 209.79978600000007, "unit": "score", "value": 209.79978600000007}, "Earley": {"lowerIsBetter": false, "filtered": 721.7794289999998, "unit": "score", "value": 721.7794289999998}, "Boyer": {"lowerIsBetter": false, "filtered": 51.52043012884043, "unit": "score", "value": 51.52043012884043}, "RayTrace": {"lowerIsBetter": false, "filtered": 389.23421400000007, "unit": "score", "value": 389.23421400000007}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0010"}, "testrun": {"date": 1447745159, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116220542", "branch": "Mozilla-Inbound", "revision": "2f103f5a44ffcbef4fc27617a6a6431b96699631"}}] 23:46:11 INFO - RETURN: dromaeo_css: 6397.48 23:46:11 INFO - RETURN: kraken: 1500.10 23:46:11 INFO - RETURN: v8_7: 18180.98 23:46:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "18180.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1500.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "6397.48"}}} 23:46:11 INFO - Return code: 0 23:46:11 INFO - # TBPL SUCCESS # 23:46:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:46:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:46:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:46:11 INFO - 2015-11-16 23:46:11.818 screenresolution[1951:13264] starting screenresolution argv=screenresolution get 23:46:11 INFO - 2015-11-16 23:46:11.821 screenresolution[1951:13264] Display 0: 1600x1200x32@60 23:46:11 INFO - 2015-11-16 23:46:11.827 screenresolution[1952:13267] starting screenresolution argv=screenresolution list 23:46:11 INFO - Available Modes on Display 0 23:46:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:46:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:46:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:46:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:46:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:46:12 INFO - Intel HD Graphics 3000: 23:46:12 INFO - Chipset Model: Intel HD Graphics 3000 23:46:12 INFO - Type: GPU 23:46:12 INFO - Bus: Built-In 23:46:12 INFO - VRAM (Total): 512 MB 23:46:12 INFO - VRAM (Dynamic, Max): 10 23:46:12 INFO - Vendor: Intel (0x8086) 23:46:12 INFO - Device ID: 0x0116 23:46:12 INFO - Revision ID: 0x0009 23:46:12 INFO - Displays: 23:46:12 INFO - Display: 23:46:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:46:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:46:12 INFO - Display Serial Number: 1600x1200 60 23:46:12 INFO - Main Display: Yes 23:46:12 INFO - Mirror: Off 23:46:12 INFO - Online: Yes 23:46:12 INFO - Rotation: Supported 23:46:12 INFO - Return code: 0 23:46:12 INFO - Running post-action listener: _resource_record_post_action 23:46:12 INFO - Running post-run listener: _resource_record_post_run 23:46:13 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 2437120; Write bytes: 685548544; Read time: 1178; Write time: 68102 23:46:13 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 333918720; Write bytes: 335534080; Read time: 32292; Write time: 11463 23:46:13 INFO - run-tests - Wall time: 1213s; CPU: 30.0%; Read bytes: 2437120; Write bytes: 339651584; Read time: 1178; Write time: 55509 23:46:13 INFO - Running post-run listener: _upload_blobber_files 23:46:13 INFO - Blob upload gear active. 23:46:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:46:13 INFO - Copying logs to upload dir... 23:46:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.264672 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-16 23:46:13.245232) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 23:46:13.248763) ========= 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.VkfWibQBzF/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.4Jb2pSQKkk/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010117 build_url: 'https://queue.taskcluster.net/v1/task/UeS6xquyQHennq4-_6ifXw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 23:46:13.277110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:46:13.277599) ========= 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.VkfWibQBzF/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.4Jb2pSQKkk/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005298 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:46:13.330019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 23:46:13.330472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 23:46:13.331147) ========= ========= Total master_lag: 0.33 =========