builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0018 starttime: 1448197638.68 results: success (0) buildid: 20151122030230 builduid: 2968c35ee67049c0a03698e9f33c93d2 revision: abbd213422a560f1180c4ec6e3bf4792c2ea81ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:18.681693) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:18.682108) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:18.682383) ========= 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.XLUVNGbXDc/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.WRjOXK53cO/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005594 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:18.742619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:18.742909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:18.961336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:18.961612) ========= 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.XLUVNGbXDc/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.WRjOXK53cO/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005705 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:19.005854) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:19.006185) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:19.007058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:19.007405) ========= 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.XLUVNGbXDc/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.WRjOXK53cO/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-22 05:07:19-- 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% 8.15M=0.001s 2015-11-22 05:07:19 (8.15 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.235613 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:19.282613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:19.282935) ========= 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.XLUVNGbXDc/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.WRjOXK53cO/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026038 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:19.381625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-22 05:07:19.381946) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev abbd213422a560f1180c4ec6e3bf4792c2ea81ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev abbd213422a560f1180c4ec6e3bf4792c2ea81ba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-22 05:07:19,460 truncating revision to first 12 chars 2015-11-22 05:07:19,460 Setting DEBUG logging. 2015-11-22 05:07:19,461 attempt 1/10 2015-11-22 05:07:19,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/abbd213422a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-22 05:07:20,442 unpacking tar archive at: mozilla-central-abbd213422a5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.220152 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-22 05:07:20.642664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:20.643022) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:20.676436) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:20.676765) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-22 05:07:20.679228) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2015-11-22 05:07:20.679524) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:07:20 INFO - MultiFileLogger online at 20151122 05:07:20 in /builds/slave/test 05:07:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:07:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:20 INFO - {'append_to_log': False, 05:07:20 INFO - 'base_work_dir': '/builds/slave/test', 05:07:20 INFO - 'blob_upload_branch': 'Firefox', 05:07:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:20 INFO - 'branch': 'Firefox', 05:07:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:20 INFO - 'config_files': ('talos/mac_config.py',), 05:07:20 INFO - 'default_actions': ('clobber', 05:07:20 INFO - 'read-buildbot-config', 05:07:20 INFO - 'download-and-extract', 05:07:20 INFO - 'populate-webroot', 05:07:20 INFO - 'create-virtualenv', 05:07:20 INFO - 'install', 05:07:20 INFO - 'run-tests'), 05:07:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:20 INFO - 'download_minidump_stackwalk': True, 05:07:20 INFO - 'download_symbols': 'ondemand', 05:07:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:20 INFO - 'installer_path': 'installer.exe', 05:07:20 INFO - 'log_level': 'info', 05:07:20 INFO - 'log_name': 'talos', 05:07:20 INFO - 'log_to_console': True, 05:07:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:20 INFO - 'opt_config_files': (), 05:07:20 INFO - 'pip_index': False, 05:07:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:20 INFO - 'cmd': ('bash', 05:07:20 INFO - '-c', 05:07:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:20 INFO - 'enabled': True, 05:07:20 INFO - 'halt_on_failure': False, 05:07:20 INFO - 'name': 'check_screen_resolution'},), 05:07:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:20 INFO - 'cmd': ('bash', 05:07:20 INFO - '-c', 05:07:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:20 INFO - 'enabled': True, 05:07:20 INFO - 'halt_on_failure': False, 05:07:20 INFO - 'name': 'check_screen_resolution'},), 05:07:20 INFO - 'run_cmd_checks_enabled': True, 05:07:20 INFO - 'sps_profile': False, 05:07:20 INFO - 'sps_profile_interval': 0, 05:07:20 INFO - 'suite': 'dromaeojs', 05:07:20 INFO - 'system_bits': '64', 05:07:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:20 INFO - 'title': 't-yosemite-r7-0018', 05:07:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:20 INFO - 'use_talos_json': True, 05:07:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:20 INFO - 'work_dir': 'build'} 05:07:20 INFO - ##### 05:07:20 INFO - ##### Running clobber step. 05:07:20 INFO - ##### 05:07:20 INFO - Running pre-action listener: _resource_record_pre_action 05:07:20 INFO - Running main action method: clobber 05:07:20 INFO - rmtree: /builds/slave/test/build 05:07:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:22 INFO - Running post-action listener: _resource_record_post_action 05:07:22 INFO - ##### 05:07:22 INFO - ##### Running read-buildbot-config step. 05:07:22 INFO - ##### 05:07:22 INFO - Running pre-action listener: _resource_record_pre_action 05:07:22 INFO - Running main action method: read_buildbot_config 05:07:22 INFO - Using buildbot properties: 05:07:22 INFO - { 05:07:22 INFO - "properties": { 05:07:22 INFO - "buildnumber": 5, 05:07:22 INFO - "product": "firefox", 05:07:22 INFO - "script_repo_revision": "production", 05:07:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:07:22 INFO - "repository": "", 05:07:22 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:07:22 INFO - "buildid": "20151122030230", 05:07:22 INFO - "slavename": "t-yosemite-r7-0018", 05:07:22 INFO - "stage_platform": "macosx64", 05:07:22 INFO - "basedir": "/builds/slave/test", 05:07:22 INFO - "nightly_build": "True", 05:07:22 INFO - "project": "", 05:07:22 INFO - "platform": "yosemite_r7", 05:07:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:07:22 INFO - "slavebuilddir": "test", 05:07:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:07:22 INFO - "branch": "mozilla-central", 05:07:22 INFO - "repo_path": "mozilla-central", 05:07:22 INFO - "pgo_build": "False", 05:07:22 INFO - "builduid": "2968c35ee67049c0a03698e9f33c93d2", 05:07:22 INFO - "revision": "abbd213422a560f1180c4ec6e3bf4792c2ea81ba" 05:07:22 INFO - }, 05:07:22 INFO - "sourcestamp": { 05:07:22 INFO - "repository": "", 05:07:22 INFO - "hasPatch": false, 05:07:22 INFO - "project": "", 05:07:22 INFO - "branch": "mozilla-central-macosx64-talos", 05:07:22 INFO - "changes": [ 05:07:22 INFO - { 05:07:22 INFO - "category": null, 05:07:22 INFO - "files": [ 05:07:22 INFO - { 05:07:22 INFO - "url": null, 05:07:22 INFO - "name": "https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:07:22 INFO - } 05:07:22 INFO - ], 05:07:22 INFO - "repository": "", 05:07:22 INFO - "rev": "abbd213422a560f1180c4ec6e3bf4792c2ea81ba", 05:07:22 INFO - "who": "sendchange", 05:07:22 INFO - "when": 1448197538, 05:07:22 INFO - "number": 6693025, 05:07:22 INFO - "comments": "", 05:07:22 INFO - "project": "", 05:07:22 INFO - "at": "Sun 22 Nov 2015 05:05:38", 05:07:22 INFO - "branch": "mozilla-central-macosx64-talos", 05:07:22 INFO - "revlink": "", 05:07:22 INFO - "properties": [ 05:07:22 INFO - [ 05:07:22 INFO - "buildid", 05:07:22 INFO - "20151122030230", 05:07:22 INFO - "Change" 05:07:22 INFO - ], 05:07:22 INFO - [ 05:07:22 INFO - "builduid", 05:07:22 INFO - "2968c35ee67049c0a03698e9f33c93d2", 05:07:22 INFO - "Change" 05:07:22 INFO - ], 05:07:22 INFO - [ 05:07:22 INFO - "nightly_build", 05:07:22 INFO - "True", 05:07:22 INFO - "Change" 05:07:22 INFO - ], 05:07:22 INFO - [ 05:07:22 INFO - "pgo_build", 05:07:22 INFO - "False", 05:07:22 INFO - "Change" 05:07:22 INFO - ] 05:07:22 INFO - ], 05:07:22 INFO - "revision": "abbd213422a560f1180c4ec6e3bf4792c2ea81ba" 05:07:22 INFO - } 05:07:22 INFO - ], 05:07:22 INFO - "revision": "abbd213422a560f1180c4ec6e3bf4792c2ea81ba" 05:07:22 INFO - } 05:07:22 INFO - } 05:07:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:07:22 INFO - Running post-action listener: _resource_record_post_action 05:07:22 INFO - ##### 05:07:22 INFO - ##### Running download-and-extract step. 05:07:22 INFO - ##### 05:07:22 INFO - Running pre-action listener: _resource_record_pre_action 05:07:22 INFO - Running main action method: download_and_extract 05:07:22 INFO - mkdir: /builds/slave/test/build/tests 05:07:22 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')]} 05:07:22 INFO - https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:07:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/test_packages.json 05:07:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/test_packages.json 05:07:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:07:24 INFO - Downloaded 1149 bytes. 05:07:24 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:07:24 INFO - Using the following test package requirements: 05:07:24 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:07:24 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:24 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:07:24 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:24 INFO - u'jsshell-mac.zip'], 05:07:24 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:24 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:07:24 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:07:24 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:24 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:07:24 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:24 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:07:24 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:24 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:07:24 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:07:24 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:24 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:07:24 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:24 INFO - https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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 05:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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 05:07:26 INFO - Downloaded 17524673 bytes. 05:07:26 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 05:07:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:07:29 INFO - Return code: 0 05:07:29 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 05:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:29 INFO - https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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 05:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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 05:07:59 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip: timed out 05:07:59 INFO - retry: attempt #1 caught exception: timed out 05:07:59 INFO - retry: Failed, sleeping 30 seconds before retrying 05:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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 #2 05:08:31 INFO - Downloaded 17524673 bytes. 05:08:31 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 05:08:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:08:34 INFO - Return code: 0 05:08:34 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')]} 05:08:34 INFO - https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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 05:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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 05:08:35 INFO - Downloaded 11130997 bytes. 05:08:35 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 05:08:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:08:36 INFO - Return code: 0 05:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:36 INFO - https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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 05:08:40 INFO - Downloaded 109734963 bytes. 05:08:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:40 INFO - mkdir: /builds/slave/test/properties 05:08:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:40 INFO - Contents: 05:08:40 INFO - build_url:https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:40 INFO - Running post-action listener: _resource_record_post_action 05:08:40 INFO - Running post-action listener: set_extra_try_arguments 05:08:40 INFO - ##### 05:08:40 INFO - ##### Running populate-webroot step. 05:08:40 INFO - ##### 05:08:40 INFO - Running pre-action listener: _resource_record_pre_action 05:08:40 INFO - Running main action method: populate_webroot 05:08:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:08:40 INFO - '../fennec_ids.txt'], 05:08:40 INFO - 'tests': ['tcheck2']}, 05:08:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:40 INFO - '--tppagecycles', 05:08:40 INFO - '7'], 05:08:40 INFO - 'tests': ['tsvgm']}}, 05:08:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:08:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:08:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:08:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:40 INFO - 'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:40 INFO - 'tests': ['damp', 'tps']}, 05:08:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:40 INFO - 'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['damp', 'tps']}, 05:08:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:08:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:40 INFO - 'other': {'tests': ['a11yr', 05:08:40 INFO - 'ts_paint', 05:08:40 INFO - 'tpaint', 05:08:40 INFO - 'sessionrestore', 05:08:40 INFO - 'sessionrestore_no_auto_restore']}, 05:08:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['a11yr', 05:08:40 INFO - 'ts_paint', 05:08:40 INFO - 'tpaint', 05:08:40 INFO - 'sessionrestore', 05:08:40 INFO - 'sessionrestore_no_auto_restore']}, 05:08:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['a11yr', 05:08:40 INFO - 'ts_paint', 05:08:40 INFO - 'tpaint', 05:08:40 INFO - 'sessionrestore', 05:08:40 INFO - 'sessionrestore_no_auto_restore']}, 05:08:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['a11yr', 05:08:40 INFO - 'ts_paint', 05:08:40 INFO - 'tpaint', 05:08:40 INFO - 'sessionrestore', 05:08:40 INFO - 'sessionrestore_no_auto_restore']}, 05:08:40 INFO - 'other_l64': {'tests': ['a11yr', 05:08:40 INFO - 'ts_paint', 05:08:40 INFO - 'tpaint', 05:08:40 INFO - 'sessionrestore', 05:08:40 INFO - 'sessionrestore_no_auto_restore']}, 05:08:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:08:40 INFO - 'ts_paint', 05:08:40 INFO - 'tpaint', 05:08:40 INFO - 'sessionrestore', 05:08:40 INFO - 'sessionrestore_no_auto_restore']}, 05:08:40 INFO - 'svgr': {'tests': ['tsvgx', 05:08:40 INFO - 'tsvgr_opacity', 05:08:40 INFO - 'tart', 05:08:40 INFO - 'tscrollx', 05:08:40 INFO - 'cart']}, 05:08:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['tsvgx', 05:08:40 INFO - 'tsvgr_opacity', 05:08:40 INFO - 'tart', 05:08:40 INFO - 'tscrollx', 05:08:40 INFO - 'cart']}, 05:08:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:40 INFO - 'tests': ['tp5o']}, 05:08:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:40 INFO - 'talos_options': ['--e10s'], 05:08:40 INFO - 'tests': ['tp5o']}, 05:08:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:40 INFO - 'talos_options': ['--xperf_path', 05:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:40 INFO - 'tests': ['tp5n']}, 05:08:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:40 INFO - 'talos_options': ['--e10s', 05:08:40 INFO - '--xperf_path', 05:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:40 INFO - 'tests': ['tp5n']}}, 05:08:40 INFO - 'talos.zip': {'path': '', 05:08:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:40 INFO - Running post-action listener: _resource_record_post_action 05:08:40 INFO - ##### 05:08:40 INFO - ##### Running create-virtualenv step. 05:08:40 INFO - ##### 05:08:40 INFO - Running pre-action listener: _resource_record_pre_action 05:08:40 INFO - Running main action method: create_virtualenv 05:08:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:40 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 05:08:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:40 INFO - Using real prefix '/tools/python27' 05:08:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:44 INFO - Installing pip.................done. 05:08:44 INFO - Return code: 0 05:08:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 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 0x1028a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102884228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a3d72de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027cb9f0>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027be8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:44 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 05:08:44 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 05:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/Render', 05:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:44 INFO - 'HOME': '/Users/cltbld', 05:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:44 INFO - 'LOGNAME': 'cltbld', 05:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:44 INFO - 'MOZ_NO_REMOTE': '1', 05:08:44 INFO - 'NO_EM_RESTART': '1', 05:08:44 INFO - 'PAGER': '/bin/cat', 05:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:44 INFO - 'PWD': '/builds/slave/test', 05:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:44 INFO - 'SHELL': '/bin/bash', 05:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WRjOXK53cO/Listeners', 05:08:44 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:44 INFO - 'USER': 'cltbld', 05:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:44 INFO - 'XPC_FLAGS': '0x0', 05:08:44 INFO - 'XPC_SERVICE_NAME': '0', 05:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:44 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 05:08:44 INFO - Cleaning up... 05:08:44 INFO - Return code: 0 05:08:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 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 0x1028a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102884228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a3d72de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027cb9f0>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027be8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:44 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 05:08:44 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 05:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/Render', 05:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:44 INFO - 'HOME': '/Users/cltbld', 05:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:44 INFO - 'LOGNAME': 'cltbld', 05:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:44 INFO - 'MOZ_NO_REMOTE': '1', 05:08:44 INFO - 'NO_EM_RESTART': '1', 05:08:44 INFO - 'PAGER': '/bin/cat', 05:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:44 INFO - 'PWD': '/builds/slave/test', 05:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:44 INFO - 'SHELL': '/bin/bash', 05:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WRjOXK53cO/Listeners', 05:08:44 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:44 INFO - 'USER': 'cltbld', 05:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:44 INFO - 'XPC_FLAGS': '0x0', 05:08:44 INFO - 'XPC_SERVICE_NAME': '0', 05:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:44 INFO - Downloading/unpacking psutil>=0.7.1 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:08:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:47 INFO - Installing collected packages: psutil 05:08:47 INFO - Running setup.py install for psutil 05:08:47 INFO - building 'psutil._psutil_osx' extension 05:08:47 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 05:08:48 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 05:08:48 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 05:08:48 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 05:08:48 INFO - building 'psutil._psutil_posix' extension 05:08:48 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 05:08:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:48 INFO - ^ 05:08:48 INFO - 1 warning generated. 05:08:48 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 05:08:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:48 INFO - Successfully installed psutil 05:08:48 INFO - Cleaning up... 05:08:48 INFO - Return code: 0 05:08:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:48 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 0x1028a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102884228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a3d72de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027cb9f0>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027be8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:48 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 05:08:48 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 05:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/Render', 05:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:48 INFO - 'HOME': '/Users/cltbld', 05:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:48 INFO - 'LOGNAME': 'cltbld', 05:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:48 INFO - 'MOZ_NO_REMOTE': '1', 05:08:48 INFO - 'NO_EM_RESTART': '1', 05:08:48 INFO - 'PAGER': '/bin/cat', 05:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:48 INFO - 'PWD': '/builds/slave/test', 05:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:48 INFO - 'SHELL': '/bin/bash', 05:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WRjOXK53cO/Listeners', 05:08:48 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:48 INFO - 'USER': 'cltbld', 05:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:48 INFO - 'XPC_FLAGS': '0x0', 05:08:48 INFO - 'XPC_SERVICE_NAME': '0', 05:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:49 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 05:08:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:51 INFO - Installing collected packages: mozsystemmonitor 05:08:51 INFO - Running setup.py install for mozsystemmonitor 05:08:51 INFO - Successfully installed mozsystemmonitor 05:08:51 INFO - Cleaning up... 05:08:51 INFO - Return code: 0 05:08:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:51 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 0x1028a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102884228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a3d72de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027cb9f0>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027be8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:51 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 05:08:51 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 05:08:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/Render', 05:08:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:51 INFO - 'HOME': '/Users/cltbld', 05:08:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:51 INFO - 'LOGNAME': 'cltbld', 05:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:51 INFO - 'MOZ_NO_REMOTE': '1', 05:08:51 INFO - 'NO_EM_RESTART': '1', 05:08:51 INFO - 'PAGER': '/bin/cat', 05:08:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:51 INFO - 'PWD': '/builds/slave/test', 05:08:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:51 INFO - 'SHELL': '/bin/bash', 05:08:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WRjOXK53cO/Listeners', 05:08:51 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:08:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:51 INFO - 'USER': 'cltbld', 05:08:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:51 INFO - 'XPC_FLAGS': '0x0', 05:08:51 INFO - 'XPC_SERVICE_NAME': '0', 05:08:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:51 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 05:08:51 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 05:08:51 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 05:08:51 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 05:08:51 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 05:08:51 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 05:08:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:55 INFO - Downloading docopt-0.6.1.tar.gz 05:08:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:55 INFO - Running setup.py install for blobuploader 05:08:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:55 INFO - Running setup.py install for requests 05:08:55 INFO - Running setup.py install for docopt 05:08:55 INFO - Successfully installed blobuploader requests docopt 05:08:55 INFO - Cleaning up... 05:08:56 INFO - Return code: 0 05:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:56 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 0x1028a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102884228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a3d72de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027cb9f0>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027be8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:56 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 05:08:56 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 05:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/Render', 05:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:56 INFO - 'HOME': '/Users/cltbld', 05:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:56 INFO - 'LOGNAME': 'cltbld', 05:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:56 INFO - 'MOZ_NO_REMOTE': '1', 05:08:56 INFO - 'NO_EM_RESTART': '1', 05:08:56 INFO - 'PAGER': '/bin/cat', 05:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:56 INFO - 'PWD': '/builds/slave/test', 05:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:56 INFO - 'SHELL': '/bin/bash', 05:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WRjOXK53cO/Listeners', 05:08:56 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:56 INFO - 'USER': 'cltbld', 05:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:56 INFO - 'XPC_FLAGS': '0x0', 05:08:56 INFO - 'XPC_SERVICE_NAME': '0', 05:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-3wW_kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-VKlyrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-kmEUYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-8kr3QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Wd34iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-MVUarL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-E91AEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:56 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-IT8CfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-V1HrjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-nr5FsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-yqnB77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-2cP77Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Moq9bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-RkauDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-LfSaQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-UzDn2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:57 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-m0MPkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:58 INFO - Running setup.py install for manifestparser 05:08:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:58 INFO - Running setup.py install for mozcrash 05:08:58 INFO - Running setup.py install for mozdebug 05:08:58 INFO - Running setup.py install for mozdevice 05:08:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:58 INFO - Running setup.py install for mozfile 05:08:58 INFO - Running setup.py install for mozhttpd 05:08:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:58 INFO - Running setup.py install for mozinfo 05:08:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Running setup.py install for mozInstall 05:08:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Running setup.py install for mozleak 05:08:59 INFO - Running setup.py install for mozlog 05:08:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Running setup.py install for moznetwork 05:08:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Running setup.py install for mozprocess 05:08:59 INFO - Running setup.py install for mozprofile 05:08:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:59 INFO - Running setup.py install for mozrunner 05:09:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:00 INFO - Running setup.py install for mozscreenshot 05:09:00 INFO - Running setup.py install for moztest 05:09:00 INFO - Running setup.py install for mozversion 05:09:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:00 INFO - Cleaning up... 05:09:00 INFO - Return code: 0 05:09:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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', '-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 0x1028a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102884228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a3d72de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027cb9f0>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027be8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:00 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 05:09:00 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 05:09:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/Render', 05:09:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:00 INFO - 'HOME': '/Users/cltbld', 05:09:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:00 INFO - 'LOGNAME': 'cltbld', 05:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:00 INFO - 'MOZ_NO_REMOTE': '1', 05:09:00 INFO - 'NO_EM_RESTART': '1', 05:09:00 INFO - 'PAGER': '/bin/cat', 05:09:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:00 INFO - 'PWD': '/builds/slave/test', 05:09:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:00 INFO - 'SHELL': '/bin/bash', 05:09:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WRjOXK53cO/Listeners', 05:09:00 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:09:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:00 INFO - 'USER': 'cltbld', 05:09:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:00 INFO - 'XPC_FLAGS': '0x0', 05:09:00 INFO - 'XPC_SERVICE_NAME': '0', 05:09:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:00 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-HyRQ5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:00 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)) 05:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:00 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-t5HwdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-d5Fn9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-hh3uwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-fIxy1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-vTAAr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-VggH5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-xH8AdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-GfI19O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-kOcT1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:01 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)) 05:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:01 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-hM9vJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:02 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)) 05:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-ZmnANm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:02 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)) 05:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-A3m1jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:02 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)) 05:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-xmEkfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:02 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)) 05:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-1263AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:02 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)) 05:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-D65Q6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:02 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)) 05:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:02 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-jO3vCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:02 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)) 05:09:02 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)) 05:09:02 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)) 05:09:02 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)) 05:09:02 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)) 05:09:02 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)) 05:09:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:02 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 05:09:02 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 05:09:02 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 05:09:02 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 05:09:02 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 05:09:02 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 05:09:04 INFO - Downloading blessings-1.5.1.tar.gz 05:09:04 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 05:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:04 INFO - Installing collected packages: blessings 05:09:04 INFO - Running setup.py install for blessings 05:09:05 INFO - Successfully installed blessings 05:09:05 INFO - Cleaning up... 05:09:05 INFO - Return code: 0 05:09:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:05 INFO - Reading from file tmpfile_stdout 05:09:05 INFO - Current package versions: 05:09:05 INFO - blessings == 1.5.1 05:09:05 INFO - blobuploader == 1.2.4 05:09:05 INFO - docopt == 0.6.1 05:09:05 INFO - manifestparser == 1.1 05:09:05 INFO - mozInstall == 1.12 05:09:05 INFO - mozcrash == 0.16 05:09:05 INFO - mozdebug == 0.1 05:09:05 INFO - mozdevice == 0.47 05:09:05 INFO - mozfile == 1.2 05:09:05 INFO - mozhttpd == 0.7 05:09:05 INFO - mozinfo == 0.9 05:09:05 INFO - mozleak == 0.1 05:09:05 INFO - mozlog == 3.0 05:09:05 INFO - moznetwork == 0.27 05:09:05 INFO - mozprocess == 0.22 05:09:05 INFO - mozprofile == 0.27 05:09:05 INFO - mozrunner == 6.11 05:09:05 INFO - mozscreenshot == 0.1 05:09:05 INFO - mozsystemmonitor == 0.0 05:09:05 INFO - moztest == 0.7 05:09:05 INFO - mozversion == 1.4 05:09:05 INFO - psutil == 3.1.1 05:09:05 INFO - requests == 1.2.3 05:09:05 INFO - wsgiref == 0.1.2 05:09:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:05 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 0x1028a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102884228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a3d72de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027cb9f0>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027be8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/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.WRjOXK53cO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:05 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 05:09:05 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 05:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/Render', 05:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:05 INFO - 'HOME': '/Users/cltbld', 05:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:05 INFO - 'LOGNAME': 'cltbld', 05:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:05 INFO - 'MOZ_NO_REMOTE': '1', 05:09:05 INFO - 'NO_EM_RESTART': '1', 05:09:05 INFO - 'PAGER': '/bin/cat', 05:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:05 INFO - 'PWD': '/builds/slave/test', 05:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:05 INFO - 'SHELL': '/bin/bash', 05:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WRjOXK53cO/Listeners', 05:09:05 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:05 INFO - 'USER': 'cltbld', 05:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:05 INFO - 'XPC_FLAGS': '0x0', 05:09:05 INFO - 'XPC_SERVICE_NAME': '0', 05:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 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)) 05:09:05 INFO - Cleaning up... 05:09:05 INFO - Return code: 0 05:09:05 INFO - Running post-action listener: _resource_record_post_action 05:09:05 INFO - Running post-action listener: _start_resource_monitoring 05:09:05 INFO - Starting resource monitoring. 05:09:05 INFO - ##### 05:09:05 INFO - ##### Running install step. 05:09:05 INFO - ##### 05:09:05 INFO - Running pre-action listener: _resource_record_pre_action 05:09:05 INFO - Running main action method: install 05:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:05 INFO - Reading from file tmpfile_stdout 05:09:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:06 INFO - Reading from file tmpfile_stdout 05:09:06 INFO - Output received: 05:09:06 INFO - Usage: mozinstall [options] installer 05:09:06 INFO - Options: 05:09:06 INFO - -h, --help show this help message and exit 05:09:06 INFO - -d DEST, --destination=DEST 05:09:06 INFO - Directory to install application into. [default: 05:09:06 INFO - "/builds/slave/test"] 05:09:06 INFO - --app=APP Application being installed. [default: firefox] 05:09:06 INFO - mkdir: /builds/slave/test/build/application 05:09:06 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'] 05:09:06 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 05:09:36 INFO - Reading from file tmpfile_stdout 05:09:36 INFO - Output received: 05:09:36 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:09:36 INFO - Running post-action listener: _resource_record_post_action 05:09:36 INFO - ##### 05:09:36 INFO - ##### Running run-tests step. 05:09:36 INFO - ##### 05:09:36 INFO - Running pre-action listener: _resource_record_pre_action 05:09:36 INFO - Running main action method: run_tests 05:09:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:36 INFO - 2015-11-22 05:09:36.600 screenresolution[1651:8373] starting screenresolution argv=screenresolution get 05:09:36 INFO - 2015-11-22 05:09:36.603 screenresolution[1651:8373] Display 0: 1600x1200x32@60 05:09:36 INFO - 2015-11-22 05:09:36.608 screenresolution[1652:8375] starting screenresolution argv=screenresolution list 05:09:36 INFO - Available Modes on Display 0 05:09:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:36 INFO - Intel Iris: 05:09:36 INFO - Chipset Model: Intel Iris 05:09:36 INFO - Type: GPU 05:09:36 INFO - Bus: Built-In 05:09:36 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:36 INFO - Vendor: Intel (0x8086) 05:09:36 INFO - Device ID: 0x0a2e 05:09:36 INFO - Revision ID: 0x0009 05:09:36 INFO - Displays: 05:09:36 INFO - Display: 05:09:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:36 INFO - Display Serial Number: 1600x1200 60 05:09:36 INFO - Main Display: Yes 05:09:36 INFO - Mirror: Off 05:09:36 INFO - Online: Yes 05:09:36 INFO - Rotation: Supported 05:09:36 INFO - Return code: 0 05:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:36 INFO - Python 2.7.3 05:09:36 INFO - Return code: 0 05:09:36 INFO - grabbing minidump binary from tooltool 05:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:36 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 0x1027cb9f0>, '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 0x10252adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027be8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:36 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 05:09:36 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 05:09:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:36 INFO - Return code: 0 05:09:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost'] in /builds/slave/test/build 05:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --webServer localhost 05:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XLUVNGbXDc/Render', 05:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:36 INFO - 'HOME': '/Users/cltbld', 05:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:36 INFO - 'LOGNAME': 'cltbld', 05:09:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:36 INFO - 'MOZ_NO_REMOTE': '1', 05:09:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:36 INFO - 'NO_EM_RESTART': '1', 05:09:36 INFO - 'PAGER': '/bin/cat', 05:09:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:36 INFO - 'PWD': '/builds/slave/test', 05:09:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:36 INFO - 'SHELL': '/bin/bash', 05:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WRjOXK53cO/Listeners', 05:09:36 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 05:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:36 INFO - 'USER': 'cltbld', 05:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:36 INFO - 'XPC_FLAGS': '0x0', 05:09:36 INFO - 'XPC_SERVICE_NAME': '0', 05:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost'] with output_timeout 3600 05:09:37 INFO - mozversion INFO | application_buildid: 20151122030230 05:09:37 INFO - mozversion INFO | application_changeset: abbd213422a560f1180c4ec6e3bf4792c2ea81ba 05:09:37 INFO - mozversion INFO | application_display_name: Nightly 05:09:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:37 INFO - mozversion INFO | application_name: Firefox 05:09:37 INFO - mozversion INFO | application_remotingname: firefox 05:09:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:09:37 INFO - mozversion INFO | application_vendor: Mozilla 05:09:37 INFO - mozversion INFO | application_version: 45.0a1 05:09:37 INFO - mozversion INFO | platform_buildid: 20151122030230 05:09:37 INFO - mozversion INFO | platform_changeset: abbd213422a560f1180c4ec6e3bf4792c2ea81ba 05:09:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:09:37 INFO - mozversion INFO | platform_version: 45.0a1 05:09:37 INFO - 2015-11-22 05:09:37,158 DEBUG : using testdate: 1448197777 05:09:37 INFO - 2015-11-22 05:09:37,158 DEBUG : actual date: 1448197777 05:09:37 INFO - 2015-11-22 05:09:37,720 INFO : starting webserver on 'localhost:49273' 05:09:37 INFO - 2015-11-22 05:09:37,721 INFO : Starting test suite t-yosemite-r7-0018 05:09:37 INFO - 2015-11-22 05:09:37,721 INFO : Starting test dromaeo_css 05:09:37 INFO - 2015-11-22 05:09:37,721 DEBUG : operating with platform_type : mac_ 05:09:37 INFO - 2015-11-22 05:09:37,723 INFO : Initialising browser for dromaeo_css test... 05:09:37 INFO - 2015-11-22 05:09:37,735 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpOPfAay/profile http://localhost:49273/getInfo.html 05:09:40 INFO - 2015-11-22 05:09:40,068 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:40 INFO - 2015-11-22 05:09:40,068 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:40 INFO - 2015-11-22 05:09:40,068 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:09:40 INFO - 2015-11-22 05:09:40,068 DEBUG : BROWSER_OUTPUT: __metrics 05:09:40 INFO - 2015-11-22 05:09:40,084 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:40 INFO - 2015-11-22 05:09:40,717 INFO : Browser initialized. 05:09:40 INFO - 2015-11-22 05:09:40,717 INFO : Running cycle 1/1 for dromaeo_css test... 05:09:40 INFO - 2015-11-22 05:09:40,718 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpOPfAay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:09:52 INFO - 2015-11-22 05:09:52,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 226107392 05:09:52 INFO - 2015-11-22 05:09:52,500 DEBUG : BROWSER_OUTPUT: 05:10:43 INFO - 2015-11-22 05:10:43,447 DEBUG : BROWSER_OUTPUT: 1448197843446 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] 05:12:55 INFO - 2015-11-22 05:12:55,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 05:12:56 INFO - 2015-11-22 05:12:56,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 336211968 05:12:56 INFO - 2015-11-22 05:12:56,848 DEBUG : BROWSER_OUTPUT: 05:15:59 INFO - 2015-11-22 05:15:59,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 05:16:00 INFO - 2015-11-22 05:16:00,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 358248448 05:16:00 INFO - 2015-11-22 05:16:00,153 DEBUG : BROWSER_OUTPUT: 05:19:02 INFO - 2015-11-22 05:19:02,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 05:19:02 INFO - 2015-11-22 05:19:02,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 362119168 05:19:02 INFO - 2015-11-22 05:19:02,807 DEBUG : BROWSER_OUTPUT: 05:22:04 INFO - 2015-11-22 05:22:04,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 05:22:05 INFO - 2015-11-22 05:22:05,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 323002368 05:22:05 INFO - 2015-11-22 05:22:05,498 DEBUG : BROWSER_OUTPUT: 05:25:08 INFO - 2015-11-22 05:25:08,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:25:09 INFO - 2015-11-22 05:25:09,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 325185536 05:25:09 INFO - 2015-11-22 05:25:09,013 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:28:11 INFO - 2015-11-22 05:28:11,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 384946176 05:28:11 INFO - 2015-11-22 05:28:11,792 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,792 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:28:11 INFO - 2015-11-22 05:28:11,792 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:28:11 INFO - 2015-11-22 05:28:11,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:28:11 INFO - 2015-11-22 05:28:11,793 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:28:11 INFO - 2015-11-22 05:28:11,793 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2766.6541682289712;3510.8595656173748;3513.648635136485;3535.0808789714665;3576;5545.3622833374175;5656.066748986413;5975.910361344578;5979.910301345483;5986.281646202457;5980.31226408962;5992.760289588422;5996.190514280571;6009.849753756147;6011.609245399046;5300.681959082458;5329.866753331159;5363.839084827461;5396.91904621431;5411.134218525037;4672.6916463390135;5446.210299506569;5456.154296084113;5457.099578569531;5464.316960379952;5326.174442961347;5436.91844622331;5439.401665816757;5439.755211015494;5441.863953401157;5414.10667239905;5416.052190866602;5430.59270554706;5433.918491222635;5448.83653490396;5249.606279529051;5366.168243922199;5375.16684913839;5402.270693456372;5429.891402171974;5916.940830591682;5955.642661440284;5999.610025348338;6027.065804800263;6027.5177985761475;5325.440828712968;6288.52836037299;6292.653904035276;6300.621962682254;6307.274663413675;6140.9030504681;6200.937990620081;6235.376462353774;6237.594556353823;6293.685315734195;5924.793396688357;6133.84665383369;6145.631262124287;6157.107219453154;6161.8459538511;6425.710843012076;6516.511261655395;6539.934600654028;6540.509461790385;6548.738050477928;6103.755849766048;6163.8150855474405;6246.718897649616;6268.717907694165;6280.403361680633;6350.428461438492;6351.269603995507;6357.554971152067;6364.299927008025;6396.904046439307;6235.438810507076;6270.623762574261;6303.842403939847;6305.243370795534;6308;6131.950716841428;6169.105479705418;6252.406021427957;6288.371162883675;6299.779507717208;5099.413567439792;5107.668001579886;5110.642255042186;5114.897702045938;5128.307678463434;4132.710710250253;4580.770961451914;4593.839215627437;4611.33135695329;4625.699329543569;5815.883682326415;5917.349091599921;5970.462658360769;5991.131285963598;6044.8186554402555;6282.183316168869;6284.340144284875;6287.276963149205;6301.684915754194;6315.778947736899;4975.577075948512;5892.587518873637;5956.52347812174;5969.76120955157;6042.879142417215;5570.6657600544095;5580.804671836548;5590.692511911802;5591.4688104629995;5593.860153496195;6148.200733904564;6335.556511044183;6337.176167098248;6337.651429171347;6362.395572420613;6282.717277722422;6286.245650521967;6286.465650419766;6292.370762923854;6301.464375528131;6221.2845522765465;6233.0338797486465;6287.905681414691;6306.590071645328;6309.400606942333;6223;6223.253209614694;6231.314555398993;6241.687915604292;6288.088227207121;6204.038374051848;6289.465395441439;6290.370962903673;6292.937070629235;6313.2424109107205;6132.8773424532155;6268.341824108403;6269.31037585856;6274.341194174546;6303.149074875017;5424.860779236405;5898.970505147447;6259.937400625936;6270.7491700331475;6280.5289603279025;5979.701014949148;6092.725827337869;6121.173641558333;6138.846528836815;6141.877162456815;6123.510119190365;6248.250209974832;6271.3415091414745;6288.465480434214;6304.65324407162;6221.129041934042;6222.377762223741;6227.377262273736;6230.034344676583;6236.064590311489 05:28:11 INFO - 2015-11-22 05:28:11,794 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.97629444791;566.6486778197514;569.3992837556377;570.6946783470842;633.7528363938065;31737.047888563353;41180.382294265575;41304.58695413045;41330;41493.75518734439;43643.78178109113;44043;44057.55942440574;44093.7795311023;44111.897202569955;8625.396222264413;8736.082711315315;9675.129238368545;9846.261530385214;9869;8664.0902705216;8755.781105472382;8756.124387561256;8758.649654013832;11915.285082895054;11699.883001170007;11757.412129393539;11773.52905883768;11790.469428875722;11797.174197806156;11710.887465690788;11769;11782.88217117835;11790.705232369259;11879.168458207929;8762.737117886474;8888.422252553562;11654.359010254433;11659.766804663945;11880.940595297054;39768;40079.99800004994;40103;40120;40131.39802902959;3233.757468189872;3324.2354258520436;3362.596488421405;3406.0803583032443;3608.458731190316;29023;29126.41747165066;29129.70870291291;29451.11646650604;30052.398952021056;2810.0726760169096;2836.9432611347866;2886.07645553423;2918.8394638294885;2976.925576860574;485641;486381;486826.5658671719;488633;490621.54689226684;60110.699446503364;61053;61088.778224435264;68431;74878;54172.729136354064;69401.61196776036;70465;70498.64750676214;70515.64742176257;16611.335546578244;16804.6639067218;16819.32722691103;16827.32690692383;16862.90391124573;10805.945970270099;12690.873091269154;12752.298623575607;12758.9362053191;12909.612711618667;21919.780802192094;22211.333659990225;22251.776152311777;22270.443238918833;22284.442888927908;9083.636654533744;9271.67549135777;9279.350445468888;9282.303827212985;9292.53537323131;938.394735395666;945.6028468043438;1017.4562602785968;1052.563186277686;1141.6004398460639;22033.669494957587;29484.705152948194;29593;30028.69971300303;30417.847910760305;1093.905171596384;1096.5997410944947;1113.8440618313443;1121.2711737370773;1123.5561953028507;14377.424903003972;15147.394104235707;15278.006929549543;15534;15615.141167235912;550017;555909.2204538952;556336;556815;558025;59779.80440391168;59949.40050599438;59993.70003150043;60118.69940650269;60232;1407.1697698358018;1417.5888992192356;1434.390384086759;1439.2515891736448;1442.8917831162705;27310.726892730818;27538.724612753616;29759.85120074386;29782;29975.850120749255;52984.735076324374;53132;53182.73408632932;53408.73295633497;53425.4657453436;497523;502132;503066;503141;503320;28043.57934631023;28331.150065498066;28464.715352846208;33383;33890.49164262489;40845.36618535225;44372;45449.545504544534;45565.54434455746;45707.54292457033;32840.014799556055;36523.8329776178;36903.63096369002;37186.62813371832;37708.62291377051;37391.81304093462;37634.8118259407;37687.13634805236;37773.62226377811;38813.41779873361;31259.374812503167;31692;36070;37855.62144378521;38153;27470;28982.420351592427;32587.185320366232;41685.374719378626;42038.36942445805;30500.08499745011;31126.68873311238;31493.212669683442;31693;32665.18337041498 05:28:11 INFO - 2015-11-22 05:28:11,797 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.61583203856424;344.67944811325475;361.9981900090499;362.28268029301984;362.5196614485807;16471.423500177498;17848.910755446235;20124.69812952805;21140.577188456242;22236.777632223693;21546.569068618617;21619.6757048644;22003.33989980299;22046.88976555115;22062.669059964115;6563.310852360505;6758.9324106758795;6761.763338283161;6766.7969960901255;6771.559848609849;4602.194615942213;6645.202575690924;6948.617826019567;7460.477766556343;7462.21646727094;7248.0939882514685;7349.412047036224;7417.740379086733;7456.478046536745;7493.213212612652;7374.299441553044;7414.961905333258;7420.591867447289;7433.9256607434045;7441.293077157661;6892.758753443655;7054.92945070553;7063.6115013674225;7083.327083927019;7089.042979197794;20633.484162895897;24454.877725611437;26872.59691104635;27429.17712468629;27438;2040.6326861164985;2063.1128614695676;2088.822450091744;2174.3259589527297;2214.557088582274;9842.409455432626;10025.649102281384;10055.69832905014;10085.34445261063;13881.791773123412;1738.4697667211497;1748.4492384898717;1753.5095169106157;1766.3464518128376;1772.8493078088377;104585;108834.45582772115;109008;110090;111724;10897.67306980792;10977.83533247002;10992.725181870357;11028.779424411467;11058.22592418539;11928.582499612645;12421.571519275218;13128.934355328161;13172.341382930816;13176.802347964789;8082.353411727047;8168.428210025241;8312.83374332522;8319.084900660922;8326.750987351945;6656.8668626627195;8447.873281900776;8459.492430454193;8527.360447966428;8537.74386768398;3945.9013524662114;4109.301418758818;4248.553901840262;4301.032267739796;4307.827686892552;1464.9780253295996;1770.97343539847;1806.2413786209822;1814.3468351393487;1829.2561950677582;913.8218047480677;914.3279689428265;971.2133172130597;1045.5713157605346;1085.3273048364786;21088;21466.914112388138;22399.32802015942;22626.547469050856;22854.885725571265;756.3344257053867;825.8513467575895;955.7419496735981;972.7276362618478;1025.6769117727893;5997.7001149942325;6092.948189454052;6154.692265386802;6195;6234;779618;779838;779881;781291;796070;113945;118564;124383;130502;131387.34306328406;486.86317448757546;492.2517772985043;493.4793792548895;493.7284493528617;494.12293179606485;11465.484053217791;11582.189246752983;11600.361980091177;11643.941780291045;11658.76682466363;52059;54623.180652289455;55145;56079;56116;72875;76602.61698691471;78987;79180;82484.58757706173;9433.57548910287;9579.856302155335;9774.364666296953;9779.706608801747;10015.298929074896;19402.12690428906;19473.610527789082;19657.41027769169;20098.39704808858;20165.193392264144;15876.364945402054;16075.196240188177;16179.27193276329;16188.433404830774;16210.108444035219;14786.186759728318;15228.010179338307;15433.61415964565;16013.67972640564;16088.436904708278;13209;14412.927935360256;16397.67204655924;16458.917705411397;16827;9540.713778586654;9861.457619830979;9863.605455781688;9960;10000.649977250761;8446.282066024456;10125;10180.541875615467;10812.459377031275;16162.67674646524 05:28:11 INFO - 2015-11-22 05:28:11,799 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1401.0612889364124;1576.3379380660126;1576.8344323845995;1880.3982725527828;2028.1583142995657;7546.962265188673;7945.205479452052;8463.280621147202;8607.526586037766;8622.137786221374;8366.874496882536;8492.53291068991;8535;8545.61544730487;8548.529830859301;2106.262808017197;2165.480284731661;2365.881705914706;2386.2841147655636;2389.414593424605;2385.4632707640817;2428.0530593068715;2432.3797431654993;2432.927012189637;2435.5250726108416;2335.9766402336013;2383.892724827387;2385.1413491143176;2388.7491813359607;2389.474315650554;2101.6112019276484;2139.7218361613045;2157.924472643466;2325.209428794218;2368.159303447277;2386.9522609547885;2388.9641655375185;2391.557561851063;2392.246442370648;2398.112698301622;8403.41176117672;8478.872816907751;8492.745217643418;8507.744767656981;8514.57427128641;5136.871578210537;5160.535551800356;5218.556422704075;5222.399424066243;5251.4485978972425;3517.472379143149;3572.089117275078;3596.532450781408;3613.8915832525067;3624.2026754114054;975.9609615615367;1008.112860682602;1040.7606250562337;1076.3057827701168;1081.3511892864296;11304.265222760576;11315.603953861657;11336.94331528337;11337.886621133766;11338.829917551244;4589.2886602576655;4700.271457923959;4709.270063140219;4714.080754252887;4747.8100875965265;9825.803483930282;9833;9840.901590984142;9844.212463002943;9846.310758246997;5259.21111833228;5262.342207224097;5293.920591191135;5298.867528311823;5304.992051510278;4763.618910487153;4790.688605240718;4812.109759694467;4825.710457372569;4831.178699621073;3835.6547910688173;3851.441540976543;3852.036990752312;3875.399313106473;3879.689624830007;1279.353926267229;1280.295837289487;1281.858995510493;1291.0446269760498;1295.4494339905502;1366.6241783509415;1367.7811550151928;1404.1996062244627;1408.978865317021;1411.978820317696;7812.57030863308;7976.800579985431;7977.880331795028;7978.0825205102155;7985.640646170937;497.3832447764818;507.0973666872972;511.1132185657881;511.6086194061546;512.3390825834706;5763.3084029915835;5929.466348028698;5944.791932282349;6284.811455656338;6389.872202555923;9645.565949532287;9652.083052110038;9829;9870.012998700073;9983;9755.365901216399;9835.60657573689;9856.950715246378;9860.950695246478;9882.357646752938;7556.622168891534;7581.545107293469;7766;7781.8832717509285;7782.571958542221;7819.545871742569;7865.252800983897;7877.842443151219;7895.486793358414;7901.762947111596;8986.281097512314;9045.819083618422;9096.7270981868;9258.444493330422;9277.67528136512;9353.766155846159;9354.877414710278;9365.250779937453;9381.671641492516;9516.238700903772;7258.056452661121;7328.523645962995;7338.376238019615;7340;7385.446091543263;7036.612986285803;7939.761807145795;8035.758927232192;8047.597620118853;8104.98687664042;7507.174210836913;7523.849523009619;7566.24337566239;7676.692932282646;7717.382609391123;7252.38354739853;7391.40868730511;7425.257474252748;7474.663640136316;7542.773716788505;6139.447449729546;7508.587027713528;7540.924590754023;7565.546067235983;7571.848563028819;6868.862622747617;6915.308469153045;6917.342852429011;6922.203946546211;6924.3421874921805;6364.713587888648;6504.284528701934;6658.234303055211;6967.79096627102;7027.086478757728 05:28:11 INFO - 2015-11-22 05:28:11,802 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.60725611126367;323.6747069195458;329.0474077545506;333.9565856438664;338.2879039621595;5997.730102145403;6517;6916.619585922772;6947.826304342394;6955.930440695592;5873.794417195399;6723.957786543094;6865.6567171641345;6966.442684585234;6971.6165610891385;5165.04446677364;5169.105301031415;5171.17261238202;5173.5085166909275;5180.300659410969;4681.695689780154;4752.764281286855;4880.755962201875;5077.949220507785;5085.364329458817;4993.076280888047;5007.649464537484;5015.5987520998415;5017.573506251973;5032.773525191357;4801.615870730333;4858.902821943577;4884.145274576935;5000.649954503187;5023.3971923369245;3607.549056367954;4147.979260103711;4231.597998190167;4249.893752656209;4254.3831144483875;6591.71461564995;6621.702023408958;6626.171728533934;6646.93353066468;6664.233613134455;4923.335349727777;5670.177824215507;5805.303363596353;5947.405259474018;5950.702464876782;7170.641467926635;7287.489875708702;7311.341979221896;7339.045924029842;7353.926460735378;4706.905861882778;4710.3405523226775;4712.458067322267;4716.410448693913;4720.12677654635;7624;7715.6913723451;7727.265909738566;7828.21717828224;7835.529868207926;4775.976120119447;4777.856664300077;4789.473157952622;4789.880252993633;4790.473047964721;4657.998530315998;4860.416749990024;4872.975635121873;4878.975605121952;4887.65786394956;5885.61743486672;5888.793892213752;5901.262342207224;5903.085021821625;5906.911396329058;7203.459740519377;7424.331810137113;7446.888296675555;7452.85094298111;7469.589172595451;1670.949871503857;1697.6604679064237;1697.6859281033048;1701.4470297153227;1702.5743564108973;1064.4837253931837;1069.7218723132041;1078.9568417263379;1088.6679562733443;1095.2990086344746;6980;6987.091678081919;6988.475864310197;6994.475414343945;7000.684969176399;7644.541327520366;7678.040244969379;7687.6156192190165;7693.6922523099565;7727.92272077272;5702.258706368146;6755.729770809211;6933.861322773617;6943.305669433117;6963.9303606963285;3474.4788281757938;3922.7450215736458;4083.959160408417;4086.1623367210245;4093.3041382964966;7628.8855667165035;7633.099422219521;7654.311111999947;7658.578778167142;7661.233876612406;7691.615419229016;7727.222738770114;7913.920860791433;7924.524528528307;7932.682692692343;7607.809804754926;7737.148913619498;7777.455578109591;7795.649195786316;7804.058950230097;6275.96862015687;7754.6898124074405;7781.37748980069;7795.766127016199;7804.453688241769;6308.589941653778;7362.926370736438;7644.006279183671;7644.655990480331;7660.2722741339485;7726.575038372944;7729.9227007729205;7740.26467485588;7746.49647772893;7752.341051010727;3985.5416627087097;4807.158747219292;4811.4707382188635;4812.759362031955;4825.252085926687;7040.964795175992;7470.215627359266;7670.348020418327;7739;7739.187385324685;6020.608660437058;7323.414126869731;7404.222556631692;7404.407647388089;7418.517796343221;6011.218541589566;7236.34872861445;7408.407327413902;7417.703291868481;7471.476996610185;5959.165716799738;7290.9635451822405;7298.96350518244;7303.488755787044;7321.853562928818;7476.962615186889;7499.437542184249;7502;7505.774826755206;7513.173550909286;7127.501074924913;7295.52579082358;7303.379212766974;7322.121345438582;7325.377342925911 05:28:11 INFO - 2015-11-22 05:28:11,803 DEBUG : BROWSER_OUTPUT: |5;yui.html;681.4241965539119;688.7899190746821;736.1276886889034;739.6634531288264;800.0918956983821;15061;15279.69440611187;15300.617484562878;15325.54023379299;15325.846741532581;14002.649933751662;14131.788023179635;14137.151770893754;14178.0784249024;14223.92888035561;760.4030835793903;769.634423648768;770.3913908012663;945.7588314979705;946.1437399153776;958.8130314588658;961.500019989605;975.3611384543135;977.008336538414;977.8142152990908;1005.5475036233687;1021.8773747150352;1022.698304000318;1023.2837014090129;1024.605526872152;803.8874557561917;812.8943237379162;1000.1698590170141;1005.71839884832;1022.0392830739081;753.3634079203065;755.7581573896356;757.4546326644806;758.8596109719664;759.0132827324456;15131.54605361841;15264.465743698916;15278.006929549654;15279.847201527953;15342.693146137015;12539.24764514132;12770.425330860133;12947.870521294855;13041.739165216737;13194.010449216346;10109.39343639384;10280.79438411235;10364.740881477948;11074.557017719282;11118.776934537194;3502.124468882779;3526.4710293455933;3546.0992907801624;3547.290541891632;3621.004223838439;78311.60844195743;78422.21577784207;79090;79185;79910.80133797998;9783.608655653836;9804.166645835041;9905;10009.949950250202;10378.688639340831;22555.548889022128;22784.31647050591;22807.315780526278;22813.771862281497;22825.657615135788;7495.287947644965;7652.540847549165;7763.146053934176;7840.490368126054;7857.960710196412;4038.8788336349958;4087.9591204088174;4099.528554216244;4104.220198162339;4107;3676;3703.5555733311635;3716.832742526593;3717.7211709121925;3727.3290807654885;696.715413587931;711.836277656142;730.937870281032;731.7925423052006;741.9427316074572;468.6016885647173;480.6395203597302;489.48848453366315;503.3858692395272;513.6789506558401;6589.341065893373;8456.577171141542;8512.148785121439;8700.78248043804;8792.252658523968;491.5698763581866;499.71516235746003;513.8407093800934;529.8172130614931;543.2313276713485;3742.9519734474393;3854.71089668276;3938.4289278055094;4035.233305671913;4195.58044195578;99587;99789;101065.49467252617;101435;101760.49119754354;78958.21041789623;79144.20855791484;80614;80648.19351806524;82020;69925.65037174884;70995.64502177456;71399.92900106503;71509.64245178741;71921;7152.392046676091;8560.743177704679;8620.698275560326;8634.395592308478;8773.56132193375;49506.25740613822;49939.75030124826;50223.24665130099;50589.98820023505;51575;64841.67579162263;71324.93012604711;72513;73173.26826731878;73188.26811732027;10665.733356666145;10762.3542587445;11157.721056973316;11171.38557379352;11278.548858045586;11763.941180294043;11865.406729663655;11959.103067269816;12262.87737122653;12288.38558072075;11132.443377831238;11196.24442966734;11254;11417.60038398652;11499.080073593925;11571.074314054687;11616.477258523219;11695.473703683185;11706.76586468283;11837;11057.281276716987;11301.321920684784;11375.658730238107;11414.600488982845;11416.94291528537;9691.757706057406;9812.901870981199;9878.50607469638;10087.646932357333;10120.089191972758;9597.808043839224;9628.566714498005;9679.516024198621;9688.41869487833;9732.562034708313 05:28:11 INFO - 2015-11-22 05:28:11,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1230 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1448198891789__endTimestamp 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,804 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5864.95 Median:6138.85 stddev:642.73 (10.5%) stddev-sans-first:596.98 05:28:11 INFO - 2015-11-22 05:28:11,806 DEBUG : BROWSER_OUTPUT: Values: 2766.7 3510.9 3513.6 3535.1 3576.0 5545.4 5656.1 5975.9 5979.9 5986.3 5980.3 5992.8 5996.2 6009.8 6011.6 5300.7 5329.9 5363.8 5396.9 5411.1 4672.7 5446.2 5456.2 5457.1 5464.3 5326.2 5436.9 5439.4 5439.8 5441.9 5414.1 5416.1 5430.6 5433.9 5448.8 5249.6 5366.2 5375.2 5402.3 5429.9 5916.9 5955.6 5999.6 6027.1 6027.5 5325.4 6288.5 6292.7 6300.6 6307.3 6140.9 6200.9 6235.4 6237.6 6293.7 5924.8 6133.8 6145.6 6157.1 6161.8 6425.7 6516.5 6539.9 6540.5 6548.7 6103.8 6163.8 6246.7 6268.7 6280.4 6350.4 6351.3 6357.6 6364.3 6396.9 6235.4 6270.6 6303.8 6305.2 6308.0 6132.0 6169.1 6252.4 6288.4 6299.8 5099.4 5107.7 5110.6 5114.9 5128.3 4132.7 4580.8 4593.8 4611.3 4625.7 5815.9 5917.3 5970.5 5991.1 6044.8 6282.2 6284.3 6287.3 6301.7 6315.8 4975.6 5892.6 5956.5 5969.8 6042.9 5570.7 5580.8 5590.7 5591.5 5593.9 6148.2 6335.6 6337.2 6337.7 6362.4 6282.7 6286.2 6286.5 6292.4 6301.5 6221.3 6233.0 6287.9 6306.6 6309.4 6223.0 6223.3 6231.3 6241.7 6288.1 6204.0 6289.5 6290.4 6292.9 6313.2 6132.9 6268.3 6269.3 6274.3 6303.1 5424.9 5899.0 6259.9 6270.7 6280.5 5979.7 6092.7 6121.2 6138.8 6141.9 6123.5 6248.3 6271.3 6288.5 6304.7 6221.1 6222.4 6227.4 6230.0 6236.1 05:28:11 INFO - 2015-11-22 05:28:11,806 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,806 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66367.12 Median:36713.73 stddev:137145.84 (373.6%) stddev-sans-first:137441.53 05:28:11 INFO - 2015-11-22 05:28:11,806 DEBUG : BROWSER_OUTPUT: Values: 546.0 566.6 569.4 570.7 633.8 31737.0 41180.4 41304.6 41330.0 41493.8 43643.8 44043.0 44057.6 44093.8 44111.9 8625.4 8736.1 9675.1 9846.3 9869.0 8664.1 8755.8 8756.1 8758.6 11915.3 11699.9 11757.4 11773.5 11790.5 11797.2 11710.9 11769.0 11782.9 11790.7 11879.2 8762.7 8888.4 11654.4 11659.8 11880.9 39768.0 40080.0 40103.0 40120.0 40131.4 3233.8 3324.2 3362.6 3406.1 3608.5 29023.0 29126.4 29129.7 29451.1 30052.4 2810.1 2836.9 2886.1 2918.8 2976.9 485641.0 486381.0 486826.6 488633.0 490621.5 60110.7 61053.0 61088.8 68431.0 74878.0 54172.7 69401.6 70465.0 70498.6 70515.6 16611.3 16804.7 16819.3 16827.3 16862.9 10805.9 12690.9 12752.3 12758.9 12909.6 21919.8 22211.3 22251.8 22270.4 22284.4 9083.6 9271.7 9279.4 9282.3 9292.5 938.4 945.6 1017.5 1052.6 1141.6 22033.7 29484.7 29593.0 30028.7 30417.8 1093.9 1096.6 1113.8 1121.3 1123.6 14377.4 15147.4 15278.0 15534.0 15615.1 550017.0 555909.2 556336.0 556815.0 558025.0 59779.8 59949.4 59993.7 60118.7 60232.0 1407.2 1417.6 1434.4 1439.3 1442.9 27310.7 27538.7 29759.9 29782.0 29975.9 52984.7 53132.0 53182.7 53408.7 53425.5 497523.0 502132.0 503066.0 503141.0 503320.0 28043.6 28331.2 28464.7 33383.0 33890.5 40845.4 44372.0 45449.5 45565.5 45707.5 32840.0 36523.8 36903.6 37186.6 37708.6 37391.8 37634.8 37687.1 37773.6 38813.4 31259.4 31692.0 36070.0 37855.6 38153.0 27470.0 28982.4 32587.2 41685.4 42038.4 30500.1 31126.7 31493.2 31693.0 32665.2 05:28:11 INFO - 2015-11-22 05:28:11,806 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,806 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:40320.72 Median:27150.89 stddev:129016.44 (475.2%) stddev-sans-first:129343.43 05:28:11 INFO - 2015-11-22 05:28:11,808 DEBUG : BROWSER_OUTPUT: Values: 342.6 344.7 362.0 362.3 362.5 16471.4 17848.9 20124.7 21140.6 22236.8 21546.6 21619.7 22003.3 22046.9 22062.7 6563.3 6758.9 6761.8 6766.8 6771.6 4602.2 6645.2 6948.6 7460.5 7462.2 7248.1 7349.4 7417.7 7456.5 7493.2 7374.3 7415.0 7420.6 7433.9 7441.3 6892.8 7054.9 7063.6 7083.3 7089.0 20633.5 24454.9 26872.6 27429.2 27438.0 2040.6 2063.1 2088.8 2174.3 2214.6 9842.4 10025.6 10055.7 10085.3 13881.8 1738.5 1748.4 1753.5 1766.3 1772.8 104585.0 108834.5 109008.0 110090.0 111724.0 10897.7 10977.8 10992.7 11028.8 11058.2 11928.6 12421.6 13128.9 13172.3 13176.8 8082.4 8168.4 8312.8 8319.1 8326.8 6656.9 8447.9 8459.5 8527.4 8537.7 3945.9 4109.3 4248.6 4301.0 4307.8 1465.0 1771.0 1806.2 1814.3 1829.3 913.8 914.3 971.2 1045.6 1085.3 21088.0 21466.9 22399.3 22626.5 22854.9 756.3 825.9 955.7 972.7 1025.7 5997.7 6092.9 6154.7 6195.0 6234.0 779618.0 779838.0 779881.0 781291.0 796070.0 113945.0 118564.0 124383.0 130502.0 131387.3 486.9 492.3 493.5 493.7 494.1 11465.5 11582.2 11600.4 11643.9 11658.8 52059.0 54623.2 55145.0 56079.0 56116.0 72875.0 76602.6 78987.0 79180.0 82484.6 9433.6 9579.9 9774.4 9779.7 10015.3 19402.1 19473.6 19657.4 20098.4 20165.2 15876.4 16075.2 16179.3 16188.4 16210.1 14786.2 15228.0 15433.6 16013.7 16088.4 13209.0 14412.9 16397.7 16458.9 16827.0 9540.7 9861.5 9863.6 9960.0 10000.6 8446.3 10125.0 10180.5 10812.5 16162.7 05:28:11 INFO - 2015-11-22 05:28:11,808 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,808 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5838.94 Median:6447.08 stddev:3046.92 (47.3%) stddev-sans-first:3037.20 05:28:11 INFO - 2015-11-22 05:28:11,809 DEBUG : BROWSER_OUTPUT: Values: 1401.1 1576.3 1576.8 1880.4 2028.2 7547.0 7945.2 8463.3 8607.5 8622.1 8366.9 8492.5 8535.0 8545.6 8548.5 2106.3 2165.5 2365.9 2386.3 2389.4 2385.5 2428.1 2432.4 2432.9 2435.5 2336.0 2383.9 2385.1 2388.7 2389.5 2101.6 2139.7 2157.9 2325.2 2368.2 2387.0 2389.0 2391.6 2392.2 2398.1 8403.4 8478.9 8492.7 8507.7 8514.6 5136.9 5160.5 5218.6 5222.4 5251.4 3517.5 3572.1 3596.5 3613.9 3624.2 976.0 1008.1 1040.8 1076.3 1081.4 11304.3 11315.6 11336.9 11337.9 11338.8 4589.3 4700.3 4709.3 4714.1 4747.8 9825.8 9833.0 9840.9 9844.2 9846.3 5259.2 5262.3 5293.9 5298.9 5305.0 4763.6 4790.7 4812.1 4825.7 4831.2 3835.7 3851.4 3852.0 3875.4 3879.7 1279.4 1280.3 1281.9 1291.0 1295.4 1366.6 1367.8 1404.2 1409.0 1412.0 7812.6 7976.8 7977.9 7978.1 7985.6 497.4 507.1 511.1 511.6 512.3 5763.3 5929.5 5944.8 6284.8 6389.9 9645.6 9652.1 9829.0 9870.0 9983.0 9755.4 9835.6 9857.0 9861.0 9882.4 7556.6 7581.5 7766.0 7781.9 7782.6 7819.5 7865.3 7877.8 7895.5 7901.8 8986.3 9045.8 9096.7 9258.4 9277.7 9353.8 9354.9 9365.3 9381.7 9516.2 7258.1 7328.5 7338.4 7340.0 7385.4 7036.6 7939.8 8035.8 8047.6 8105.0 7507.2 7523.8 7566.2 7676.7 7717.4 7252.4 7391.4 7425.3 7474.7 7542.8 6139.4 7508.6 7540.9 7565.5 7571.8 6868.9 6915.3 6917.3 6922.2 6924.3 6364.7 6504.3 6658.2 6967.8 7027.1 05:28:11 INFO - 2015-11-22 05:28:11,809 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,809 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5965.38 Median:6810.69 stddev:1934.64 (28.4%) stddev-sans-first:1893.10 05:28:11 INFO - 2015-11-22 05:28:11,810 DEBUG : BROWSER_OUTPUT: Values: 320.6 323.7 329.0 334.0 338.3 5997.7 6517.0 6916.6 6947.8 6955.9 5873.8 6724.0 6865.7 6966.4 6971.6 5165.0 5169.1 5171.2 5173.5 5180.3 4681.7 4752.8 4880.8 5077.9 5085.4 4993.1 5007.6 5015.6 5017.6 5032.8 4801.6 4858.9 4884.1 5000.6 5023.4 3607.5 4148.0 4231.6 4249.9 4254.4 6591.7 6621.7 6626.2 6646.9 6664.2 4923.3 5670.2 5805.3 5947.4 5950.7 7170.6 7287.5 7311.3 7339.0 7353.9 4706.9 4710.3 4712.5 4716.4 4720.1 7624.0 7715.7 7727.3 7828.2 7835.5 4776.0 4777.9 4789.5 4789.9 4790.5 4658.0 4860.4 4873.0 4879.0 4887.7 5885.6 5888.8 5901.3 5903.1 5906.9 7203.5 7424.3 7446.9 7452.9 7469.6 1670.9 1697.7 1697.7 1701.4 1702.6 1064.5 1069.7 1079.0 1088.7 1095.3 6980.0 6987.1 6988.5 6994.5 7000.7 7644.5 7678.0 7687.6 7693.7 7727.9 5702.3 6755.7 6933.9 6943.3 6963.9 3474.5 3922.7 4084.0 4086.2 4093.3 7628.9 7633.1 7654.3 7658.6 7661.2 7691.6 7727.2 7913.9 7924.5 7932.7 7607.8 7737.1 7777.5 7795.6 7804.1 6276.0 7754.7 7781.4 7795.8 7804.5 6308.6 7362.9 7644.0 7644.7 7660.3 7726.6 7729.9 7740.3 7746.5 7752.3 3985.5 4807.2 4811.5 4812.8 4825.3 7041.0 7470.2 7670.3 7739.0 7739.2 6020.6 7323.4 7404.2 7404.4 7418.5 6011.2 7236.3 7408.4 7417.7 7471.5 5959.2 7291.0 7299.0 7303.5 7321.9 7477.0 7499.4 7502.0 7505.8 7513.2 7127.5 7295.5 7303.4 7322.1 7325.4 05:28:11 INFO - 2015-11-22 05:28:11,811 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-22 05:28:11,811 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18801.56 Median:474.62 stddev:26652.89 (5615.6%) stddev-sans-first:26692.93 05:28:11 INFO - 2015-11-22 05:28:11,811 DEBUG : BROWSER_OUTPUT: Values: 681.4 688.8 736.1 739.7 800.1 15061.0 15279.7 15300.6 15325.5 15325.8 14002.6 14131.8 14137.2 14178.1 14223.9 760.4 769.6 770.4 945.8 946.1 958.8 961.5 975.4 977.0 977.8 1005.5 1021.9 1022.7 1023.3 1024.6 803.9 812.9 1000.2 1005.7 1022.0 753.4 755.8 757.5 758.9 759.0 15131.5 15264.5 15278.0 15279.8 15342.7 12539.2 12770.4 12947.9 13041.7 13194.0 10109.4 10280.8 10364.7 11074.6 11118.8 3502.1 3526.5 3546.1 3547.3 3621.0 78311.6 78422.2 79090.0 79185.0 79910.8 9783.6 9804.2 9905.0 10009.9 10378.7 22555.5 22784.3 22807.3 22813.8 22825.7 7495.3 7652.5 7763.1 7840.5 7858.0 4038.9 4088.0 4099.5 4104.2 4107.0 3676.0 3703.6 3716.8 3717.7 3727.3 696.7 711.8 730.9 731.8 741.9 468.6 480.6 489.5 503.4 513.7 6589.3 8456.6 8512.1 8700.8 8792.3 491.6 499.7 513.8 529.8 543.2 3743.0 3854.7 3938.4 4035.2 4195.6 99587.0 99789.0 101065.5 101435.0 101760.5 78958.2 79144.2 80614.0 80648.2 82020.0 69925.7 70995.6 71399.9 71509.6 71921.0 7152.4 8560.7 8620.7 8634.4 8773.6 49506.3 49939.8 50223.2 50590.0 51575.0 64841.7 71324.9 72513.0 73173.3 73188.3 10665.7 10762.4 11157.7 11171.4 11278.5 11763.9 11865.4 11959.1 12262.9 12288.4 11132.4 11196.2 11254.0 11417.6 11499.1 11571.1 11616.5 11695.5 11706.8 11837.0 11057.3 11301.3 11375.7 11414.6 11416.9 9691.8 9812.9 9878.5 10087.6 10120.1 9597.8 9628.6 9679.5 9688.4 9732.6 05:28:11 INFO - 2015-11-22 05:28:11,811 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:28:11 INFO - 2015-11-22 05:28:11,811 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-22 05:28:12,213 INFO : Browser exited with error code: 0 05:28:12 INFO - 2015-11-22 05:28:12,237 INFO : Completed test dromaeo_css (00:18:34) 05:28:12 INFO - 2015-11-22 05:28:12,237 INFO : Starting test kraken 05:28:12 INFO - 2015-11-22 05:28:12,237 DEBUG : operating with platform_type : mac_ 05:28:12 INFO - 2015-11-22 05:28:12,237 INFO : Initialising browser for kraken test... 05:28:12 INFO - 2015-11-22 05:28:12,249 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpDw6OGa/profile http://localhost:49273/getInfo.html 05:28:14 INFO - 2015-11-22 05:28:14,380 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:28:14 INFO - 2015-11-22 05:28:14,380 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:28:14 INFO - 2015-11-22 05:28:14,380 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:28:14 INFO - 2015-11-22 05:28:14,380 DEBUG : BROWSER_OUTPUT: __metrics 05:28:14 INFO - 2015-11-22 05:28:14,397 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:15 INFO - 2015-11-22 05:28:15,029 INFO : Browser initialized. 05:28:15 INFO - 2015-11-22 05:28:15,030 INFO : Running cycle 1/1 for kraken test... 05:28:15 INFO - 2015-11-22 05:28:15,030 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpDw6OGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:28:26 INFO - 2015-11-22 05:28:26,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 226271232 05:28:26 INFO - 2015-11-22 05:28:26,948 DEBUG : BROWSER_OUTPUT: 05:28:29 INFO - 2015-11-22 05:28:29,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:30 INFO - 2015-11-22 05:28:30,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 275042304 05:28:30 INFO - 2015-11-22 05:28:30,181 DEBUG : BROWSER_OUTPUT: 05:28:32 INFO - 2015-11-22 05:28:32,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 05:28:33 INFO - 2015-11-22 05:28:33,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 289624064 05:28:33 INFO - 2015-11-22 05:28:33,318 DEBUG : BROWSER_OUTPUT: 05:28:36 INFO - 2015-11-22 05:28:36,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 05:28:37 INFO - 2015-11-22 05:28:37,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 276451328 05:28:37 INFO - 2015-11-22 05:28:37,105 DEBUG : BROWSER_OUTPUT: 05:28:39 INFO - 2015-11-22 05:28:39,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 05:28:39 INFO - 2015-11-22 05:28:39,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 278913024 05:28:39 INFO - 2015-11-22 05:28:39,600 DEBUG : BROWSER_OUTPUT: 05:28:41 INFO - 2015-11-22 05:28:41,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:42 INFO - 2015-11-22 05:28:42,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 278863872 05:28:42 INFO - 2015-11-22 05:28:42,238 DEBUG : BROWSER_OUTPUT: 05:28:45 INFO - 2015-11-22 05:28:45,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:45 INFO - 2015-11-22 05:28:45,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 280788992 05:28:45 INFO - 2015-11-22 05:28:45,664 DEBUG : BROWSER_OUTPUT: 05:28:48 INFO - 2015-11-22 05:28:48,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:49 INFO - 2015-11-22 05:28:49,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 280678400 05:28:49 INFO - 2015-11-22 05:28:49,056 DEBUG : BROWSER_OUTPUT: 05:28:51 INFO - 2015-11-22 05:28:51,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 05:28:52 INFO - 2015-11-22 05:28:52,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 280899584 05:28:52 INFO - 2015-11-22 05:28:52,326 DEBUG : BROWSER_OUTPUT: 05:28:53 INFO - 2015-11-22 05:28:53,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:54 INFO - 2015-11-22 05:28:54,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 313667584 05:28:54 INFO - 2015-11-22 05:28:54,422 DEBUG : BROWSER_OUTPUT: 05:28:56 INFO - 2015-11-22 05:28:56,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:56 INFO - 2015-11-22 05:28:56,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 315326464 05:28:56 INFO - 2015-11-22 05:28:56,823 DEBUG : BROWSER_OUTPUT: 05:28:58 INFO - 2015-11-22 05:28:58,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:59 INFO - 2015-11-22 05:28:59,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 323874816 05:28:59 INFO - 2015-11-22 05:28:59,426 DEBUG : BROWSER_OUTPUT: 05:29:01 INFO - 2015-11-22 05:29:01,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:02 INFO - 2015-11-22 05:29:02,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 324423680 05:29:02 INFO - 2015-11-22 05:29:02,579 DEBUG : BROWSER_OUTPUT: 05:29:05 INFO - 2015-11-22 05:29:05,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:05 INFO - 2015-11-22 05:29:05,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 325222400 05:29:05 INFO - 2015-11-22 05:29:05,779 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 05:29:07 INFO - 2015-11-22 05:29:07,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 383709184 05:29:07 INFO - 2015-11-22 05:29:07,691 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,691 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:07 INFO - 2015-11-22 05:29:07,691 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:07 INFO - 2015-11-22 05:29:07,691 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |0;ai-astar;146;158;114;110;110;109;99;110;110;103 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;144;140;154;117;141;137;117;157;117 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;180;183;184;183;184;183;182;182;182 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |3;audio-fft;68;64;77;71;54;60;75;92;71;54 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;84;114;74;74;74;110;74;75;137 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;88;88;130;131;88;88;89;87;88 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;95;94;95;95;94;101;95;95;95 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;86;83;86;86;85;84;85;84;84 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;55;54;54;53;56;54;64;53;54 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;63;63;66;66;68;66;67;68;69 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;81;81;79;80;83;81;81;83;82 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;125;120;124;126;127;132;121;121;130 05:29:07 INFO - 2015-11-22 05:29:07,692 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;126;139;171;172;138;139;139;133;163 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;65;67;65;66;65;66;65;67;66 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1071 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: __startTimestamp1448198947686__endTimestamp 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.90 Median:112.00 stddev:19.18 (17.1%) stddev-sans-first:17.21 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: Values: 146.0 158.0 114.0 110.0 110.0 109.0 99.0 110.0 110.0 103.0 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,693 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.70 Median:142.50 stddev:17.03 (12.0%) stddev-sans-first:15.63 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: Values: 163.0 144.0 140.0 154.0 117.0 141.0 137.0 117.0 157.0 117.0 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.25 (0.7%) stddev-sans-first:1.24 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: Values: 184.0 180.0 183.0 184.0 183.0 184.0 183.0 182.0 182.0 182.0 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:68.60 Median:71.00 stddev:11.51 (16.2%) stddev-sans-first:12.21 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: Values: 68.0 64.0 77.0 71.0 54.0 60.0 75.0 92.0 71.0 54.0 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:90.00 Median:74.00 stddev:22.38 (30.2%) stddev-sans-first:23.63 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 114.0 74.0 74.0 74.0 110.0 74.0 75.0 137.0 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:88.00 stddev:17.98 (20.4%) stddev-sans-first:18.75 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 88.0 130.0 131.0 88.0 88.0 89.0 87.0 88.0 05:29:07 INFO - 2015-11-22 05:29:07,694 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:2.06 (2.2%) stddev-sans-first:2.13 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 94.0 95.0 95.0 94.0 101.0 95.0 95.0 95.0 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 83.0 86.0 86.0 85.0 84.0 85.0 84.0 84.0 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:3.27 (6.0%) stddev-sans-first:3.42 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: Values: 57.0 55.0 54.0 54.0 53.0 56.0 54.0 64.0 53.0 54.0 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.50 stddev:2.02 (3.0%) stddev-sans-first:2.11 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: Values: 65.0 63.0 63.0 66.0 66.0 68.0 66.0 67.0 68.0 69.0 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:1.81 (2.2%) stddev-sans-first:1.30 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 81.0 79.0 80.0 83.0 81.0 81.0 83.0 82.0 05:29:07 INFO - 2015-11-22 05:29:07,695 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.50 stddev:4.02 (3.2%) stddev-sans-first:4.14 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: Values: 122.0 125.0 120.0 124.0 126.0 127.0 132.0 121.0 121.0 130.0 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:139.00 stddev:16.39 (11.8%) stddev-sans-first:17.20 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: Values: 139.0 126.0 139.0 171.0 172.0 138.0 139.0 139.0 133.0 163.0 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:0.83 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 67.0 65.0 66.0 65.0 66.0 65.0 67.0 66.0 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:07 INFO - 2015-11-22 05:29:07,696 DEBUG : BROWSER_OUTPUT: 05:29:08 INFO - 2015-11-22 05:29:08,313 INFO : Browser exited with error code: 0 05:29:08 INFO - 2015-11-22 05:29:08,360 INFO : Completed test kraken (00:00:56) 05:29:08 INFO - 2015-11-22 05:29:08,360 INFO : Starting test v8_7 05:29:08 INFO - 2015-11-22 05:29:08,360 DEBUG : operating with platform_type : mac_ 05:29:08 INFO - 2015-11-22 05:29:08,361 INFO : Initialising browser for v8_7 test... 05:29:08 INFO - 2015-11-22 05:29:08,374 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpHGMBiX/profile http://localhost:49273/getInfo.html 05:29:10 INFO - 2015-11-22 05:29:10,443 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:29:10 INFO - 2015-11-22 05:29:10,443 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:29:10 INFO - 2015-11-22 05:29:10,443 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:29:10 INFO - 2015-11-22 05:29:10,443 DEBUG : BROWSER_OUTPUT: __metrics 05:29:10 INFO - 2015-11-22 05:29:10,460 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:11 INFO - 2015-11-22 05:29:11,132 INFO : Browser initialized. 05:29:11 INFO - 2015-11-22 05:29:11,132 INFO : Running cycle 1/1 for v8_7 test... 05:29:11 INFO - 2015-11-22 05:29:11,132 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpHGMBiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:29:22 INFO - 2015-11-22 05:29:22,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 225976320 05:29:22 INFO - 2015-11-22 05:29:22,915 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/v8_7/run.html (next: http://localhost:49273/tests/v8_7/run.html) 05:29:44 INFO - 2015-11-22 05:29:44,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 689901568 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: |0;Richards;148.25796886582654 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.21231662098984 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.326369282891 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4803.827751196172 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1881.578947368421 05:29:44 INFO - 2015-11-22 05:29:44,674 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: |6;Boyer;13210.526315789473 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: |7;RegExp;27081.08108108108 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: |8;Splay;664.6903820816864 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: __startTimestamp1448198984671__endTimestamp 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.26 Median:148.26 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: Values: 148.3 05:29:44 INFO - 2015-11-22 05:29:44,675 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.21 Median:161.21 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: Values: 161.2 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.33 Median:282.33 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: Values: 282.3 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4803.83 Median:4803.83 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: Values: 4803.8 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1881.58 Median:1881.58 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: Values: 1881.6 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,676 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: Values: 784.9 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13210.53 Median:13210.53 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: Values: 13210.5 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27081.08 Median:27081.08 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: Values: 27081.1 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:664.69 Median:664.69 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: Values: 664.7 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 05:29:44 INFO - 2015-11-22 05:29:44,677 DEBUG : BROWSER_OUTPUT: Values: 4513.5 05:29:44 INFO - 2015-11-22 05:29:44,678 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:44 INFO - 2015-11-22 05:29:44,678 DEBUG : BROWSER_OUTPUT: 05:29:45 INFO - 2015-11-22 05:29:45,321 INFO : Browser exited with error code: 0 05:29:45 INFO - 2015-11-22 05:29:45,340 INFO : Completed test v8_7 (00:00:36) 05:29:45 INFO - 2015-11-22 05:29:45,690 INFO : Completed test suite (00:20:07) 05:29:45 INFO - 2015-11-22 05:29:45,690 DEBUG : Working with test: dromaeo_css 05:29:45 INFO - 2015-11-22 05:29:45,690 DEBUG : Generating results file: dromaeo_css 05:29:45 INFO - 2015-11-22 05:29:45,691 DEBUG : Working with test: kraken 05:29:45 INFO - 2015-11-22 05:29:45,691 DEBUG : Generating results file: kraken 05:29:45 INFO - 2015-11-22 05:29:45,691 INFO : javascript benchmark 05:29:45 INFO - 2015-11-22 05:29:45,691 DEBUG : Working with test: v8_7 05:29:45 INFO - 2015-11-22 05:29:45,691 DEBUG : Generating results file: v8_7 05:29:45 INFO - 2015-11-22 05:29:45,691 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:46 INFO - 2015-11-22 05:29:46,071 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 05:29:46 INFO - 2015-11-22 05:29:46,072 DEBUG : process_Request line: dromaeo_css 7678.90 graph.html#tests=[[72,1,59]] 05:29:46 INFO - 2015-11-22 05:29:46,072 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:46 INFO - 2015-11-22 05:29:46,099 DEBUG : process_Request line: kraken 1411.90 graph.html#tests=[[232,1,59]] 05:29:46 INFO - 2015-11-22 05:29:46,099 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:46 INFO - 2015-11-22 05:29:46,222 DEBUG : process_Request line: v8_7 20342.27 graph.html#tests=[[230,1,59]] 05:29:46 INFO - 2015-11-22 05:29:46,222 INFO : javascript benchmark 05:29:46 INFO - 2015-11-22 05:29:46,224 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2766.6541682289712, 3510.8595656173748, 3513.648635136485, 3535.0808789714665, 3576.0, 5545.3622833374175, 5656.066748986413, 5975.910361344578, 5979.910301345483, 5986.281646202457, 5980.31226408962, 5992.760289588422, 5996.190514280571, 6009.849753756147, 6011.609245399046, 5300.681959082458, 5329.866753331159, 5363.839084827461, 5396.91904621431, 5411.134218525037, 4672.6916463390135, 5446.210299506569, 5456.154296084113, 5457.099578569531, 5464.316960379952, 5326.174442961347, 5436.91844622331, 5439.401665816757, 5439.755211015494, 5441.863953401157, 5414.10667239905, 5416.052190866602, 5430.59270554706, 5433.918491222635, 5448.83653490396, 5249.606279529051, 5366.168243922199, 5375.16684913839, 5402.270693456372, 5429.891402171974, 5916.940830591682, 5955.642661440284, 5999.610025348338, 6027.065804800263, 6027.5177985761475, 5325.440828712968, 6288.52836037299, 6292.653904035276, 6300.621962682254, 6307.274663413675, 6140.9030504681, 6200.937990620081, 6235.376462353774, 6237.594556353823, 6293.685315734195, 5924.793396688357, 6133.84665383369, 6145.631262124287, 6157.107219453154, 6161.8459538511, 6425.710843012076, 6516.511261655395, 6539.934600654028, 6540.509461790385, 6548.738050477928, 6103.755849766048, 6163.8150855474405, 6246.718897649616, 6268.717907694165, 6280.403361680633, 6350.428461438492, 6351.269603995507, 6357.554971152067, 6364.299927008025, 6396.904046439307, 6235.438810507076, 6270.623762574261, 6303.842403939847, 6305.243370795534, 6308.0, 6131.950716841428, 6169.105479705418, 6252.406021427957, 6288.371162883675, 6299.779507717208, 5099.413567439792, 5107.668001579886, 5110.642255042186, 5114.897702045938, 5128.307678463434, 4132.710710250253, 4580.770961451914, 4593.839215627437, 4611.33135695329, 4625.699329543569, 5815.883682326415, 5917.349091599921, 5970.462658360769, 5991.131285963598, 6044.8186554402555, 6282.183316168869, 6284.340144284875, 6287.276963149205, 6301.684915754194, 6315.778947736899, 4975.577075948512, 5892.587518873637, 5956.52347812174, 5969.76120955157, 6042.879142417215, 5570.6657600544095, 5580.804671836548, 5590.692511911802, 5591.4688104629995, 5593.860153496195, 6148.200733904564, 6335.556511044183, 6337.176167098248, 6337.651429171347, 6362.395572420613, 6282.717277722422, 6286.245650521967, 6286.465650419766, 6292.370762923854, 6301.464375528131, 6221.2845522765465, 6233.0338797486465, 6287.905681414691, 6306.590071645328, 6309.400606942333, 6223.0, 6223.253209614694, 6231.314555398993, 6241.687915604292, 6288.088227207121, 6204.038374051848, 6289.465395441439, 6290.370962903673, 6292.937070629235, 6313.2424109107205, 6132.8773424532155, 6268.341824108403, 6269.31037585856, 6274.341194174546, 6303.149074875017, 5424.860779236405, 5898.970505147447, 6259.937400625936, 6270.7491700331475, 6280.5289603279025, 5979.701014949148, 6092.725827337869, 6121.173641558333, 6138.846528836815, 6141.877162456815, 6123.510119190365, 6248.250209974832, 6271.3415091414745, 6288.465480434214, 6304.65324407162, 6221.129041934042, 6222.377762223741, 6227.377262273736, 6230.034344676583, 6236.064590311489], "unit": "ms", "name": "dojo.html", "value": 5824.453413934092}, {"lowerIsBetter": false, "replicates": [545.97629444791, 566.6486778197514, 569.3992837556377, 570.6946783470842, 633.7528363938065, 31737.047888563353, 41180.382294265575, 41304.58695413045, 41330.0, 41493.75518734439, 43643.78178109113, 44043.0, 44057.55942440574, 44093.7795311023, 44111.897202569955, 8625.396222264413, 8736.082711315315, 9675.129238368545, 9846.261530385214, 9869.0, 8664.0902705216, 8755.781105472382, 8756.124387561256, 8758.649654013832, 11915.285082895054, 11699.883001170007, 11757.412129393539, 11773.52905883768, 11790.469428875722, 11797.174197806156, 11710.887465690788, 11769.0, 11782.88217117835, 11790.705232369259, 11879.168458207929, 8762.737117886474, 8888.422252553562, 11654.359010254433, 11659.766804663945, 11880.940595297054, 39768.0, 40079.99800004994, 40103.0, 40120.0, 40131.39802902959, 3233.757468189872, 3324.2354258520436, 3362.596488421405, 3406.0803583032443, 3608.458731190316, 29023.0, 29126.41747165066, 29129.70870291291, 29451.11646650604, 30052.398952021056, 2810.0726760169096, 2836.9432611347866, 2886.07645553423, 2918.8394638294885, 2976.925576860574, 485641.0, 486381.0, 486826.5658671719, 488633.0, 490621.54689226684, 60110.699446503364, 61053.0, 61088.778224435264, 68431.0, 74878.0, 54172.729136354064, 69401.61196776036, 70465.0, 70498.64750676214, 70515.64742176257, 16611.335546578244, 16804.6639067218, 16819.32722691103, 16827.32690692383, 16862.90391124573, 10805.945970270099, 12690.873091269154, 12752.298623575607, 12758.9362053191, 12909.612711618667, 21919.780802192094, 22211.333659990225, 22251.776152311777, 22270.443238918833, 22284.442888927908, 9083.636654533744, 9271.67549135777, 9279.350445468888, 9282.303827212985, 9292.53537323131, 938.394735395666, 945.6028468043438, 1017.4562602785968, 1052.563186277686, 1141.6004398460639, 22033.669494957587, 29484.705152948194, 29593.0, 30028.69971300303, 30417.847910760305, 1093.905171596384, 1096.5997410944947, 1113.8440618313443, 1121.2711737370773, 1123.5561953028507, 14377.424903003972, 15147.394104235707, 15278.006929549543, 15534.0, 15615.141167235912, 550017.0, 555909.2204538952, 556336.0, 556815.0, 558025.0, 59779.80440391168, 59949.40050599438, 59993.70003150043, 60118.69940650269, 60232.0, 1407.1697698358018, 1417.5888992192356, 1434.390384086759, 1439.2515891736448, 1442.8917831162705, 27310.726892730818, 27538.724612753616, 29759.85120074386, 29782.0, 29975.850120749255, 52984.735076324374, 53132.0, 53182.73408632932, 53408.73295633497, 53425.4657453436, 497523.0, 502132.0, 503066.0, 503141.0, 503320.0, 28043.57934631023, 28331.150065498066, 28464.715352846208, 33383.0, 33890.49164262489, 40845.36618535225, 44372.0, 45449.545504544534, 45565.54434455746, 45707.54292457033, 32840.014799556055, 36523.8329776178, 36903.63096369002, 37186.62813371832, 37708.62291377051, 37391.81304093462, 37634.8118259407, 37687.13634805236, 37773.62226377811, 38813.41779873361, 31259.374812503167, 31692.0, 36070.0, 37855.62144378521, 38153.0, 27470.0, 28982.420351592427, 32587.185320366232, 41685.374719378626, 42038.36942445805, 30500.08499745011, 31126.68873311238, 31493.212669683442, 31693.0, 32665.18337041498], "unit": "ms", "name": "ext.html", "value": 20507.90031666033}, {"lowerIsBetter": false, "replicates": [342.61583203856424, 344.67944811325475, 361.9981900090499, 362.28268029301984, 362.5196614485807, 16471.423500177498, 17848.910755446235, 20124.69812952805, 21140.577188456242, 22236.777632223693, 21546.569068618617, 21619.6757048644, 22003.33989980299, 22046.88976555115, 22062.669059964115, 6563.310852360505, 6758.9324106758795, 6761.763338283161, 6766.7969960901255, 6771.559848609849, 4602.194615942213, 6645.202575690924, 6948.617826019567, 7460.477766556343, 7462.21646727094, 7248.0939882514685, 7349.412047036224, 7417.740379086733, 7456.478046536745, 7493.213212612652, 7374.299441553044, 7414.961905333258, 7420.591867447289, 7433.9256607434045, 7441.293077157661, 6892.758753443655, 7054.92945070553, 7063.6115013674225, 7083.327083927019, 7089.042979197794, 20633.484162895897, 24454.877725611437, 26872.59691104635, 27429.17712468629, 27438.0, 2040.6326861164985, 2063.1128614695676, 2088.822450091744, 2174.3259589527297, 2214.557088582274, 9842.409455432626, 10025.649102281384, 10055.69832905014, 10085.34445261063, 13881.791773123412, 1738.4697667211497, 1748.4492384898717, 1753.5095169106157, 1766.3464518128376, 1772.8493078088377, 104585.0, 108834.45582772115, 109008.0, 110090.0, 111724.0, 10897.67306980792, 10977.83533247002, 10992.725181870357, 11028.779424411467, 11058.22592418539, 11928.582499612645, 12421.571519275218, 13128.934355328161, 13172.341382930816, 13176.802347964789, 8082.353411727047, 8168.428210025241, 8312.83374332522, 8319.084900660922, 8326.750987351945, 6656.8668626627195, 8447.873281900776, 8459.492430454193, 8527.360447966428, 8537.74386768398, 3945.9013524662114, 4109.301418758818, 4248.553901840262, 4301.032267739796, 4307.827686892552, 1464.9780253295996, 1770.97343539847, 1806.2413786209822, 1814.3468351393487, 1829.2561950677582, 913.8218047480677, 914.3279689428265, 971.2133172130597, 1045.5713157605346, 1085.3273048364786, 21088.0, 21466.914112388138, 22399.32802015942, 22626.547469050856, 22854.885725571265, 756.3344257053867, 825.8513467575895, 955.7419496735981, 972.7276362618478, 1025.6769117727893, 5997.7001149942325, 6092.948189454052, 6154.692265386802, 6195.0, 6234.0, 779618.0, 779838.0, 779881.0, 781291.0, 796070.0, 113945.0, 118564.0, 124383.0, 130502.0, 131387.34306328406, 486.86317448757546, 492.2517772985043, 493.4793792548895, 493.7284493528617, 494.12293179606485, 11465.484053217791, 11582.189246752983, 11600.361980091177, 11643.941780291045, 11658.76682466363, 52059.0, 54623.180652289455, 55145.0, 56079.0, 56116.0, 72875.0, 76602.61698691471, 78987.0, 79180.0, 82484.58757706173, 9433.57548910287, 9579.856302155335, 9774.364666296953, 9779.706608801747, 10015.298929074896, 19402.12690428906, 19473.610527789082, 19657.41027769169, 20098.39704808858, 20165.193392264144, 15876.364945402054, 16075.196240188177, 16179.27193276329, 16188.433404830774, 16210.108444035219, 14786.186759728318, 15228.010179338307, 15433.61415964565, 16013.67972640564, 16088.436904708278, 13209.0, 14412.927935360256, 16397.67204655924, 16458.917705411397, 16827.0, 9540.713778586654, 9861.457619830979, 9863.605455781688, 9960.0, 10000.649977250761, 8446.282066024456, 10125.0, 10180.541875615467, 10812.459377031275, 16162.67674646524], "unit": "ms", "name": "jquery.html", "value": 9788.076905303435}, {"lowerIsBetter": false, "replicates": [1401.0612889364124, 1576.3379380660126, 1576.8344323845995, 1880.3982725527828, 2028.1583142995657, 7546.962265188673, 7945.205479452052, 8463.280621147202, 8607.526586037766, 8622.137786221374, 8366.874496882536, 8492.53291068991, 8535.0, 8545.61544730487, 8548.529830859301, 2106.262808017197, 2165.480284731661, 2365.881705914706, 2386.2841147655636, 2389.414593424605, 2385.4632707640817, 2428.0530593068715, 2432.3797431654993, 2432.927012189637, 2435.5250726108416, 2335.9766402336013, 2383.892724827387, 2385.1413491143176, 2388.7491813359607, 2389.474315650554, 2101.6112019276484, 2139.7218361613045, 2157.924472643466, 2325.209428794218, 2368.159303447277, 2386.9522609547885, 2388.9641655375185, 2391.557561851063, 2392.246442370648, 2398.112698301622, 8403.41176117672, 8478.872816907751, 8492.745217643418, 8507.744767656981, 8514.57427128641, 5136.871578210537, 5160.535551800356, 5218.556422704075, 5222.399424066243, 5251.4485978972425, 3517.472379143149, 3572.089117275078, 3596.532450781408, 3613.8915832525067, 3624.2026754114054, 975.9609615615367, 1008.112860682602, 1040.7606250562337, 1076.3057827701168, 1081.3511892864296, 11304.265222760576, 11315.603953861657, 11336.94331528337, 11337.886621133766, 11338.829917551244, 4589.2886602576655, 4700.271457923959, 4709.270063140219, 4714.080754252887, 4747.8100875965265, 9825.803483930282, 9833.0, 9840.901590984142, 9844.212463002943, 9846.310758246997, 5259.21111833228, 5262.342207224097, 5293.920591191135, 5298.867528311823, 5304.992051510278, 4763.618910487153, 4790.688605240718, 4812.109759694467, 4825.710457372569, 4831.178699621073, 3835.6547910688173, 3851.441540976543, 3852.036990752312, 3875.399313106473, 3879.689624830007, 1279.353926267229, 1280.295837289487, 1281.858995510493, 1291.0446269760498, 1295.4494339905502, 1366.6241783509415, 1367.7811550151928, 1404.1996062244627, 1408.978865317021, 1411.978820317696, 7812.57030863308, 7976.800579985431, 7977.880331795028, 7978.0825205102155, 7985.640646170937, 497.3832447764818, 507.0973666872972, 511.1132185657881, 511.6086194061546, 512.3390825834706, 5763.3084029915835, 5929.466348028698, 5944.791932282349, 6284.811455656338, 6389.872202555923, 9645.565949532287, 9652.083052110038, 9829.0, 9870.012998700073, 9983.0, 9755.365901216399, 9835.60657573689, 9856.950715246378, 9860.950695246478, 9882.357646752938, 7556.622168891534, 7581.545107293469, 7766.0, 7781.8832717509285, 7782.571958542221, 7819.545871742569, 7865.252800983897, 7877.842443151219, 7895.486793358414, 7901.762947111596, 8986.281097512314, 9045.819083618422, 9096.7270981868, 9258.444493330422, 9277.67528136512, 9353.766155846159, 9354.877414710278, 9365.250779937453, 9381.671641492516, 9516.238700903772, 7258.056452661121, 7328.523645962995, 7338.376238019615, 7340.0, 7385.446091543263, 7036.612986285803, 7939.761807145795, 8035.758927232192, 8047.597620118853, 8104.98687664042, 7507.174210836913, 7523.849523009619, 7566.24337566239, 7676.692932282646, 7717.382609391123, 7252.38354739853, 7391.40868730511, 7425.257474252748, 7474.663640136316, 7542.773716788505, 6139.447449729546, 7508.587027713528, 7540.924590754023, 7565.546067235983, 7571.848563028819, 6868.862622747617, 6915.308469153045, 6917.342852429011, 6922.203946546211, 6924.3421874921805, 6364.713587888648, 6504.284528701934, 6658.234303055211, 6967.79096627102, 7027.086478757728], "unit": "ms", "name": "mootools.html", "value": 4707.447116232976}, {"lowerIsBetter": false, "replicates": [320.60725611126367, 323.6747069195458, 329.0474077545506, 333.9565856438664, 338.2879039621595, 5997.730102145403, 6517.0, 6916.619585922772, 6947.826304342394, 6955.930440695592, 5873.794417195399, 6723.957786543094, 6865.6567171641345, 6966.442684585234, 6971.6165610891385, 5165.04446677364, 5169.105301031415, 5171.17261238202, 5173.5085166909275, 5180.300659410969, 4681.695689780154, 4752.764281286855, 4880.755962201875, 5077.949220507785, 5085.364329458817, 4993.076280888047, 5007.649464537484, 5015.5987520998415, 5017.573506251973, 5032.773525191357, 4801.615870730333, 4858.902821943577, 4884.145274576935, 5000.649954503187, 5023.3971923369245, 3607.549056367954, 4147.979260103711, 4231.597998190167, 4249.893752656209, 4254.3831144483875, 6591.71461564995, 6621.702023408958, 6626.171728533934, 6646.93353066468, 6664.233613134455, 4923.335349727777, 5670.177824215507, 5805.303363596353, 5947.405259474018, 5950.702464876782, 7170.641467926635, 7287.489875708702, 7311.341979221896, 7339.045924029842, 7353.926460735378, 4706.905861882778, 4710.3405523226775, 4712.458067322267, 4716.410448693913, 4720.12677654635, 7624.0, 7715.6913723451, 7727.265909738566, 7828.21717828224, 7835.529868207926, 4775.976120119447, 4777.856664300077, 4789.473157952622, 4789.880252993633, 4790.473047964721, 4657.998530315998, 4860.416749990024, 4872.975635121873, 4878.975605121952, 4887.65786394956, 5885.61743486672, 5888.793892213752, 5901.262342207224, 5903.085021821625, 5906.911396329058, 7203.459740519377, 7424.331810137113, 7446.888296675555, 7452.85094298111, 7469.589172595451, 1670.949871503857, 1697.6604679064237, 1697.6859281033048, 1701.4470297153227, 1702.5743564108973, 1064.4837253931837, 1069.7218723132041, 1078.9568417263379, 1088.6679562733443, 1095.2990086344746, 6980.0, 6987.091678081919, 6988.475864310197, 6994.475414343945, 7000.684969176399, 7644.541327520366, 7678.040244969379, 7687.6156192190165, 7693.6922523099565, 7727.92272077272, 5702.258706368146, 6755.729770809211, 6933.861322773617, 6943.305669433117, 6963.9303606963285, 3474.4788281757938, 3922.7450215736458, 4083.959160408417, 4086.1623367210245, 4093.3041382964966, 7628.8855667165035, 7633.099422219521, 7654.311111999947, 7658.578778167142, 7661.233876612406, 7691.615419229016, 7727.222738770114, 7913.920860791433, 7924.524528528307, 7932.682692692343, 7607.809804754926, 7737.148913619498, 7777.455578109591, 7795.649195786316, 7804.058950230097, 6275.96862015687, 7754.6898124074405, 7781.37748980069, 7795.766127016199, 7804.453688241769, 6308.589941653778, 7362.926370736438, 7644.006279183671, 7644.655990480331, 7660.2722741339485, 7726.575038372944, 7729.9227007729205, 7740.26467485588, 7746.49647772893, 7752.341051010727, 3985.5416627087097, 4807.158747219292, 4811.4707382188635, 4812.759362031955, 4825.252085926687, 7040.964795175992, 7470.215627359266, 7670.348020418327, 7739.0, 7739.187385324685, 6020.608660437058, 7323.414126869731, 7404.222556631692, 7404.407647388089, 7418.517796343221, 6011.218541589566, 7236.34872861445, 7408.407327413902, 7417.703291868481, 7471.476996610185, 5959.165716799738, 7290.9635451822405, 7298.96350518244, 7303.488755787044, 7321.853562928818, 7476.962615186889, 7499.437542184249, 7502.0, 7505.774826755206, 7513.173550909286, 7127.501074924913, 7295.52579082358, 7303.379212766974, 7322.121345438582, 7325.377342925911], "unit": "ms", "name": "prototype.html", "value": 5314.0330159348405}, {"lowerIsBetter": false, "replicates": [681.4241965539119, 688.7899190746821, 736.1276886889034, 739.6634531288264, 800.0918956983821, 15061.0, 15279.69440611187, 15300.617484562878, 15325.54023379299, 15325.846741532581, 14002.649933751662, 14131.788023179635, 14137.151770893754, 14178.0784249024, 14223.92888035561, 760.4030835793903, 769.634423648768, 770.3913908012663, 945.7588314979705, 946.1437399153776, 958.8130314588658, 961.500019989605, 975.3611384543135, 977.008336538414, 977.8142152990908, 1005.5475036233687, 1021.8773747150352, 1022.698304000318, 1023.2837014090129, 1024.605526872152, 803.8874557561917, 812.8943237379162, 1000.1698590170141, 1005.71839884832, 1022.0392830739081, 753.3634079203065, 755.7581573896356, 757.4546326644806, 758.8596109719664, 759.0132827324456, 15131.54605361841, 15264.465743698916, 15278.006929549654, 15279.847201527953, 15342.693146137015, 12539.24764514132, 12770.425330860133, 12947.870521294855, 13041.739165216737, 13194.010449216346, 10109.39343639384, 10280.79438411235, 10364.740881477948, 11074.557017719282, 11118.776934537194, 3502.124468882779, 3526.4710293455933, 3546.0992907801624, 3547.290541891632, 3621.004223838439, 78311.60844195743, 78422.21577784207, 79090.0, 79185.0, 79910.80133797998, 9783.608655653836, 9804.166645835041, 9905.0, 10009.949950250202, 10378.688639340831, 22555.548889022128, 22784.31647050591, 22807.315780526278, 22813.771862281497, 22825.657615135788, 7495.287947644965, 7652.540847549165, 7763.146053934176, 7840.490368126054, 7857.960710196412, 4038.8788336349958, 4087.9591204088174, 4099.528554216244, 4104.220198162339, 4107.0, 3676.0, 3703.5555733311635, 3716.832742526593, 3717.7211709121925, 3727.3290807654885, 696.715413587931, 711.836277656142, 730.937870281032, 731.7925423052006, 741.9427316074572, 468.6016885647173, 480.6395203597302, 489.48848453366315, 503.3858692395272, 513.6789506558401, 6589.341065893373, 8456.577171141542, 8512.148785121439, 8700.78248043804, 8792.252658523968, 491.5698763581866, 499.71516235746003, 513.8407093800934, 529.8172130614931, 543.2313276713485, 3742.9519734474393, 3854.71089668276, 3938.4289278055094, 4035.233305671913, 4195.58044195578, 99587.0, 99789.0, 101065.49467252617, 101435.0, 101760.49119754354, 78958.21041789623, 79144.20855791484, 80614.0, 80648.19351806524, 82020.0, 69925.65037174884, 70995.64502177456, 71399.92900106503, 71509.64245178741, 71921.0, 7152.392046676091, 8560.743177704679, 8620.698275560326, 8634.395592308478, 8773.56132193375, 49506.25740613822, 49939.75030124826, 50223.24665130099, 50589.98820023505, 51575.0, 64841.67579162263, 71324.93012604711, 72513.0, 73173.26826731878, 73188.26811732027, 10665.733356666145, 10762.3542587445, 11157.721056973316, 11171.38557379352, 11278.548858045586, 11763.941180294043, 11865.406729663655, 11959.103067269816, 12262.87737122653, 12288.38558072075, 11132.443377831238, 11196.24442966734, 11254.0, 11417.60038398652, 11499.080073593925, 11571.074314054687, 11616.477258523219, 11695.473703683185, 11706.76586468283, 11837.0, 11057.281276716987, 11301.321920684784, 11375.658730238107, 11414.600488982845, 11416.94291528537, 9691.757706057406, 9812.901870981199, 9878.50607469638, 10087.646932357333, 10120.089191972758, 9597.808043839224, 9628.566714498005, 9679.516024198621, 9688.41869487833, 9732.562034708313], "unit": "ms", "name": "yui.html", "value": 7009.302134378343}], "name": "dromaeo_css", "value": 7678.902525537022}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [146.0, 158.0, 114.0, 110.0, 110.0, 109.0, 99.0, 110.0, 110.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 116.9}, {"lowerIsBetter": true, "replicates": [163.0, 144.0, 140.0, 154.0, 117.0, 141.0, 137.0, 117.0, 157.0, 117.0], "unit": "ms", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [184.0, 180.0, 183.0, 184.0, 183.0, 184.0, 183.0, 182.0, 182.0, 182.0], "unit": "ms", "name": "audio-dft", "value": 182.7}, {"lowerIsBetter": true, "replicates": [68.0, 64.0, 77.0, 71.0, 54.0, 60.0, 75.0, 92.0, 71.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 114.0, 74.0, 74.0, 74.0, 110.0, 74.0, 75.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 90.0}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 88.0, 130.0, 131.0, 88.0, 88.0, 89.0, 87.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 96.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 101.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-darkroom", "value": 95.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 83.0, 86.0, 86.0, 85.0, 84.0, 85.0, 84.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 84.8}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 54.0, 54.0, 53.0, 56.0, 54.0, 64.0, 53.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 63.0, 66.0, 66.0, 68.0, 66.0, 67.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [77.0, 81.0, 81.0, 79.0, 80.0, 83.0, 81.0, 81.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 120.0, 124.0, 126.0, 127.0, 132.0, 121.0, 121.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [139.0, 126.0, 139.0, 171.0, 172.0, 138.0, 139.0, 139.0, 133.0, 163.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 67.0, 65.0, 66.0, 65.0, 66.0, 65.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1411.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.25796886582654], "unit": "score", "name": "Richards", "value": 238.11198999999996}, {"lowerIsBetter": false, "replicates": [161.21231662098984], "unit": "score", "name": "DeltaBlue", "value": 410.129954}, {"lowerIsBetter": false, "replicates": [282.326369282891], "unit": "score", "name": "Encrypt", "value": 942.813102}, {"lowerIsBetter": false, "replicates": [4803.827751196172], "unit": "score", "name": "Decrypt", "value": 55.41018824701192}, {"lowerIsBetter": false, "replicates": [1881.578947368421], "unit": "score", "name": "RayTrace", "value": 393.2808671328673}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [13210.526315789473], "unit": "score", "name": "Boyer", "value": 50.449390438247015}, {"lowerIsBetter": false, "replicates": [27081.08108108108], "unit": "score", "name": "RegExp", "value": 33.63916666666665}, {"lowerIsBetter": false, "replicates": [664.6903820816864], "unit": "score", "name": "Splay", "value": 122.59993855302281}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 20342.265987936786}]} 05:29:46 INFO - RETURN: dromaeo_css: 7678.90 05:29:46 INFO - RETURN: kraken: 1411.90 05:29:46 INFO - RETURN: v8_7: 20342.27 05:29:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "20342.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1411.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7678.90"}}} 05:29:46 INFO - Return code: 0 05:29:46 INFO - # TBPL SUCCESS # 05:29:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:46 INFO - 2015-11-22 05:29:46.348 screenresolution[1682:10927] starting screenresolution argv=screenresolution get 05:29:46 INFO - 2015-11-22 05:29:46.351 screenresolution[1682:10927] Display 0: 1600x1200x32@60 05:29:46 INFO - 2015-11-22 05:29:46.357 screenresolution[1683:10930] starting screenresolution argv=screenresolution list 05:29:46 INFO - Available Modes on Display 0 05:29:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:46 INFO - Intel Iris: 05:29:46 INFO - Chipset Model: Intel Iris 05:29:46 INFO - Type: GPU 05:29:46 INFO - Bus: Built-In 05:29:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:46 INFO - Vendor: Intel (0x8086) 05:29:46 INFO - Device ID: 0x0a2e 05:29:46 INFO - Revision ID: 0x0009 05:29:46 INFO - Displays: 05:29:46 INFO - Display: 05:29:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:46 INFO - Display Serial Number: 1600x1200 60 05:29:46 INFO - Main Display: Yes 05:29:46 INFO - Mirror: Off 05:29:46 INFO - Online: Yes 05:29:46 INFO - Rotation: Supported 05:29:46 INFO - Return code: 0 05:29:46 INFO - Running post-action listener: _resource_record_post_action 05:29:46 INFO - Running post-run listener: _resource_record_post_run 05:29:47 INFO - Total resource usage - Wall time: 1240s; CPU: 53.0%; Read bytes: 33693184; Write bytes: 693951488; Read time: 355; Write time: 2290 05:29:47 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334535168; Write bytes: 338757632; Read time: 25994; Write time: 653 05:29:47 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 32767488; Write bytes: 344585216; Read time: 341; Write time: 1608 05:29:47 INFO - Running post-run listener: _upload_blobber_files 05:29:47 INFO - Blob upload gear active. 05:29:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:29:47 INFO - Copying logs to upload dir... 05:29:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1346.995133 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2015-11-22 05:29:47.713817) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-22 05:29:47.717162) ========= 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.XLUVNGbXDc/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.WRjOXK53cO/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009413 build_url: 'https://queue.taskcluster.net/v1/task/7P4HKHM0TjKgpFa8S_P0_g/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-22 05:29:47.741769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 05:29:47.742110) ========= 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.XLUVNGbXDc/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.WRjOXK53cO/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005006 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 05:29:47.792868) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-22 05:29:47.793533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-22 05:29:47.794374) ========= ========= Total master_lag: 0.35 =========