builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0089 starttime: 1447732884.55 results: success (0) buildid: 20151116174203 builduid: 1d69a440480a4f51b5afb2ea8e42784a revision: 204a1746f4213c92d3d0f8ca908e5e604d75b038 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.546627) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.547069) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.547476) ========= 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.r5WUpzmyLD/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.SxCb2VhwUx/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005988 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.594195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.594547) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.610684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.611032) ========= 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.r5WUpzmyLD/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.SxCb2VhwUx/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005449 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.660791) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.661091) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.661478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.661806) ========= 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.r5WUpzmyLD/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.SxCb2VhwUx/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-16 20:01:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.0M=0s 2015-11-16 20:01:24 (57.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.802434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.802756) ========= 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.r5WUpzmyLD/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.SxCb2VhwUx/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.021292 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.852943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:24.853329) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 204a1746f4213c92d3d0f8ca908e5e604d75b038 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 204a1746f4213c92d3d0f8ca908e5e604d75b038 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-16 20:01:24,932 truncating revision to first 12 chars 2015-11-16 20:01:24,933 Setting DEBUG logging. 2015-11-16 20:01:24,933 attempt 1/10 2015-11-16 20:01:24,933 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/204a1746f421?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 20:01:25,306 unpacking tar archive at: mozilla-inbound-204a1746f421/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:25.512978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:25.513297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:25.527794) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:25.528138) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 20:01:25.528641) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2015-11-16 20:01:25.528929) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 20:01:25 INFO - MultiFileLogger online at 20151116 20:01:25 in /builds/slave/test 20:01:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 20:01:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:01:25 INFO - {'append_to_log': False, 20:01:25 INFO - 'base_work_dir': '/builds/slave/test', 20:01:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:01:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:01:25 INFO - 'branch': 'Mozilla-Inbound', 20:01:25 INFO - 'buildbot_json_path': 'buildprops.json', 20:01:25 INFO - 'config_files': ('talos/mac_config.py',), 20:01:25 INFO - 'default_actions': ('clobber', 20:01:25 INFO - 'read-buildbot-config', 20:01:25 INFO - 'download-and-extract', 20:01:25 INFO - 'populate-webroot', 20:01:25 INFO - 'create-virtualenv', 20:01:25 INFO - 'install', 20:01:25 INFO - 'run-tests'), 20:01:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:01:25 INFO - 'download_minidump_stackwalk': True, 20:01:25 INFO - 'download_symbols': 'ondemand', 20:01:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:01:25 INFO - 'tooltool.py': '/tools/tooltool.py', 20:01:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:01:25 INFO - '/tools/misc-python/virtualenv.py')}, 20:01:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:01:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:01:25 INFO - 'installer_path': 'installer.exe', 20:01:25 INFO - 'log_level': 'info', 20:01:25 INFO - 'log_name': 'talos', 20:01:25 INFO - 'log_to_console': True, 20:01:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:01:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:01:25 INFO - 'opt_config_files': (), 20:01:25 INFO - 'pip_index': False, 20:01:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:01:25 INFO - 'cmd': ('bash', 20:01:25 INFO - '-c', 20:01:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:01:25 INFO - 'enabled': True, 20:01:25 INFO - 'halt_on_failure': False, 20:01:25 INFO - 'name': 'check_screen_resolution'},), 20:01:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:01:25 INFO - 'cmd': ('bash', 20:01:25 INFO - '-c', 20:01:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:01:25 INFO - 'enabled': True, 20:01:25 INFO - 'halt_on_failure': False, 20:01:25 INFO - 'name': 'check_screen_resolution'},), 20:01:25 INFO - 'run_cmd_checks_enabled': True, 20:01:25 INFO - 'sps_profile': False, 20:01:25 INFO - 'sps_profile_interval': 0, 20:01:25 INFO - 'suite': 'dromaeojs-e10s', 20:01:25 INFO - 'system_bits': '64', 20:01:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:01:25 INFO - 'title': 't-yosemite-r5-0089', 20:01:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:01:25 INFO - 'use_talos_json': True, 20:01:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:01:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:01:25 INFO - 'work_dir': 'build'} 20:01:25 INFO - ##### 20:01:25 INFO - ##### Running clobber step. 20:01:25 INFO - ##### 20:01:25 INFO - Running pre-action listener: _resource_record_pre_action 20:01:25 INFO - Running main action method: clobber 20:01:25 INFO - rmtree: /builds/slave/test/build 20:01:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:01:27 INFO - Running post-action listener: _resource_record_post_action 20:01:27 INFO - ##### 20:01:27 INFO - ##### Running read-buildbot-config step. 20:01:27 INFO - ##### 20:01:27 INFO - Running pre-action listener: _resource_record_pre_action 20:01:27 INFO - Running main action method: read_buildbot_config 20:01:27 INFO - Using buildbot properties: 20:01:27 INFO - { 20:01:27 INFO - "properties": { 20:01:27 INFO - "buildnumber": 199, 20:01:27 INFO - "product": "firefox", 20:01:27 INFO - "script_repo_revision": "production", 20:01:27 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 20:01:27 INFO - "repository": "", 20:01:27 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 20:01:27 INFO - "buildid": "20151116174203", 20:01:27 INFO - "slavename": "t-yosemite-r5-0089", 20:01:27 INFO - "pgo_build": "False", 20:01:27 INFO - "basedir": "/builds/slave/test", 20:01:27 INFO - "project": "", 20:01:27 INFO - "platform": "yosemite", 20:01:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:01:27 INFO - "slavebuilddir": "test", 20:01:27 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 20:01:27 INFO - "branch": "mozilla-inbound", 20:01:27 INFO - "repo_path": "integration/mozilla-inbound", 20:01:27 INFO - "stage_platform": "macosx64", 20:01:27 INFO - "builduid": "1d69a440480a4f51b5afb2ea8e42784a", 20:01:27 INFO - "revision": "204a1746f4213c92d3d0f8ca908e5e604d75b038" 20:01:27 INFO - }, 20:01:27 INFO - "sourcestamp": { 20:01:27 INFO - "repository": "", 20:01:27 INFO - "hasPatch": false, 20:01:27 INFO - "project": "", 20:01:27 INFO - "branch": "mozilla-inbound-macosx64-talos", 20:01:27 INFO - "changes": [ 20:01:27 INFO - { 20:01:27 INFO - "category": null, 20:01:27 INFO - "files": [ 20:01:27 INFO - { 20:01:27 INFO - "url": null, 20:01:27 INFO - "name": "https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 20:01:27 INFO - } 20:01:27 INFO - ], 20:01:27 INFO - "repository": "", 20:01:27 INFO - "rev": "204a1746f4213c92d3d0f8ca908e5e604d75b038", 20:01:27 INFO - "who": "kcambridge@mozilla.com", 20:01:27 INFO - "when": 1447732430, 20:01:27 INFO - "number": 6669847, 20:01:27 INFO - "comments": "Bug 1210211 - Part 3: Test for push notification quota with web notifications. r=kitcambridge", 20:01:27 INFO - "project": "", 20:01:27 INFO - "at": "Mon 16 Nov 2015 19:53:50", 20:01:27 INFO - "branch": "mozilla-inbound-macosx64-talos", 20:01:27 INFO - "revlink": "", 20:01:27 INFO - "properties": [ 20:01:27 INFO - [ 20:01:27 INFO - "buildid", 20:01:27 INFO - "20151116174203", 20:01:27 INFO - "Change" 20:01:27 INFO - ], 20:01:27 INFO - [ 20:01:27 INFO - "builduid", 20:01:27 INFO - "1d69a440480a4f51b5afb2ea8e42784a", 20:01:27 INFO - "Change" 20:01:27 INFO - ], 20:01:27 INFO - [ 20:01:27 INFO - "pgo_build", 20:01:27 INFO - "False", 20:01:27 INFO - "Change" 20:01:27 INFO - ] 20:01:27 INFO - ], 20:01:27 INFO - "revision": "204a1746f4213c92d3d0f8ca908e5e604d75b038" 20:01:27 INFO - } 20:01:27 INFO - ], 20:01:27 INFO - "revision": "204a1746f4213c92d3d0f8ca908e5e604d75b038" 20:01:27 INFO - } 20:01:27 INFO - } 20:01:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 20:01:27 INFO - Running post-action listener: _resource_record_post_action 20:01:27 INFO - ##### 20:01:27 INFO - ##### Running download-and-extract step. 20:01:27 INFO - ##### 20:01:27 INFO - Running pre-action listener: _resource_record_pre_action 20:01:27 INFO - Running main action method: download_and_extract 20:01:27 INFO - mkdir: /builds/slave/test/build/tests 20:01:27 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')]} 20:01:27 INFO - https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/test_packages.json 20:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/test_packages.json 20:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:01:27 INFO - Downloaded 1149 bytes. 20:01:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:01:27 INFO - Using the following test package requirements: 20:01:27 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 20:01:27 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:01:27 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 20:01:27 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:01:27 INFO - u'jsshell-mac.zip'], 20:01:27 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:01:27 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 20:01:27 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 20:01:27 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:01:27 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 20:01:27 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:01:27 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 20:01:27 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:01:27 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 20:01:27 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 20:01:27 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:01:27 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 20:01:27 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:01:27 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')]} 20:01:27 INFO - https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/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 20:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/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 20:01:29 INFO - Downloaded 17464505 bytes. 20:01:29 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 20:01:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:01:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 20:01:34 INFO - Return code: 0 20:01:34 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 20:01: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')]} 20:01:34 INFO - https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:01:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:01:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:01:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/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 20:01:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/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 20:01:35 INFO - Downloaded 17464505 bytes. 20:01:35 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 20:01:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:01:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 20:01:40 INFO - Return code: 0 20:01:40 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')]} 20:01:40 INFO - https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 20:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 20:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/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 20:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/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 20:01:41 INFO - Downloaded 11131693 bytes. 20:01:41 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 20:01:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 20:01:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 20:01:41 INFO - Return code: 0 20:01:41 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')]} 20:01:41 INFO - https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 20:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 20:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 20:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ywXr4XLEREuFBtq7h--ivw/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 20:01:45 INFO - Downloaded 108800714 bytes. 20:01:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 20:01:45 INFO - mkdir: /builds/slave/test/properties 20:01:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:01:45 INFO - Writing to file /builds/slave/test/properties/build_url 20:01:45 INFO - Contents: 20:01:45 INFO - build_url:https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 20:01:45 INFO - Running post-action listener: _resource_record_post_action 20:01:45 INFO - Running post-action listener: set_extra_try_arguments 20:01:45 INFO - ##### 20:01:45 INFO - ##### Running populate-webroot step. 20:01:45 INFO - ##### 20:01:45 INFO - Running pre-action listener: _resource_record_pre_action 20:01:45 INFO - Running main action method: populate_webroot 20:01:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:01:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:01:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:01:45 INFO - '../fennec_ids.txt'], 20:01:45 INFO - 'tests': ['tcheck2']}, 20:01:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:01:45 INFO - '--tppagecycles', 20:01:45 INFO - '7'], 20:01:45 INFO - 'tests': ['tsvgm']}}, 20:01:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:01:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:01:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:01:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:01:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:45 INFO - 'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:45 INFO - 'tests': ['damp', 'tps']}, 20:01:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:45 INFO - 'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['damp', 'tps']}, 20:01:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:01:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:01:45 INFO - 'other': {'tests': ['a11yr', 20:01:45 INFO - 'ts_paint', 20:01:45 INFO - 'tpaint', 20:01:45 INFO - 'sessionrestore', 20:01:45 INFO - 'sessionrestore_no_auto_restore']}, 20:01:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['a11yr', 20:01:45 INFO - 'ts_paint', 20:01:45 INFO - 'tpaint', 20:01:45 INFO - 'sessionrestore', 20:01:45 INFO - 'sessionrestore_no_auto_restore']}, 20:01:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['a11yr', 20:01:45 INFO - 'ts_paint', 20:01:45 INFO - 'tpaint', 20:01:45 INFO - 'sessionrestore', 20:01:45 INFO - 'sessionrestore_no_auto_restore']}, 20:01:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['a11yr', 20:01:45 INFO - 'ts_paint', 20:01:45 INFO - 'tpaint', 20:01:45 INFO - 'sessionrestore', 20:01:45 INFO - 'sessionrestore_no_auto_restore']}, 20:01:45 INFO - 'other_l64': {'tests': ['a11yr', 20:01:45 INFO - 'ts_paint', 20:01:45 INFO - 'tpaint', 20:01:45 INFO - 'sessionrestore', 20:01:45 INFO - 'sessionrestore_no_auto_restore']}, 20:01:45 INFO - 'other_nol64': {'tests': ['a11yr', 20:01:45 INFO - 'ts_paint', 20:01:45 INFO - 'tpaint', 20:01:45 INFO - 'sessionrestore', 20:01:45 INFO - 'sessionrestore_no_auto_restore']}, 20:01:45 INFO - 'svgr': {'tests': ['tsvgx', 20:01:45 INFO - 'tsvgr_opacity', 20:01:45 INFO - 'tart', 20:01:45 INFO - 'tscrollx', 20:01:45 INFO - 'cart']}, 20:01:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['tsvgx', 20:01:45 INFO - 'tsvgr_opacity', 20:01:45 INFO - 'tart', 20:01:45 INFO - 'tscrollx', 20:01:45 INFO - 'cart']}, 20:01:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:45 INFO - 'tests': ['tp5o']}, 20:01:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:45 INFO - 'talos_options': ['--e10s'], 20:01:45 INFO - 'tests': ['tp5o']}, 20:01:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:45 INFO - 'talos_options': ['--xperf_path', 20:01:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:45 INFO - 'tests': ['tp5n']}, 20:01:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:45 INFO - 'talos_options': ['--e10s', 20:01:45 INFO - '--xperf_path', 20:01:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:45 INFO - 'tests': ['tp5n']}}, 20:01:45 INFO - 'talos.zip': {'path': '', 20:01:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:01:45 INFO - Running post-action listener: _resource_record_post_action 20:01:45 INFO - ##### 20:01:45 INFO - ##### Running create-virtualenv step. 20:01:45 INFO - ##### 20:01:45 INFO - Running pre-action listener: _resource_record_pre_action 20:01:45 INFO - Running main action method: create_virtualenv 20:01:45 INFO - Creating virtualenv /builds/slave/test/build/venv 20:01:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:01:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:01:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:01:45 INFO - Using real prefix '/tools/python27' 20:01:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:01:46 INFO - Installing distribute.............................................................................................................................................................................................done. 20:01:50 INFO - Installing pip.................done. 20:01:50 INFO - Return code: 0 20:01:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:01:50 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')]} 20:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 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')]} 20:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 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 0x105096490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105073228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14374f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb99f0>, '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 0x104d19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fad8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:01:50 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 20:01:50 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 20:01:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/Render', 20:01:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:50 INFO - 'HOME': '/Users/cltbld', 20:01:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:50 INFO - 'LOGNAME': 'cltbld', 20:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:50 INFO - 'MOZ_NO_REMOTE': '1', 20:01:50 INFO - 'NO_EM_RESTART': '1', 20:01:50 INFO - 'PAGER': '/bin/cat', 20:01:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:50 INFO - 'PWD': '/builds/slave/test', 20:01:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:50 INFO - 'SHELL': '/bin/bash', 20:01:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxCb2VhwUx/Listeners', 20:01:50 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 20:01:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:50 INFO - 'USER': 'cltbld', 20:01:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:50 INFO - 'XPC_FLAGS': '0x0', 20:01:50 INFO - 'XPC_SERVICE_NAME': '0', 20:01:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:50 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 20:01:50 INFO - Cleaning up... 20:01:50 INFO - Return code: 0 20:01:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:01:50 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')]} 20:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 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')]} 20:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 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 0x105096490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105073228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14374f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb99f0>, '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 0x104d19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fad8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:01:50 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 20:01:50 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 20:01:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/Render', 20:01:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:50 INFO - 'HOME': '/Users/cltbld', 20:01:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:50 INFO - 'LOGNAME': 'cltbld', 20:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:50 INFO - 'MOZ_NO_REMOTE': '1', 20:01:50 INFO - 'NO_EM_RESTART': '1', 20:01:50 INFO - 'PAGER': '/bin/cat', 20:01:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:50 INFO - 'PWD': '/builds/slave/test', 20:01:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:50 INFO - 'SHELL': '/bin/bash', 20:01:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxCb2VhwUx/Listeners', 20:01:50 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 20:01:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:50 INFO - 'USER': 'cltbld', 20:01:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:50 INFO - 'XPC_FLAGS': '0x0', 20:01:50 INFO - 'XPC_SERVICE_NAME': '0', 20:01:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:51 INFO - Downloading/unpacking psutil>=0.7.1 20:01: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 20:01: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 20:01: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 20:01: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 20:01: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 20:01: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 20:01:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:01:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:01:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:53 INFO - Installing collected packages: psutil 20:01:53 INFO - Running setup.py install for psutil 20:01:54 INFO - building 'psutil._psutil_osx' extension 20:01:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:01:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:01:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:01:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 20:01:54 INFO - building 'psutil._psutil_posix' extension 20:01:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 20:01:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:01:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:01:54 INFO - ^ 20:01:54 INFO - 1 warning generated. 20:01:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 20:01:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:55 INFO - Successfully installed psutil 20:01:55 INFO - Cleaning up... 20:01:55 INFO - Return code: 0 20:01:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:01:55 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')]} 20:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:55 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')]} 20:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:55 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 0x105096490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105073228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14374f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb99f0>, '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 0x104d19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fad8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:01:55 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 20:01:55 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 20:01:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/Render', 20:01:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:55 INFO - 'HOME': '/Users/cltbld', 20:01:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:55 INFO - 'LOGNAME': 'cltbld', 20:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:55 INFO - 'MOZ_NO_REMOTE': '1', 20:01:55 INFO - 'NO_EM_RESTART': '1', 20:01:55 INFO - 'PAGER': '/bin/cat', 20:01:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:55 INFO - 'PWD': '/builds/slave/test', 20:01:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:55 INFO - 'SHELL': '/bin/bash', 20:01:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxCb2VhwUx/Listeners', 20:01:55 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 20:01:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:55 INFO - 'USER': 'cltbld', 20:01:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:55 INFO - 'XPC_FLAGS': '0x0', 20:01:55 INFO - 'XPC_SERVICE_NAME': '0', 20:01:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:01:55 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 20:01:55 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 20:01:55 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 20:01:55 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 20:01:55 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 20:01:55 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 20:01:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:01:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:01:58 INFO - Installing collected packages: mozsystemmonitor 20:01:58 INFO - Running setup.py install for mozsystemmonitor 20:01:58 INFO - Successfully installed mozsystemmonitor 20:01:58 INFO - Cleaning up... 20:01:58 INFO - Return code: 0 20:01:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:58 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 0x105096490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105073228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14374f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb99f0>, '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 0x104d19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fad8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:01:58 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 20:01:58 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 20:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/Render', 20:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:58 INFO - 'HOME': '/Users/cltbld', 20:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:58 INFO - 'LOGNAME': 'cltbld', 20:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:58 INFO - 'MOZ_NO_REMOTE': '1', 20:01:58 INFO - 'NO_EM_RESTART': '1', 20:01:58 INFO - 'PAGER': '/bin/cat', 20:01:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:58 INFO - 'PWD': '/builds/slave/test', 20:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:58 INFO - 'SHELL': '/bin/bash', 20:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxCb2VhwUx/Listeners', 20:01:58 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 20:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:58 INFO - 'USER': 'cltbld', 20:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:58 INFO - 'XPC_FLAGS': '0x0', 20:01:58 INFO - 'XPC_SERVICE_NAME': '0', 20:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:01:58 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 20:01:58 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 20:01:58 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 20:01:58 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 20:01:58 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 20:01:58 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 20:02:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:02:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:02:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:02: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 20:02: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 20:02: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 20:02: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 20:02: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 20:02: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 20:02:02 INFO - Downloading docopt-0.6.1.tar.gz 20:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:02:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:02:02 INFO - Running setup.py install for blobuploader 20:02:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:02:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:02:02 INFO - Running setup.py install for requests 20:02:03 INFO - Running setup.py install for docopt 20:02:03 INFO - Successfully installed blobuploader requests docopt 20:02:03 INFO - Cleaning up... 20:02:03 INFO - Return code: 0 20:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:03 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 0x105096490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105073228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14374f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb99f0>, '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 0x104d19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fad8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:02:03 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 20:02:03 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 20:02:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/Render', 20:02:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:02:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:02:03 INFO - 'HOME': '/Users/cltbld', 20:02:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:02:03 INFO - 'LOGNAME': 'cltbld', 20:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:03 INFO - 'MOZ_NO_REMOTE': '1', 20:02:03 INFO - 'NO_EM_RESTART': '1', 20:02:03 INFO - 'PAGER': '/bin/cat', 20:02:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:03 INFO - 'PWD': '/builds/slave/test', 20:02:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:02:03 INFO - 'SHELL': '/bin/bash', 20:02:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxCb2VhwUx/Listeners', 20:02:03 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 20:02:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:02:03 INFO - 'USER': 'cltbld', 20:02:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:02:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:03 INFO - 'XPC_FLAGS': '0x0', 20:02:03 INFO - 'XPC_SERVICE_NAME': '0', 20:02:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:04 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-0SWyya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:04 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-LK00XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:04 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-lCnf_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:04 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-PQW1MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:04 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-J82pDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:04 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-rjpI3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:04 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-jhduFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:05 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-sU1WTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:05 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-7C89C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:05 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-DOt_NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:05 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-xSR_Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:05 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-5t_lPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:05 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-buqniE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:05 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-Ix1LQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:06 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-Qfkxd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:06 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-XZmxNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:06 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-DSVHza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:02:06 INFO - Running setup.py install for manifestparser 20:02:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:02:06 INFO - Running setup.py install for mozcrash 20:02:06 INFO - Running setup.py install for mozdebug 20:02:06 INFO - Running setup.py install for mozdevice 20:02:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:02:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:02:07 INFO - Running setup.py install for mozfile 20:02:07 INFO - Running setup.py install for mozhttpd 20:02:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:02:07 INFO - Running setup.py install for mozinfo 20:02:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:02:07 INFO - Running setup.py install for mozInstall 20:02:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:02:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:02:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:02:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:02:07 INFO - Running setup.py install for mozleak 20:02:08 INFO - Running setup.py install for mozlog 20:02:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:02:08 INFO - Running setup.py install for moznetwork 20:02:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:02:08 INFO - Running setup.py install for mozprocess 20:02:08 INFO - Running setup.py install for mozprofile 20:02:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:02:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:02:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:02:08 INFO - Running setup.py install for mozrunner 20:02:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:02:09 INFO - Running setup.py install for mozscreenshot 20:02:09 INFO - Running setup.py install for moztest 20:02:09 INFO - Running setup.py install for mozversion 20:02:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:02:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:02:09 INFO - Cleaning up... 20:02:09 INFO - Return code: 0 20:02:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:09 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 0x105096490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105073228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14374f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb99f0>, '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 0x104d19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fad8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:02:09 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 20:02:09 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 20:02:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/Render', 20:02:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:02:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:02:09 INFO - 'HOME': '/Users/cltbld', 20:02:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:02:09 INFO - 'LOGNAME': 'cltbld', 20:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:09 INFO - 'MOZ_NO_REMOTE': '1', 20:02:09 INFO - 'NO_EM_RESTART': '1', 20:02:09 INFO - 'PAGER': '/bin/cat', 20:02:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:09 INFO - 'PWD': '/builds/slave/test', 20:02:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:02:09 INFO - 'SHELL': '/bin/bash', 20:02:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxCb2VhwUx/Listeners', 20:02:09 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 20:02:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:02:09 INFO - 'USER': 'cltbld', 20:02:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:02:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:09 INFO - 'XPC_FLAGS': '0x0', 20:02:09 INFO - 'XPC_SERVICE_NAME': '0', 20:02:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:10 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-kb_llN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:10 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)) 20:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:10 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-rymVMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:10 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)) 20:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:10 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-TSckeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:10 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)) 20:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:10 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-MdSMDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:10 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)) 20:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:10 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-KeF69S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:10 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)) 20:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:10 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-3YtTqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:10 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)) 20:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:10 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-zlUytx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:11 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-xCysoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:11 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-SRfBtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:11 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-dLlYE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:11 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-bgyQOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:11 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-9en4gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:11 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-KAzEcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:11 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-Wy03dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:11 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)) 20:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:11 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-Ef4IFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:12 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)) 20:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:12 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-CuSSmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:12 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)) 20:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:12 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-vCuUt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:12 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)) 20:02:12 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)) 20:02:12 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)) 20:02:12 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)) 20:02:12 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)) 20:02:12 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)) 20:02:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:14 INFO - Downloading blessings-1.5.1.tar.gz 20:02:15 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 20:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:02:15 INFO - Installing collected packages: blessings 20:02:15 INFO - Running setup.py install for blessings 20:02:15 INFO - Successfully installed blessings 20:02:15 INFO - Cleaning up... 20:02:15 INFO - Return code: 0 20:02:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:02:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:15 INFO - Reading from file tmpfile_stdout 20:02:15 INFO - Current package versions: 20:02:15 INFO - blessings == 1.5.1 20:02:15 INFO - blobuploader == 1.2.4 20:02:15 INFO - docopt == 0.6.1 20:02:15 INFO - manifestparser == 1.1 20:02:15 INFO - mozInstall == 1.12 20:02:15 INFO - mozcrash == 0.16 20:02:15 INFO - mozdebug == 0.1 20:02:15 INFO - mozdevice == 0.47 20:02:15 INFO - mozfile == 1.2 20:02:15 INFO - mozhttpd == 0.7 20:02:15 INFO - mozinfo == 0.9 20:02:15 INFO - mozleak == 0.1 20:02:15 INFO - mozlog == 3.0 20:02:15 INFO - moznetwork == 0.27 20:02:15 INFO - mozprocess == 0.22 20:02:15 INFO - mozprofile == 0.27 20:02:15 INFO - mozrunner == 6.11 20:02:15 INFO - mozscreenshot == 0.1 20:02:15 INFO - mozsystemmonitor == 0.0 20:02:15 INFO - moztest == 0.7 20:02:15 INFO - mozversion == 1.4 20:02:15 INFO - psutil == 3.1.1 20:02:15 INFO - requests == 1.2.3 20:02:15 INFO - wsgiref == 0.1.2 20:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x105096490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105073228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14374f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb99f0>, '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 0x104d19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fad8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/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.SxCb2VhwUx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 20:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 20:02:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/Render', 20:02:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:02:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:02:15 INFO - 'HOME': '/Users/cltbld', 20:02:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:02:15 INFO - 'LOGNAME': 'cltbld', 20:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:15 INFO - 'MOZ_NO_REMOTE': '1', 20:02:15 INFO - 'NO_EM_RESTART': '1', 20:02:15 INFO - 'PAGER': '/bin/cat', 20:02:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:15 INFO - 'PWD': '/builds/slave/test', 20:02:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:02:15 INFO - 'SHELL': '/bin/bash', 20:02:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxCb2VhwUx/Listeners', 20:02:15 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 20:02:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:02:15 INFO - 'USER': 'cltbld', 20:02:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:02:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:15 INFO - 'XPC_FLAGS': '0x0', 20:02:15 INFO - 'XPC_SERVICE_NAME': '0', 20:02:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 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)) 20:02:16 INFO - Cleaning up... 20:02:16 INFO - Return code: 0 20:02:16 INFO - Running post-action listener: _resource_record_post_action 20:02:16 INFO - Running post-action listener: _start_resource_monitoring 20:02:16 INFO - Starting resource monitoring. 20:02:16 INFO - ##### 20:02:16 INFO - ##### Running install step. 20:02:16 INFO - ##### 20:02:16 INFO - Running pre-action listener: _resource_record_pre_action 20:02:16 INFO - Running main action method: install 20:02:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:16 INFO - Reading from file tmpfile_stdout 20:02:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:02:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:02:16 INFO - Reading from file tmpfile_stdout 20:02:16 INFO - Output received: 20:02:16 INFO - Usage: mozinstall [options] installer 20:02:16 INFO - Options: 20:02:16 INFO - -h, --help show this help message and exit 20:02:16 INFO - -d DEST, --destination=DEST 20:02:16 INFO - Directory to install application into. [default: 20:02:16 INFO - "/builds/slave/test"] 20:02:16 INFO - --app=APP Application being installed. [default: firefox] 20:02:16 INFO - mkdir: /builds/slave/test/build/application 20:02:16 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'] 20:02:16 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 20:02:57 INFO - Reading from file tmpfile_stdout 20:02:57 INFO - Output received: 20:02:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:02:57 INFO - Running post-action listener: _resource_record_post_action 20:02:57 INFO - ##### 20:02:57 INFO - ##### Running run-tests step. 20:02:57 INFO - ##### 20:02:57 INFO - Running pre-action listener: _resource_record_pre_action 20:02:57 INFO - Running main action method: run_tests 20:02:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:02:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:02:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:02:57 INFO - 2015-11-16 20:02:57.586 screenresolution[2609:78543] starting screenresolution argv=screenresolution get 20:02:57 INFO - 2015-11-16 20:02:57.589 screenresolution[2609:78543] Display 0: 1600x1200x32@60 20:02:57 INFO - 2015-11-16 20:02:57.597 screenresolution[2610:78545] starting screenresolution argv=screenresolution list 20:02:57 INFO - Available Modes on Display 0 20:02:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:02:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:02:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:02:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:02:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:02:57 INFO - Intel HD Graphics 3000: 20:02:57 INFO - Chipset Model: Intel HD Graphics 3000 20:02:57 INFO - Type: GPU 20:02:57 INFO - Bus: Built-In 20:02:57 INFO - VRAM (Total): 512 MB 20:02:57 INFO - VRAM (Dynamic, Max): 10 20:02:57 INFO - Vendor: Intel (0x8086) 20:02:57 INFO - Device ID: 0x0116 20:02:57 INFO - Revision ID: 0x0009 20:02:57 INFO - Displays: 20:02:57 INFO - Display: 20:02:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:02:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:02:57 INFO - Display Serial Number: 1600x1200 60 20:02:57 INFO - Main Display: Yes 20:02:57 INFO - Mirror: Off 20:02:57 INFO - Online: Yes 20:02:57 INFO - Rotation: Supported 20:02:57 INFO - Return code: 0 20:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:57 INFO - Python 2.7.3 20:02:57 INFO - Return code: 0 20:02:57 INFO - grabbing minidump binary from tooltool 20:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:57 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 0x104fb99f0>, '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 0x104d19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fad8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:57 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 20:02:57 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 20:02:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:57 INFO - Return code: 0 20:02:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:02:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:02:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0089', '--webServer', 'localhost'] in /builds/slave/test/build 20:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0089 --webServer localhost 20:02:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r5WUpzmyLD/Render', 20:02:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:02:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:02:57 INFO - 'HOME': '/Users/cltbld', 20:02:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:02:57 INFO - 'LOGNAME': 'cltbld', 20:02:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:57 INFO - 'MOZ_NO_REMOTE': '1', 20:02:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:57 INFO - 'NO_EM_RESTART': '1', 20:02:57 INFO - 'PAGER': '/bin/cat', 20:02:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:57 INFO - 'PWD': '/builds/slave/test', 20:02:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:02:57 INFO - 'SHELL': '/bin/bash', 20:02:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxCb2VhwUx/Listeners', 20:02:57 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 20:02:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:02:57 INFO - 'USER': 'cltbld', 20:02:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:02:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:57 INFO - 'XPC_FLAGS': '0x0', 20:02:57 INFO - 'XPC_SERVICE_NAME': '0', 20:02:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:02:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0089', '--webServer', 'localhost'] with output_timeout 3600 20:02:58 INFO - mozversion INFO | application_buildid: 20151116174203 20:02:58 INFO - mozversion INFO | application_changeset: 204a1746f4213c92d3d0f8ca908e5e604d75b038 20:02:58 INFO - mozversion INFO | application_display_name: Nightly 20:02:58 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:58 INFO - mozversion INFO | application_name: Firefox 20:02:58 INFO - mozversion INFO | application_remotingname: firefox 20:02:58 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:02:58 INFO - mozversion INFO | application_vendor: Mozilla 20:02:58 INFO - mozversion INFO | application_version: 45.0a1 20:02:58 INFO - mozversion INFO | platform_buildid: 20151116174203 20:02:58 INFO - mozversion INFO | platform_changeset: 204a1746f4213c92d3d0f8ca908e5e604d75b038 20:02:58 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:02:58 INFO - mozversion INFO | platform_version: 45.0a1 20:02:58 INFO - 2015-11-16 20:02:58,245 DEBUG : using testdate: 1447732978 20:02:58 INFO - 2015-11-16 20:02:58,245 DEBUG : actual date: 1447732978 20:02:58 INFO - 2015-11-16 20:02:58,254 INFO : starting webserver on 'localhost:54775' 20:02:58 INFO - 2015-11-16 20:02:58,255 INFO : Starting test suite t-yosemite-r5-0089.e 20:02:58 INFO - 2015-11-16 20:02:58,255 INFO : Starting test dromaeo_css 20:02:58 INFO - 2015-11-16 20:02:58,255 DEBUG : operating with platform_type : mac_ 20:02:58 INFO - 2015-11-16 20:02:58,256 INFO : Initialising browser for dromaeo_css test... 20:02:58 INFO - 2015-11-16 20:02:58,271 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmp48dJco/profile http://localhost:54775/getInfo.html 20:03:01 INFO - 2015-11-16 20:03:01,606 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:03:01 INFO - 2015-11-16 20:03:01,606 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:03:01 INFO - 2015-11-16 20:03:01,606 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 20:03:01 INFO - 2015-11-16 20:03:01,606 DEBUG : BROWSER_OUTPUT: __metrics 20:03:02 INFO - 2015-11-16 20:03:02,324 INFO : Browser initialized. 20:03:02 INFO - 2015-11-16 20:03:02,325 INFO : Running cycle 1/1 for dromaeo_css test... 20:03:02 INFO - 2015-11-16 20:03:02,325 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmp48dJco/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:03:14 INFO - 2015-11-16 20:03:14,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 240222208 20:03:14 INFO - 2015-11-16 20:03:14,525 DEBUG : BROWSER_OUTPUT: 20:04:04 INFO - 2015-11-16 20:04:04,251 DEBUG : BROWSER_OUTPUT: 1447733044247 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] 20:06:13 INFO - 2015-11-16 20:06:13,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54775/tests/dromaeo/cssquery-ext.html) 20:06:14 INFO - 2015-11-16 20:06:14,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 265596928 20:06:14 INFO - 2015-11-16 20:06:14,616 DEBUG : BROWSER_OUTPUT: 20:09:16 INFO - 2015-11-16 20:09:16,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/dromaeo/cssquery-ext.html (next: http://localhost:54775/tests/dromaeo/cssquery-jquery.html) 20:09:17 INFO - 2015-11-16 20:09:17,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 271409152 20:09:17 INFO - 2015-11-16 20:09:17,337 DEBUG : BROWSER_OUTPUT: 20:12:19 INFO - 2015-11-16 20:12:19,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54775/tests/dromaeo/cssquery-mootools.html) 20:12:19 INFO - 2015-11-16 20:12:19,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 275623936 20:12:19 INFO - 2015-11-16 20:12:19,680 DEBUG : BROWSER_OUTPUT: 20:15:21 INFO - 2015-11-16 20:15:21,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54775/tests/dromaeo/cssquery-prototype.html) 20:15:22 INFO - 2015-11-16 20:15:22,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 278806528 20:15:22 INFO - 2015-11-16 20:15:22,041 DEBUG : BROWSER_OUTPUT: 20:18:24 INFO - 2015-11-16 20:18:24,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54775/tests/dromaeo/cssquery-yui.html) 20:18:25 INFO - 2015-11-16 20:18:25,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 283922432 20:18:25 INFO - 2015-11-16 20:18:25,341 DEBUG : BROWSER_OUTPUT: 20:21:27 INFO - 2015-11-16 20:21:27,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/dromaeo/cssquery-yui.html (next: http://localhost:54775/tests/dromaeo/cssquery-dojo.html) 20:21:28 INFO - 2015-11-16 20:21:28,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 289492992 20:21:28 INFO - 2015-11-16 20:21:28,186 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,186 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:21:28 INFO - 2015-11-16 20:21:28,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:21:28 INFO - 2015-11-16 20:21:28,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:21:28 INFO - 2015-11-16 20:21:28,187 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:21:28 INFO - 2015-11-16 20:21:28,187 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2613.621024951382;2676.3041609181605;2713.81003329767;2748.8900443982234;2768.1833859011576;4445.3998710174155;4591.88520286993;4613.054323863608;4622.260438329868;4632.166210082184;4425.579569940858;4442.444694413199;4524.660650451213;4525.705829121105;4598.057398233363;4146.751194928314;4253.510846252674;4318.157959197958;4326.697131200817;4352.064306174172;213.95198576091624;4132.896677583054;4166.312558427856;4306.80619372129;4340.066885619591;4241.321388577828;4245.957540424587;4281.336392859112;4281.357796330544;4316.6978311518205;4199.790010499462;4225.619694227535;4280.614744672995;4283.635890949273;4340.500842403132;3977.3238549446664;4056.655184309337;4068.7355321903983;4171.791410429466;4290.249206388869;4326.783660816946;4521.412216411878;4549.47681016684;4558.612517935946;4605.608523275526;4831.613470922318;4874.268859671078;4888.340074090023;4915.606751459911;4939.135651261051;4785.521447855222;4876.341693871317;4878.853634390974;5015.673981191211;5026.874328141789;4591.632669386475;4618;4631.652626053059;4635.258358662598;4652.511486293958;4641.2109941310055;4965.230389289666;5017.247412888023;5035.597152227813;5074.416442109131;4684.976575117103;4783.258594917794;4831.95168048322;4853.126437241331;4859.586935110485;4809.639277054235;4897.240927656219;4933.531314525186;4945.109880221523;4974.875628109254;4657.906841863144;4749.928751068736;4882.755862206946;4884.267359896044;4918.532739389752;4755.619550435957;4785.832495862698;4818.229083346648;4853.126437241331;4868.172410690191;3795.5635101963076;3796.297684928242;3845.615438456132;3859.1895701902913;3907.5115610548683;3368.882089126918;3443.3974054540354;3508;3541.15012397028;3571.4642803579673;4552.795124219418;4582.175208462442;4658.883527911829;4672.883177920579;4705.60002399793;4946.925796113062;4982;4992.475790041994;4999.525045120708;5056.241563765465;4432;4441.356003379492;4542.954570454319;4568.109218702321;4570.108828778356;4311.07311927937;4313.223619748475;4387.692861499664;4388.05656783793;4446.333050042519;4939.456659767423;4992.550670439678;5013.3983921928875;5053.166227572483;5122.334096567422;4704.670673052853;4803.567678908915;4879.731614761222;4905.117078925685;4995.125852975787;4954.108260513142;4969.428515720739;5005.674631148963;5032.547070763649;5103.387593488805;4553.704009239389;4807.591354734886;4860.441049279378;4867.172580661367;4917.28699338601;4523.23105072132;4665.393498845128;4675.836345727883;4711.1519926413575;4784.880377990578;4694.882627934329;4731.3612662291525;4751.049790041936;4775.42694876617;4788.473267940593;4708.764561771966;4723.905521889612;4746.5490778376;4755.38180036593;4793.448753393404;4535.727856328631;4697.8355757548325;4702.717836929795;4710.952890471051;4786.282057691375;4735.408073990751;4761.16679581065;4773.355596994361;4794.472608013186;4898.657094003528;4406;4543.65922555803;4610.239310513728;4677.064587082665;4731.077439899324 20:21:28 INFO - 2015-11-16 20:21:28,188 DEBUG : BROWSER_OUTPUT: |1;ext.html;487.6220928780195;487.914614942385;495.7769003948222;498.9422424460145;503.90425819094384;35358.46962295564;36185.45721814172;36418.635813641886;36489.087772805695;36605.633943660556;37517.437238441446;38744.418833717515;38809.22381552367;38915.61084389162;39221.21557568847;7821.491603045798;7967.123616402191;8076.273135417811;8108;8165.510069395826;7974.242446967529;7986.041674999008;8036.357091432671;8139.715109971152;8160.836783264331;7957.084935232436;7986.960065199666;8019.719309824157;8030.839383212332;8062.798430039266;7930.286274235317;7975.561344126071;7988.241117093896;8030;8056.033276006917;7959.840803183962;8022.799430014238;8080.474769139987;8099.514029158269;8145.918540814575;35411.5835366585;35557;35600.64399355999;35659.64340356589;35973.28053438917;2161;2374.3589230907733;2478.529079474894;2528.8103392245657;2708.9458210835674;24292.757072429227;24444.633330500055;24708.382290442703;24719.62920556193;24960.126395576248;2027.7059826325249;2077.470245087508;2078.262216912989;2110.4407332056862;2122.0875023739786;212953;214644;215016;215873;217007;37874.62125378766;38595.22809543793;38673.80663096667;52888;53246.20130698042;36580.81709591435;36723.816380918455;36865;37003.81498092492;37133.58631688932;12098.092643051807;12157.696057598454;12168.939155304166;12190.695232619255;12196.39018049094;9421.05789421066;9524.095210954949;9550.474723890253;9557.808843823084;9560.760980975392;12610.117291789487;12726;12772.680682982815;12779.361031948365;12811.935940320238;5452.91820622691;5587.972060139673;5614.466625670555;5687.7156142192725;5690.374058853523;772.8531578999972;879.6877108626474;911.6900253913701;916;963.4508330251689;23751;24428.26715198547;24534.50930981406;24575;24587.262382128563;934.7429456899407;955.9569819358006;956.8803899512561;974.6637410093506;1024.7950409918046;12322.568710095104;12920.806187907188;12947;12962.611121666365;13011.739765204642;343877;347965;349754;350081;351787.0980966595;52161;52325.47674523282;52342;52370.476295236556;52537.47462525326;1161.651504548632;1168.2348062019391;1178.6994316449423;1201.2672269915345;1204.680759598707;24170.758292417555;24480.877595611906;24510.264692059267;24626.753732462446;24693.87653061723;41409.79295103505;41783;41943.79028104962;42003.36994945017;42114;240965;242654;244003;244730;247285;28720.569191461727;28748.568771468028;39679.801600991814;40958;41157.1768564633;38007;38529.614703853724;38589.61410385973;38862.6113738859;39511.2097758049;31719.84140079377;31979.68020319767;32227.516587251677;32808.50787238146;33142.337153257286;32195.678043219268;32196.678033220305;32426.675733242366;32544;32931.34137317288;33157;34941;35601.46597800983;35955.64044359523;36056;25921.22236332913;27756.583651244844;27801.165965021082;27940.58089128624;27995.720042799312;21312.573748525254;21442.142314307253;21462.892685536473;21766.891165544705;21871 20:21:28 INFO - 2015-11-16 20:21:28,191 DEBUG : BROWSER_OUTPUT: |2;jquery.html;278.36671572173316;285.4419609663108;287.61316029939735;292.37140148680334;293.39267715828237;8655;9094.090590940903;15350;15668.764968525467;15841.762373564407;10067.791864976194;10099.343542669722;10340.534675939582;10412.479376031188;10530.42082685452;3834.884953451401;3923.98038009811;3955.8417663293435;3958.445817585526;3965.9801700991457;3804.524434445694;3847.1343947611845;3867.9613203867884;3884.7086468514835;3902.5316961964463;3718.4236443351324;3836.673882719972;3848.903777405559;3857.9421308680394;3875.4961854958815;3851.441540976543;3859.671927886133;3865.6714179294795;3901.648851603341;3904.863329783458;3299.059767966118;3317.08780085476;3319.0872510059685;3335.96664033359;3338.2989572189867;10663.200259980533;11209.607663731811;11211.103111751041;11242.775144497145;11300.926411990848;1629.2016911713295;1647.6045749020268;1676.287577779451;1684.3431061885874;1727.1450631937146;8339.416240863142;8361.95819020901;8483.830323393559;8536.27441667459;8706;1342.7314537092523;1359.9184048956995;1363.5909227231791;1381.4336122189854;1406.1914399220489;52983;53809.461905380835;53942.190867137026;54391.45608543904;54585.45414545883;5617.803376881871;5639.210510528529;5646.745896434671;5743.971280143573;5771.826845194651;6117.785877494355;6464.159659244268;6501.544891857619;6541.934580654228;6543.607383557001;4345.456817897762;4349.3041113421705;4505.256632655641;4589.747563883951;4605.6776025678555;4798.4001999750035;4800.06398752247;4834.879128021757;4850.442199147073;4881.487443818419;2493.1772515069983;2549.7195308516048;2555.0546297869905;2571.1643715792443;2581.57404028337;904.3992133922919;905.1898550797132;907.9682211122579;910.6767097680361;977.0669011094387;365.4408754605458;384.1452767592141;396.3499860229226;398.8005997001441;403.7960829780942;10047.497625118714;10253.179745620333;10348.637797677045;10398.324108932895;10472.16222702182;384.24687612280246;392.8526802449082;395.58068447445226;400.2355500993089;415.5408273857344;5514.889702206014;5604.8318550443555;5624.971875140598;5644.379118296984;5683.090705487102;510959;511981;525550;526022;527230;60212.69893650504;61295;62205;62293.688531557054;63065;424.95325514193416;428.95067067287664;432.6430694676904;433.7766050484003;437.14319932931176;9464.621415143318;9517.524123793644;9571.234301255743;9725.708228753148;9754.609815607297;28760.280992975342;30153.698463015087;30781.38437231198;31090.53364199584;31408.528872067393;37195.442068369535;37726.62273377231;38424.80787596044;38765.41851872168;39066.21867562576;5264.6314757966575;5389.110796718497;5412.052890744026;5413.83758487246;5415.729213539386;9894.406335619886;10035.899641003496;10253.974602539687;10327.070563649308;10350.171986241234;8575.656973720981;8754.299656027375;8827.514486703036;9033.780439640565;9035.638574456949;8508.446950948168;8626.39615226928;8651.351148664002;8683;8738.519381434082;8763.780905477159;8772.868406974028;8911.15344042315;9034.096590340914;9059.773505662411;5215.4002289735645;5315.149576067811;5330.973345133405;5343.385510666168;5393.83818485446;8511.829763404821;8758.47449153053;8790.604422800861;8823.867641985247;8875.511846848485 20:21:28 INFO - 2015-11-16 20:21:28,193 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1455.5633310006995;1459.3068292561031;1517.6964607078587;1535.8464153584644;1559.4230134850104;5888.676122813244;5937.109433584965;6611.4049735523795;6787.457003439719;6827.146606674166;6478.319776423478;6537.575057621251;6574.506911981596;6617.503687223453;6708.597484150954;1842.4933143385542;1874.7469091672585;1875.3342563390004;1883.3690713610956;1890.5840715042737;1902.590942947266;1906.856985726069;1930.2664987304804;1946.2506934830121;1960.549073713047;1853.4439668099583;1880.6238752249606;1899.8575106866972;1903.4765439504108;1912.8756630818953;1841.640880028395;1899.8955057471903;1909.1885948471984;1921.7117432385114;1930.2954421636073;1845.7323688065155;1865.6082222733241;1878.0985127138913;1888.3673969220329;1931.748872646561;6586.637734924578;6609.20689517261;6636.502262330297;6705.865882682368;6713.227978782454;3996.200759848013;4050.5949405059555;4060.20825938942;4094.9385759213637;4122.835086596562;2102.495401103724;2147.70064111212;2352.141468364052;2417.431903502693;2422.454947636785;739.1056821246299;747.0698979770167;748.494766032931;759.8556274307864;778.7897267737679;8647.870281945712;8668.60991255395;8706.04233534317;8775;8802.075782042857;3623.384024715752;3653.415453527423;3706.8887933362043;3719.274741425396;3723.1809002020054;7667.348275396542;7670.923290767132;7676;7692;7718.266764657348;4091.5499295077516;4109.198706252252;4139.751614903055;4147.212029714405;4149.896252593649;3714.57282412526;3733.775973441602;3773.5471743390967;3786.9964459418275;3791.9810400947817;3065.6781037991136;3105.6894310568764;3109.9533506997413;3131.1858916681826;3147.937041259208;986.1371300112402;989.6239429016928;989.7129832348683;997.9002099789963;998.1964518562627;1116.1182665694173;1137.2096393006946;1139.1228753859482;1143.2968724234536;1163.4938801621322;6152.507799376039;6214.689265536705;6276;6340.239171299474;6340.429361357407;373.93456145174486;375.14841310226177;375.61687079179086;376.4391057324621;379.12233180187775;4898.044881248194;4912.582430493377;4992.375953005874;4996.7001979881325;5005.599552035828;7116.359527642537;7193.100862392201;7388.926110738931;7567.810804729926;7664.540127592362;7674.117476490163;7674.234925966947;7699.422543309274;7702.037245344332;7842.960785196037;6138.631682099089;6176.6911654418;6244.0321750128805;6251.562390632612;6286.9056964145575;5873.94126058751;5957.314908785545;5972.402759723993;5978.133170690313;5996.130561068708;6620.404163625104;6846.4522838173825;6859.725610975505;6887.862242755217;6968.65156742171;6938.791836244921;7064.894026589708;7102.3962963148715;7108.218096009538;7265.818354541178;5686.203931449518;5740.598158129058;5818.50542703858;5823.883522329615;5848.093545500455;6266.530010249158;6270.874582508415;6311.810645680637;6313.3686631336495;6315.621062736251;5731.455511726546;5815.592908496534;5945.524358051259;5945.583809133319;6049.971504844275;5484.232207490874;5690.374058853606;5769.365369809401;5815.185873977562;5917.704114794157;5872.354041055395;5900.498457630978;5967.37342579023;5990.101484777319;5994.28068631767;5391.784328626811;5409;5445.101558243004;5459.099248623933;5462.262594549685;5395.622306438669;5441.7279136043835;5463.125899856004;5474.206240095244;5575.99632066232 20:21:28 INFO - 2015-11-16 20:21:28,194 DEBUG : BROWSER_OUTPUT: |4;prototype.html;268.5595623177988;273.2090597719602;275.2348471249926;277.32886414876;278.7226709424123;5369.114096174127;5409.188621706741;5442.482964118412;5454.372747134081;5557.027520183967;5422.75597598108;5452.073147564914;5488.91766623501;5578.30271216098;5614.859628509289;4132.690048246379;4208.452901122865;4214.6838987075935;4219;4226.239276930151;4177.268977928866;4211.915761684764;4233.597808208216;4238.7032907696475;4259.6805239607;3910.8240129194114;4154.43915071466;4173.4157217989505;4190.811413486401;4204.747715137101;4093.7339072960312;4099.672026237894;4120.91758164835;4125.154343359604;4128.091819799639;3497.6327485613897;3502.4921386399083;3520.260745243502;3529.38235808735;3533.116720819795;5369.785208591652;5380.650257733235;5390.380106287748;5413.64811287269;5420.864478388033;4519.909601807945;4658.371119898804;4659.44086709597;4669.859904202879;4678.228092364756;5723.599348045638;5727.140928860705;5820.970895145497;5825.009748342792;5832.2418085649015;3843.6540711336115;3845.2309538092213;3873.5545412277665;3877.941830872539;3884.4561761353434;5999.100134979744;6015.729292181863;6033.276006879159;6077.088436734481;6090.512758979316;3752.5121734174927;3917.118648304109;3927.116398810245;3932.823022963916;3948.723589348718;3951.4665520154413;3969.761814291152;3986.5216174059296;3993.820278087493;3994.6404823566018;4662.463816661059;4677.462091859412;4686.5782079613;4702.1065997461055;4709.152352576569;5765.827025189251;5790.565707571949;5827.883442331215;5833.941660583425;5840.503557197686;1365.9795103073461;1393.8745512903683;1395.4418232706998;1399.6011136825955;1413.5123382433044;866.2117473099449;883.0727735877304;885.623609965762;896.090468174803;896.1441823058963;5438.91841622376;5440.564754819605;5482.506574408322;5521.061419558685;5531.059719847555;5962.403759624003;6004.579679422486;6074.574779765374;6075.939240607626;6077.118817771398;5470.863228419322;5481.890362192814;5483.533899618577;5512.724363781795;5542.39033706292;3132.577102091234;3232.563603913489;3246.366958443128;3283.326917981808;3301.108700650811;6133.3866613338305;6166.630002199882;6171.691415429211;6222.471089957314;6272.5922815016875;6156.29202641693;6252.562320637512;6256.5307601930035;6268.310485846553;6288.52836037299;6043.456088951927;6104.084387341934;6167.105769663373;6253.6873156342;6296.464800492009;6080.574359794772;6082.300535438481;6121.265448146251;6143.508519318354;6173.9073913892225;5971.104334349709;6004.42957918997;6008.098785182257;6010.429009244115;6028.2163318770035;6269.780557680459;6278.811635650938;6311.90532142009;6312.3056463788025;6323.936760632519;3937.9409308860963;4057.695672824609;4102.774347410802;4135.379693046068;4140.0891803803115;6014.1580178775885;6019.939800601938;6042;6042.274927008787;6050.818475445743;5805.8548536286935;5882.23530940975;5899.879022985619;5929.555283353679;5933.762649493972;5737.91393129095;5894.616849904743;5921.526277897844;5926.377730338425;5934.495567876779;5770.884582308414;5826.0387036140255;5827.155062515827;5833.416658334133;5849.034909239927;5884.6469211845715;5908.822735317947;5922.615030023035;5926.1999630049395;5934.732937017931;5585.664860108406;5682.943170568242;5713.685747283939;5796.855078623068;5851.244626612084 20:21:28 INFO - 2015-11-16 20:21:28,199 DEBUG : BROWSER_OUTPUT: |5;yui.html;636.6434796513953;638.8850006998741;638.9009703495957;663.8572706868023;669.0532895952226;11616.186866919319;11708.414579271044;12013.999999999989;12128.514859405614;12169.939150304235;11313.717157071056;11321.433928303593;11418.54325826966;11462.083033357332;11486.655400337982;615.7506209984963;631.4254028833763;752.8945947567331;769.8152443413568;780.2158830375465;734.8750712378882;768.5849641193777;769.1270408086806;778.1634742651644;781.8709912864399;805.6777289084355;813.040612077751;818.1327792539927;820.6676296100089;824.5918270456133;802.835418739157;802.9317508011768;811.1847593168857;811.4360519438992;814.5275740070745;599.2808629644401;599.553332767087;600.3486217454067;608.5192697768757;608.7625825927892;11615.477303521277;11693.415329233589;11745.706357341049;11817.881821181763;11875.940620296844;8230.62962166704;8730.956345218297;8815.77960550985;9716.174125199366;10499.73750656232;7611.847763044708;7772.844543109106;7918.287354138155;7988.400869934778;8101.351891848638;2578.432744796142;2658.734126587345;2682.758551730334;2721.877515511807;2778.8884446221473;40525;40659.390109148386;40834.79582602098;40868.59131408678;40927.590724092675;5620.1569764534825;5762.567807414461;5893.410658934158;5959.195508606283;5979.133025711248;10231.43727095002;10275.794484110425;10378.221633377527;10407.843882341771;10414.854366019732;5092.210707340369;5143.434222235551;5180.481951804864;5288.233206185082;5333.57331413486;3101.17818778024;3178.0465860241834;3208.8876889308763;3228.2413632796274;3251.869925203013;2253.3352660965056;2277.5558766040795;2285.611446054175;2294.586974344634;2297.368223738485;340.5861877818413;340.7291203493229;346.6983724159997;347.25340517886747;347.9304139172125;505.2244804225496;508.659198337115;516.9302144210559;528.5269683633204;552.2930648769582;7027.824304392431;7091.361777439952;7531.0209672743285;7736.497127686683;7755.573443460664;439.1918869280539;460.61078388761445;518.9662671926312;535.788363596385;593.2525018476664;3166.6200055992967;3291.769576129696;3326.4012477754236;3454.602720687153;3475.252820643523;51666.48333516692;51896;52742;53353.46646533562;53519;45551;45564.772176138904;45773.08453830905;45851.77074114608;47052;41892.58107418887;42571.36142957858;42576;42619.147617047485;42999.35500967488;6741;6834.829129271808;6896;7000.47496437759;7054.894176587458;30549.23626909345;31094.22264443407;31150.68849311478;31575;32029.359412811147;37593.43609845909;37702.62297376991;39384.80307598443;41290.79354603208;41605;8346.123657015925;8575.656973720981;8654.177853103945;8851.513166775889;8982.371234013557;9064.410813297114;9099.135582119688;9119.133682300171;9163.587638556148;9240.399374040666;8411.3270938326;8479.745607631781;8488.915110848813;8692.261157801659;8852.3803333766;8523.318134549098;8775.736727898173;8779.20987111163;8817.647294108421;9018.323625727966;8239;8399.622017009371;8661.566921654017;8676.219140277406;8790.868136978079;6474.838129046811;6527.2167339919515;6670.566413183127;6747.898781518379;6834.794956151323;6109.327973922954;6515.153030106246;6716.361945615159;6720.193576770819;6800.557963732342 20:21:28 INFO - 2015-11-16 20:21:28,199 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:21:28 INFO - 2015-11-16 20:21:28,199 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:21:28 INFO - 2015-11-16 20:21:28,199 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,293 20:21:28 INFO - 2015-11-16 20:21:28,200 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:21:28 INFO - 2015-11-16 20:21:28,200 DEBUG : BROWSER_OUTPUT: __startTimestamp1447734088183__endTimestamp 20:21:28 INFO - 2015-11-16 20:21:28,200 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,200 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:21:28 INFO - 2015-11-16 20:21:28,200 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:21:28 INFO - 2015-11-16 20:21:28,200 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,200 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4520.17 Median:4672.88 stddev:584.87 (12.5%) stddev-sans-first:567.22 20:21:28 INFO - 2015-11-16 20:21:28,201 DEBUG : BROWSER_OUTPUT: Values: 2613.6 2676.3 2713.8 2748.9 2768.2 4445.4 4591.9 4613.1 4622.3 4632.2 4425.6 4442.4 4524.7 4525.7 4598.1 4146.8 4253.5 4318.2 4326.7 4352.1 214.0 4132.9 4166.3 4306.8 4340.1 4241.3 4246.0 4281.3 4281.4 4316.7 4199.8 4225.6 4280.6 4283.6 4340.5 3977.3 4056.7 4068.7 4171.8 4290.2 4326.8 4521.4 4549.5 4558.6 4605.6 4831.6 4874.3 4888.3 4915.6 4939.1 4785.5 4876.3 4878.9 5015.7 5026.9 4591.6 4618.0 4631.7 4635.3 4652.5 4641.2 4965.2 5017.2 5035.6 5074.4 4685.0 4783.3 4832.0 4853.1 4859.6 4809.6 4897.2 4933.5 4945.1 4974.9 4657.9 4749.9 4882.8 4884.3 4918.5 4755.6 4785.8 4818.2 4853.1 4868.2 3795.6 3796.3 3845.6 3859.2 3907.5 3368.9 3443.4 3508.0 3541.2 3571.5 4552.8 4582.2 4658.9 4672.9 4705.6 4946.9 4982.0 4992.5 4999.5 5056.2 4432.0 4441.4 4543.0 4568.1 4570.1 4311.1 4313.2 4387.7 4388.1 4446.3 4939.5 4992.6 5013.4 5053.2 5122.3 4704.7 4803.6 4879.7 4905.1 4995.1 4954.1 4969.4 5005.7 5032.5 5103.4 4553.7 4807.6 4860.4 4867.2 4917.3 4523.2 4665.4 4675.8 4711.2 4784.9 4694.9 4731.4 4751.0 4775.4 4788.5 4708.8 4723.9 4746.5 4755.4 4793.4 4535.7 4697.8 4702.7 4711.0 4786.3 4735.4 4761.2 4773.4 4794.5 4898.7 4406.0 4543.7 4610.2 4677.1 4731.1 20:21:28 INFO - 2015-11-16 20:21:28,201 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,201 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41436.07 Median:35807.64 stddev:72390.45 (202.2%) stddev-sans-first:72528.23 20:21:28 INFO - 2015-11-16 20:21:28,201 DEBUG : BROWSER_OUTPUT: Values: 487.6 487.9 495.8 498.9 503.9 35358.5 36185.5 36418.6 36489.1 36605.6 37517.4 38744.4 38809.2 38915.6 39221.2 7821.5 7967.1 8076.3 8108.0 8165.5 7974.2 7986.0 8036.4 8139.7 8160.8 7957.1 7987.0 8019.7 8030.8 8062.8 7930.3 7975.6 7988.2 8030.0 8056.0 7959.8 8022.8 8080.5 8099.5 8145.9 35411.6 35557.0 35600.6 35659.6 35973.3 2161.0 2374.4 2478.5 2528.8 2708.9 24292.8 24444.6 24708.4 24719.6 24960.1 2027.7 2077.5 2078.3 2110.4 2122.1 212953.0 214644.0 215016.0 215873.0 217007.0 37874.6 38595.2 38673.8 52888.0 53246.2 36580.8 36723.8 36865.0 37003.8 37133.6 12098.1 12157.7 12168.9 12190.7 12196.4 9421.1 9524.1 9550.5 9557.8 9560.8 12610.1 12726.0 12772.7 12779.4 12811.9 5452.9 5588.0 5614.5 5687.7 5690.4 772.9 879.7 911.7 916.0 963.5 23751.0 24428.3 24534.5 24575.0 24587.3 934.7 956.0 956.9 974.7 1024.8 12322.6 12920.8 12947.0 12962.6 13011.7 343877.0 347965.0 349754.0 350081.0 351787.1 52161.0 52325.5 52342.0 52370.5 52537.5 1161.7 1168.2 1178.7 1201.3 1204.7 24170.8 24480.9 24510.3 24626.8 24693.9 41409.8 41783.0 41943.8 42003.4 42114.0 240965.0 242654.0 244003.0 244730.0 247285.0 28720.6 28748.6 39679.8 40958.0 41157.2 38007.0 38529.6 38589.6 38862.6 39511.2 31719.8 31979.7 32227.5 32808.5 33142.3 32195.7 32196.7 32426.7 32544.0 32931.3 33157.0 34941.0 35601.5 35955.6 36056.0 25921.2 27756.6 27801.2 27940.6 27995.7 21312.6 21442.1 21462.9 21766.9 21871.0 20:21:28 INFO - 2015-11-16 20:21:28,202 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,202 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24372.57 Median:2389.62 stddev:85209.69 (3565.8%) stddev-sans-first:85429.52 20:21:28 INFO - 2015-11-16 20:21:28,202 DEBUG : BROWSER_OUTPUT: Values: 278.4 285.4 287.6 292.4 293.4 8655.0 9094.1 15350.0 15668.8 15841.8 10067.8 10099.3 10340.5 10412.5 10530.4 3834.9 3924.0 3955.8 3958.4 3966.0 3804.5 3847.1 3868.0 3884.7 3902.5 3718.4 3836.7 3848.9 3857.9 3875.5 3851.4 3859.7 3865.7 3901.6 3904.9 3299.1 3317.1 3319.1 3336.0 3338.3 10663.2 11209.6 11211.1 11242.8 11300.9 1629.2 1647.6 1676.3 1684.3 1727.1 8339.4 8362.0 8483.8 8536.3 8706.0 1342.7 1359.9 1363.6 1381.4 1406.2 52983.0 53809.5 53942.2 54391.5 54585.5 5617.8 5639.2 5646.7 5744.0 5771.8 6117.8 6464.2 6501.5 6541.9 6543.6 4345.5 4349.3 4505.3 4589.7 4605.7 4798.4 4800.1 4834.9 4850.4 4881.5 2493.2 2549.7 2555.1 2571.2 2581.6 904.4 905.2 908.0 910.7 977.1 365.4 384.1 396.3 398.8 403.8 10047.5 10253.2 10348.6 10398.3 10472.2 384.2 392.9 395.6 400.2 415.5 5514.9 5604.8 5625.0 5644.4 5683.1 510959.0 511981.0 525550.0 526022.0 527230.0 60212.7 61295.0 62205.0 62293.7 63065.0 425.0 429.0 432.6 433.8 437.1 9464.6 9517.5 9571.2 9725.7 9754.6 28760.3 30153.7 30781.4 31090.5 31408.5 37195.4 37726.6 38424.8 38765.4 39066.2 5264.6 5389.1 5412.1 5413.8 5415.7 9894.4 10035.9 10254.0 10327.1 10350.2 8575.7 8754.3 8827.5 9033.8 9035.6 8508.4 8626.4 8651.4 8683.0 8738.5 8763.8 8772.9 8911.2 9034.1 9059.8 5215.4 5315.1 5331.0 5343.4 5393.8 8511.8 8758.5 8790.6 8823.9 8875.5 20:21:28 INFO - 2015-11-16 20:21:28,202 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,202 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4564.71 Median:5792.28 stddev:2352.83 (40.6%) stddev-sans-first:2347.82 20:21:28 INFO - 2015-11-16 20:21:28,204 DEBUG : BROWSER_OUTPUT: Values: 1455.6 1459.3 1517.7 1535.8 1559.4 5888.7 5937.1 6611.4 6787.5 6827.1 6478.3 6537.6 6574.5 6617.5 6708.6 1842.5 1874.7 1875.3 1883.4 1890.6 1902.6 1906.9 1930.3 1946.3 1960.5 1853.4 1880.6 1899.9 1903.5 1912.9 1841.6 1899.9 1909.2 1921.7 1930.3 1845.7 1865.6 1878.1 1888.4 1931.7 6586.6 6609.2 6636.5 6705.9 6713.2 3996.2 4050.6 4060.2 4094.9 4122.8 2102.5 2147.7 2352.1 2417.4 2422.5 739.1 747.1 748.5 759.9 778.8 8647.9 8668.6 8706.0 8775.0 8802.1 3623.4 3653.4 3706.9 3719.3 3723.2 7667.3 7670.9 7676.0 7692.0 7718.3 4091.5 4109.2 4139.8 4147.2 4149.9 3714.6 3733.8 3773.5 3787.0 3792.0 3065.7 3105.7 3110.0 3131.2 3147.9 986.1 989.6 989.7 997.9 998.2 1116.1 1137.2 1139.1 1143.3 1163.5 6152.5 6214.7 6276.0 6340.2 6340.4 373.9 375.1 375.6 376.4 379.1 4898.0 4912.6 4992.4 4996.7 5005.6 7116.4 7193.1 7388.9 7567.8 7664.5 7674.1 7674.2 7699.4 7702.0 7843.0 6138.6 6176.7 6244.0 6251.6 6286.9 5873.9 5957.3 5972.4 5978.1 5996.1 6620.4 6846.5 6859.7 6887.9 6968.7 6938.8 7064.9 7102.4 7108.2 7265.8 5686.2 5740.6 5818.5 5823.9 5848.1 6266.5 6270.9 6311.8 6313.4 6315.6 5731.5 5815.6 5945.5 5945.6 6050.0 5484.2 5690.4 5769.4 5815.2 5917.7 5872.4 5900.5 5967.4 5990.1 5994.3 5391.8 5409.0 5445.1 5459.1 5462.3 5395.6 5441.7 5463.1 5474.2 5576.0 20:21:28 INFO - 2015-11-16 20:21:28,204 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,204 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4845.33 Median:5536.73 stddev:1511.02 (27.3%) stddev-sans-first:1475.69 20:21:28 INFO - 2015-11-16 20:21:28,205 DEBUG : BROWSER_OUTPUT: Values: 268.6 273.2 275.2 277.3 278.7 5369.1 5409.2 5442.5 5454.4 5557.0 5422.8 5452.1 5488.9 5578.3 5614.9 4132.7 4208.5 4214.7 4219.0 4226.2 4177.3 4211.9 4233.6 4238.7 4259.7 3910.8 4154.4 4173.4 4190.8 4204.7 4093.7 4099.7 4120.9 4125.2 4128.1 3497.6 3502.5 3520.3 3529.4 3533.1 5369.8 5380.7 5390.4 5413.6 5420.9 4519.9 4658.4 4659.4 4669.9 4678.2 5723.6 5727.1 5821.0 5825.0 5832.2 3843.7 3845.2 3873.6 3877.9 3884.5 5999.1 6015.7 6033.3 6077.1 6090.5 3752.5 3917.1 3927.1 3932.8 3948.7 3951.5 3969.8 3986.5 3993.8 3994.6 4662.5 4677.5 4686.6 4702.1 4709.2 5765.8 5790.6 5827.9 5833.9 5840.5 1366.0 1393.9 1395.4 1399.6 1413.5 866.2 883.1 885.6 896.1 896.1 5438.9 5440.6 5482.5 5521.1 5531.1 5962.4 6004.6 6074.6 6075.9 6077.1 5470.9 5481.9 5483.5 5512.7 5542.4 3132.6 3232.6 3246.4 3283.3 3301.1 6133.4 6166.6 6171.7 6222.5 6272.6 6156.3 6252.6 6256.5 6268.3 6288.5 6043.5 6104.1 6167.1 6253.7 6296.5 6080.6 6082.3 6121.3 6143.5 6173.9 5971.1 6004.4 6008.1 6010.4 6028.2 6269.8 6278.8 6311.9 6312.3 6323.9 3937.9 4057.7 4102.8 4135.4 4140.1 6014.2 6019.9 6042.0 6042.3 6050.8 5805.9 5882.2 5899.9 5929.6 5933.8 5737.9 5894.6 5921.5 5926.4 5934.5 5770.9 5826.0 5827.2 5833.4 5849.0 5884.6 5908.8 5922.6 5926.2 5934.7 5585.7 5682.9 5713.7 5796.9 5851.2 20:21:28 INFO - 2015-11-16 20:21:28,206 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,206 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11521.16 Median:5691.36 stddev:14431.39 (253.6%) stddev-sans-first:14448.73 20:21:28 INFO - 2015-11-16 20:21:28,207 DEBUG : BROWSER_OUTPUT: Values: 636.6 638.9 638.9 663.9 669.1 11616.2 11708.4 12014.0 12128.5 12169.9 11313.7 11321.4 11418.5 11462.1 11486.7 615.8 631.4 752.9 769.8 780.2 734.9 768.6 769.1 778.2 781.9 805.7 813.0 818.1 820.7 824.6 802.8 802.9 811.2 811.4 814.5 599.3 599.6 600.3 608.5 608.8 11615.5 11693.4 11745.7 11817.9 11875.9 8230.6 8731.0 8815.8 9716.2 10499.7 7611.8 7772.8 7918.3 7988.4 8101.4 2578.4 2658.7 2682.8 2721.9 2778.9 40525.0 40659.4 40834.8 40868.6 40927.6 5620.2 5762.6 5893.4 5959.2 5979.1 10231.4 10275.8 10378.2 10407.8 10414.9 5092.2 5143.4 5180.5 5288.2 5333.6 3101.2 3178.0 3208.9 3228.2 3251.9 2253.3 2277.6 2285.6 2294.6 2297.4 340.6 340.7 346.7 347.3 347.9 505.2 508.7 516.9 528.5 552.3 7027.8 7091.4 7531.0 7736.5 7755.6 439.2 460.6 519.0 535.8 593.3 3166.6 3291.8 3326.4 3454.6 3475.3 51666.5 51896.0 52742.0 53353.5 53519.0 45551.0 45564.8 45773.1 45851.8 47052.0 41892.6 42571.4 42576.0 42619.1 42999.4 6741.0 6834.8 6896.0 7000.5 7054.9 30549.2 31094.2 31150.7 31575.0 32029.4 37593.4 37702.6 39384.8 41290.8 41605.0 8346.1 8575.7 8654.2 8851.5 8982.4 9064.4 9099.1 9119.1 9163.6 9240.4 8411.3 8479.7 8488.9 8692.3 8852.4 8523.3 8775.7 8779.2 8817.6 9018.3 8239.0 8399.6 8661.6 8676.2 8790.9 6474.8 6527.2 6670.6 6747.9 6834.8 6109.3 6515.2 6716.4 6720.2 6800.6 20:21:28 INFO - 2015-11-16 20:21:28,207 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:21:28 INFO - 2015-11-16 20:21:28,207 DEBUG : BROWSER_OUTPUT: 20:21:28 INFO - 2015-11-16 20:21:28,839 INFO : Browser exited with error code: 0 20:21:28 INFO - 2015-11-16 20:21:28,872 INFO : Completed test dromaeo_css (00:18:30) 20:21:28 INFO - 2015-11-16 20:21:28,873 INFO : Starting test kraken 20:21:28 INFO - 2015-11-16 20:21:28,873 DEBUG : operating with platform_type : mac_ 20:21:28 INFO - 2015-11-16 20:21:28,873 INFO : Initialising browser for kraken test... 20:21:28 INFO - 2015-11-16 20:21:28,888 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmpQKJxJP/profile http://localhost:54775/getInfo.html 20:21:32 INFO - 2015-11-16 20:21:32,102 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:21:32 INFO - 2015-11-16 20:21:32,102 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:21:32 INFO - 2015-11-16 20:21:32,103 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 20:21:32 INFO - 2015-11-16 20:21:32,103 DEBUG : BROWSER_OUTPUT: __metrics 20:21:32 INFO - 2015-11-16 20:21:32,826 INFO : Browser initialized. 20:21:32 INFO - 2015-11-16 20:21:32,826 INFO : Running cycle 1/1 for kraken test... 20:21:32 INFO - 2015-11-16 20:21:32,827 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmpQKJxJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:21:45 INFO - 2015-11-16 20:21:45,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 241209344 20:21:45 INFO - 2015-11-16 20:21:45,060 DEBUG : BROWSER_OUTPUT: 20:21:47 INFO - 2015-11-16 20:21:47,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54775/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:48 INFO - 2015-11-16 20:21:48,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 259719168 20:21:48 INFO - 2015-11-16 20:21:48,522 DEBUG : BROWSER_OUTPUT: 20:21:51 INFO - 2015-11-16 20:21:51,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54775/tests/kraken/driver.html?testName=audio-dft) 20:21:52 INFO - 2015-11-16 20:21:52,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 267767808 20:21:52 INFO - 2015-11-16 20:21:52,143 DEBUG : BROWSER_OUTPUT: 20:21:55 INFO - 2015-11-16 20:21:55,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54775/tests/kraken/driver.html?testName=audio-fft) 20:21:55 INFO - 2015-11-16 20:21:55,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 267034624 20:21:55 INFO - 2015-11-16 20:21:55,999 DEBUG : BROWSER_OUTPUT: 20:21:58 INFO - 2015-11-16 20:21:58,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54775/tests/kraken/driver.html?testName=audio-oscillator) 20:21:58 INFO - 2015-11-16 20:21:58,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 267345920 20:21:58 INFO - 2015-11-16 20:21:58,766 DEBUG : BROWSER_OUTPUT: 20:22:01 INFO - 2015-11-16 20:22:01,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:22:01 INFO - 2015-11-16 20:22:01,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 267988992 20:22:01 INFO - 2015-11-16 20:22:01,730 DEBUG : BROWSER_OUTPUT: 20:22:05 INFO - 2015-11-16 20:22:05,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54775/tests/kraken/driver.html?testName=imaging-darkroom) 20:22:05 INFO - 2015-11-16 20:22:05,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 269250560 20:22:05 INFO - 2015-11-16 20:22:05,768 DEBUG : BROWSER_OUTPUT: 20:22:09 INFO - 2015-11-16 20:22:09,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54775/tests/kraken/driver.html?testName=imaging-desaturate) 20:22:09 INFO - 2015-11-16 20:22:09,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 266194944 20:22:09 INFO - 2015-11-16 20:22:09,920 DEBUG : BROWSER_OUTPUT: 20:22:13 INFO - 2015-11-16 20:22:13,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54775/tests/kraken/driver.html?testName=json-parse-financial) 20:22:13 INFO - 2015-11-16 20:22:13,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 267210752 20:22:13 INFO - 2015-11-16 20:22:13,736 DEBUG : BROWSER_OUTPUT: 20:22:15 INFO - 2015-11-16 20:22:15,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:22:16 INFO - 2015-11-16 20:22:16,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 267808768 20:22:16 INFO - 2015-11-16 20:22:16,109 DEBUG : BROWSER_OUTPUT: 20:22:18 INFO - 2015-11-16 20:22:18,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54775/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:22:18 INFO - 2015-11-16 20:22:18,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 268144640 20:22:18 INFO - 2015-11-16 20:22:18,775 DEBUG : BROWSER_OUTPUT: 20:22:21 INFO - 2015-11-16 20:22:21,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:22:21 INFO - 2015-11-16 20:22:21,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 268271616 20:22:21 INFO - 2015-11-16 20:22:21,696 DEBUG : BROWSER_OUTPUT: 20:22:24 INFO - 2015-11-16 20:22:24,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:22:25 INFO - 2015-11-16 20:22:25,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 268111872 20:22:25 INFO - 2015-11-16 20:22:25,244 DEBUG : BROWSER_OUTPUT: 20:22:28 INFO - 2015-11-16 20:22:28,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:22:28 INFO - 2015-11-16 20:22:28,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 267837440 20:22:28 INFO - 2015-11-16 20:22:28,766 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54775/tests/kraken/driver.html?testName=ai-astar) 20:22:30 INFO - 2015-11-16 20:22:30,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 269275136 20:22:30 INFO - 2015-11-16 20:22:30,904 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,904 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:22:30 INFO - 2015-11-16 20:22:30,904 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:22:30 INFO - 2015-11-16 20:22:30,904 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:22:30 INFO - 2015-11-16 20:22:30,904 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:22:30 INFO - 2015-11-16 20:22:30,905 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;124;135;134;129;139;133;136;132;128 20:22:30 INFO - 2015-11-16 20:22:30,905 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;180;162;185;195;158;182;180;156;199;157 20:22:30 INFO - 2015-11-16 20:22:30,905 DEBUG : BROWSER_OUTPUT: |2;audio-dft;191;204;206;199;201;195;194;202;205;195 20:22:30 INFO - 2015-11-16 20:22:30,905 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;90;99;149;81;85;84;87;117;82 20:22:30 INFO - 2015-11-16 20:22:30,905 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;103;105;153;107;110;111;152;105;105;150 20:22:30 INFO - 2015-11-16 20:22:30,905 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;142;149;136;150;142;143;149;149;136 20:22:30 INFO - 2015-11-16 20:22:30,905 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;158;157;156;150;157;156;151;157;156;150 20:22:30 INFO - 2015-11-16 20:22:30,905 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;127;118;136;125;122;118;118;119;127 20:22:30 INFO - 2015-11-16 20:22:30,906 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;75;78;80;83;80;81;88;78;81 20:22:30 INFO - 2015-11-16 20:22:30,906 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;83;84;87;87;89;88;86;86;86 20:22:30 INFO - 2015-11-16 20:22:30,906 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;101;107;108;108;109;106;107;103;106;103 20:22:30 INFO - 2015-11-16 20:22:30,906 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;153;162;158;166;159;157;153;170;167;165 20:22:30 INFO - 2015-11-16 20:22:30,906 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;169;188;189;188;181;180;181;187;192;168 20:22:30 INFO - 2015-11-16 20:22:30,906 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;85;87;89;88;88;91;88;89;84 20:22:30 INFO - 2015-11-16 20:22:30,907 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:22:30 INFO - 2015-11-16 20:22:30,907 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:22:30 INFO - 2015-11-16 20:22:30,907 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,744 20:22:30 INFO - 2015-11-16 20:22:30,907 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:22:30 INFO - 2015-11-16 20:22:30,907 DEBUG : BROWSER_OUTPUT: __startTimestamp1447734150901__endTimestamp 20:22:30 INFO - 2015-11-16 20:22:30,907 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,908 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:22:30 INFO - 2015-11-16 20:22:30,908 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:22:30 INFO - 2015-11-16 20:22:30,908 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,908 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:131.70 Median:133.50 stddev:4.62 (3.5%) stddev-sans-first:4.58 20:22:30 INFO - 2015-11-16 20:22:30,908 DEBUG : BROWSER_OUTPUT: Values: 127.0 124.0 135.0 134.0 129.0 139.0 133.0 136.0 132.0 128.0 20:22:30 INFO - 2015-11-16 20:22:30,908 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,910 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:175.40 Median:181.00 stddev:16.04 (8.9%) stddev-sans-first:16.93 20:22:30 INFO - 2015-11-16 20:22:30,910 DEBUG : BROWSER_OUTPUT: Values: 180.0 162.0 185.0 195.0 158.0 182.0 180.0 156.0 199.0 157.0 20:22:30 INFO - 2015-11-16 20:22:30,910 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,911 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:199.20 Median:201.50 stddev:5.20 (2.6%) stddev-sans-first:4.59 20:22:30 INFO - 2015-11-16 20:22:30,911 DEBUG : BROWSER_OUTPUT: Values: 191.0 204.0 206.0 199.0 201.0 195.0 194.0 202.0 205.0 195.0 20:22:30 INFO - 2015-11-16 20:22:30,911 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,911 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:95.90 Median:85.00 stddev:21.56 (25.4%) stddev-sans-first:22.50 20:22:30 INFO - 2015-11-16 20:22:30,911 DEBUG : BROWSER_OUTPUT: Values: 85.0 90.0 99.0 149.0 81.0 85.0 84.0 87.0 117.0 82.0 20:22:30 INFO - 2015-11-16 20:22:30,911 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,911 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:120.10 Median:110.50 stddev:21.93 (19.8%) stddev-sans-first:22.37 20:22:30 INFO - 2015-11-16 20:22:30,912 DEBUG : BROWSER_OUTPUT: Values: 103.0 105.0 153.0 107.0 110.0 111.0 152.0 105.0 105.0 150.0 20:22:30 INFO - 2015-11-16 20:22:30,912 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,912 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.80 Median:146.00 stddev:5.29 (3.6%) stddev-sans-first:5.57 20:22:30 INFO - 2015-11-16 20:22:30,912 DEBUG : BROWSER_OUTPUT: Values: 142.0 142.0 149.0 136.0 150.0 142.0 143.0 149.0 149.0 136.0 20:22:30 INFO - 2015-11-16 20:22:30,912 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,912 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.80 Median:156.50 stddev:3.16 (2.0%) stddev-sans-first:3.13 20:22:30 INFO - 2015-11-16 20:22:30,913 DEBUG : BROWSER_OUTPUT: Values: 158.0 157.0 156.0 150.0 157.0 156.0 151.0 157.0 156.0 150.0 20:22:30 INFO - 2015-11-16 20:22:30,913 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,913 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:122.80 Median:123.50 stddev:5.98 (4.8%) stddev-sans-first:6.08 20:22:30 INFO - 2015-11-16 20:22:30,913 DEBUG : BROWSER_OUTPUT: Values: 118.0 127.0 118.0 136.0 125.0 122.0 118.0 118.0 119.0 127.0 20:22:30 INFO - 2015-11-16 20:22:30,913 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,913 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:79.90 Median:80.50 stddev:3.84 (4.8%) stddev-sans-first:3.64 20:22:30 INFO - 2015-11-16 20:22:30,914 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 78.0 80.0 83.0 80.0 81.0 88.0 78.0 81.0 20:22:30 INFO - 2015-11-16 20:22:30,914 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,914 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:85.60 Median:86.50 stddev:2.63 (3.0%) stddev-sans-first:1.86 20:22:30 INFO - 2015-11-16 20:22:30,914 DEBUG : BROWSER_OUTPUT: Values: 80.0 83.0 84.0 87.0 87.0 89.0 88.0 86.0 86.0 86.0 20:22:30 INFO - 2015-11-16 20:22:30,914 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,915 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.80 Median:107.00 stddev:2.62 (2.4%) stddev-sans-first:2.12 20:22:30 INFO - 2015-11-16 20:22:30,915 DEBUG : BROWSER_OUTPUT: Values: 101.0 107.0 108.0 108.0 109.0 106.0 107.0 103.0 106.0 103.0 20:22:30 INFO - 2015-11-16 20:22:30,915 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,915 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:161.00 Median:163.50 stddev:5.93 (3.6%) stddev-sans-first:5.53 20:22:30 INFO - 2015-11-16 20:22:30,915 DEBUG : BROWSER_OUTPUT: Values: 153.0 162.0 158.0 166.0 159.0 157.0 153.0 170.0 167.0 165.0 20:22:30 INFO - 2015-11-16 20:22:30,915 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,915 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:187.50 stddev:8.27 (4.4%) stddev-sans-first:7.24 20:22:30 INFO - 2015-11-16 20:22:30,917 DEBUG : BROWSER_OUTPUT: Values: 169.0 188.0 189.0 188.0 181.0 180.0 181.0 187.0 192.0 168.0 20:22:30 INFO - 2015-11-16 20:22:30,917 DEBUG : BROWSER_OUTPUT: 20:22:30 INFO - 2015-11-16 20:22:30,917 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.70 Median:88.00 stddev:3.65 (4.2%) stddev-sans-first:2.12 20:22:30 INFO - 2015-11-16 20:22:30,917 DEBUG : BROWSER_OUTPUT: Values: 78.0 85.0 87.0 89.0 88.0 88.0 91.0 88.0 89.0 84.0 20:22:30 INFO - 2015-11-16 20:22:30,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:22:30 INFO - 2015-11-16 20:22:30,917 DEBUG : BROWSER_OUTPUT: 20:22:31 INFO - 2015-11-16 20:22:31,628 INFO : Browser exited with error code: 0 20:22:31 INFO - 2015-11-16 20:22:31,682 INFO : Completed test kraken (00:01:02) 20:22:31 INFO - 2015-11-16 20:22:31,682 INFO : Starting test v8_7 20:22:31 INFO - 2015-11-16 20:22:31,682 DEBUG : operating with platform_type : mac_ 20:22:31 INFO - 2015-11-16 20:22:31,682 INFO : Initialising browser for v8_7 test... 20:22:31 INFO - 2015-11-16 20:22:31,698 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmpgH9L39/profile http://localhost:54775/getInfo.html 20:22:34 INFO - 2015-11-16 20:22:34,848 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:22:34 INFO - 2015-11-16 20:22:34,848 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:22:34 INFO - 2015-11-16 20:22:34,848 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 20:22:34 INFO - 2015-11-16 20:22:34,848 DEBUG : BROWSER_OUTPUT: __metrics 20:22:35 INFO - 2015-11-16 20:22:35,540 INFO : Browser initialized. 20:22:35 INFO - 2015-11-16 20:22:35,540 INFO : Running cycle 1/1 for v8_7 test... 20:22:35 INFO - 2015-11-16 20:22:35,541 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmpgH9L39/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:22:47 INFO - 2015-11-16 20:22:47,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 241926144 20:22:47 INFO - 2015-11-16 20:22:47,740 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54775/tests/v8_7/run.html (next: http://localhost:54775/tests/v8_7/run.html) 20:23:10 INFO - 2015-11-16 20:23:10,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 257245184 20:23:10 INFO - 2015-11-16 20:23:10,649 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: |0;Richards;190.83969465648855 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;227.89425706472196 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: |2;Encrypt;368.3241252302026 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7299.270072992701 20:23:10 INFO - 2015-11-16 20:23:10,650 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1303.7809647979138 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: |5;Earley;1037.3056994818653 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: |6;Boyer;15149.253731343284 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: |7;RegExp;33540.983606557376 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: |8;Splay;889.8305084745763 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6622.516556291391 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: __startTimestamp1447734190647__endTimestamp 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,651 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.84 Median:190.84 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: Values: 190.8 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:227.89 Median:227.89 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: Values: 227.9 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:368.32 Median:368.32 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,652 DEBUG : BROWSER_OUTPUT: Values: 368.3 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7299.27 Median:7299.27 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: Values: 7299.3 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1303.78 Median:1303.78 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: Values: 1303.8 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1037.31 Median:1037.31 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: Values: 1037.3 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15149.25 Median:15149.25 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: Values: 15149.3 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,653 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33540.98 Median:33540.98 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: Values: 33541.0 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:889.83 Median:889.83 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: Values: 889.8 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6622.52 Median:6622.52 stddev:0.00 (0.0%) 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: Values: 6622.5 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:23:10 INFO - 2015-11-16 20:23:10,654 DEBUG : BROWSER_OUTPUT: 20:23:11 INFO - 2015-11-16 20:23:11,371 INFO : Browser exited with error code: 0 20:23:11 INFO - 2015-11-16 20:23:11,394 INFO : Completed test v8_7 (00:00:39) 20:23:11 INFO - 2015-11-16 20:23:11,591 INFO : Completed test suite (00:20:13) 20:23:11 INFO - 2015-11-16 20:23:11,592 DEBUG : Working with test: dromaeo_css 20:23:11 INFO - 2015-11-16 20:23:11,592 DEBUG : Generating results file: dromaeo_css 20:23:11 INFO - 2015-11-16 20:23:11,593 DEBUG : Working with test: kraken 20:23:11 INFO - 2015-11-16 20:23:11,593 DEBUG : Generating results file: kraken 20:23:11 INFO - 2015-11-16 20:23:11,593 INFO : javascript benchmark 20:23:11 INFO - 2015-11-16 20:23:11,593 DEBUG : Working with test: v8_7 20:23:11 INFO - 2015-11-16 20:23:11,593 DEBUG : Generating results file: v8_7 20:23:11 INFO - 2015-11-16 20:23:11,594 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:11 INFO - 2015-11-16 20:23:11,647 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 20:23:11 INFO - 2015-11-16 20:23:11,648 DEBUG : process_Request line: dromaeo_css 5646.16 graph.html#tests=[[72,63,57]] 20:23:11 INFO - 2015-11-16 20:23:11,648 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:11 INFO - 2015-11-16 20:23:11,675 DEBUG : process_Request line: kraken 1845.00 graph.html#tests=[[232,63,57]] 20:23:11 INFO - 2015-11-16 20:23:11,675 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:11 INFO - 2015-11-16 20:23:11,707 DEBUG : process_Request line: v8_7 16312.41 graph.html#tests=[[230,63,57]] 20:23:11 INFO - 2015-11-16 20:23:11,708 INFO : javascript benchmark 20:23:11 INFO - 2015-11-16 20:23:11,710 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [278.36671572173316, 285.4419609663108, 287.61316029939735, 292.37140148680334, 293.39267715828237, 8655.0, 9094.090590940903, 15350.0, 15668.764968525467, 15841.762373564407, 10067.791864976194, 10099.343542669722, 10340.534675939582, 10412.479376031188, 10530.42082685452, 3834.884953451401, 3923.98038009811, 3955.8417663293435, 3958.445817585526, 3965.9801700991457, 3804.524434445694, 3847.1343947611845, 3867.9613203867884, 3884.7086468514835, 3902.5316961964463, 3718.4236443351324, 3836.673882719972, 3848.903777405559, 3857.9421308680394, 3875.4961854958815, 3851.441540976543, 3859.671927886133, 3865.6714179294795, 3901.648851603341, 3904.863329783458, 3299.059767966118, 3317.08780085476, 3319.0872510059685, 3335.96664033359, 3338.2989572189867, 10663.200259980533, 11209.607663731811, 11211.103111751041, 11242.775144497145, 11300.926411990848, 1629.2016911713295, 1647.6045749020268, 1676.287577779451, 1684.3431061885874, 1727.1450631937146, 8339.416240863142, 8361.95819020901, 8483.830323393559, 8536.27441667459, 8706.0, 1342.7314537092523, 1359.9184048956995, 1363.5909227231791, 1381.4336122189854, 1406.1914399220489, 52983.0, 53809.461905380835, 53942.190867137026, 54391.45608543904, 54585.45414545883, 5617.803376881871, 5639.210510528529, 5646.745896434671, 5743.971280143573, 5771.826845194651, 6117.785877494355, 6464.159659244268, 6501.544891857619, 6541.934580654228, 6543.607383557001, 4345.456817897762, 4349.3041113421705, 4505.256632655641, 4589.747563883951, 4605.6776025678555, 4798.4001999750035, 4800.06398752247, 4834.879128021757, 4850.442199147073, 4881.487443818419, 2493.1772515069983, 2549.7195308516048, 2555.0546297869905, 2571.1643715792443, 2581.57404028337, 904.3992133922919, 905.1898550797132, 907.9682211122579, 910.6767097680361, 977.0669011094387, 365.4408754605458, 384.1452767592141, 396.3499860229226, 398.8005997001441, 403.7960829780942, 10047.497625118714, 10253.179745620333, 10348.637797677045, 10398.324108932895, 10472.16222702182, 384.24687612280246, 392.8526802449082, 395.58068447445226, 400.2355500993089, 415.5408273857344, 5514.889702206014, 5604.8318550443555, 5624.971875140598, 5644.379118296984, 5683.090705487102, 510959.0, 511981.0, 525550.0, 526022.0, 527230.0, 60212.69893650504, 61295.0, 62205.0, 62293.688531557054, 63065.0, 424.95325514193416, 428.95067067287664, 432.6430694676904, 433.7766050484003, 437.14319932931176, 9464.621415143318, 9517.524123793644, 9571.234301255743, 9725.708228753148, 9754.609815607297, 28760.280992975342, 30153.698463015087, 30781.38437231198, 31090.53364199584, 31408.528872067393, 37195.442068369535, 37726.62273377231, 38424.80787596044, 38765.41851872168, 39066.21867562576, 5264.6314757966575, 5389.110796718497, 5412.052890744026, 5413.83758487246, 5415.729213539386, 9894.406335619886, 10035.899641003496, 10253.974602539687, 10327.070563649308, 10350.171986241234, 8575.656973720981, 8754.299656027375, 8827.514486703036, 9033.780439640565, 9035.638574456949, 8508.446950948168, 8626.39615226928, 8651.351148664002, 8683.0, 8738.519381434082, 8763.780905477159, 8772.868406974028, 8911.15344042315, 9034.096590340914, 9059.773505662411, 5215.4002289735645, 5315.149576067811, 5330.973345133405, 5343.385510666168, 5393.83818485446, 8511.829763404821, 8758.47449153053, 8790.604422800861, 8823.867641985247, 8875.511846848485], "dojo.html": [2613.621024951382, 2676.3041609181605, 2713.81003329767, 2748.8900443982234, 2768.1833859011576, 4445.3998710174155, 4591.88520286993, 4613.054323863608, 4622.260438329868, 4632.166210082184, 4425.579569940858, 4442.444694413199, 4524.660650451213, 4525.705829121105, 4598.057398233363, 4146.751194928314, 4253.510846252674, 4318.157959197958, 4326.697131200817, 4352.064306174172, 213.95198576091624, 4132.896677583054, 4166.312558427856, 4306.80619372129, 4340.066885619591, 4241.321388577828, 4245.957540424587, 4281.336392859112, 4281.357796330544, 4316.6978311518205, 4199.790010499462, 4225.619694227535, 4280.614744672995, 4283.635890949273, 4340.500842403132, 3977.3238549446664, 4056.655184309337, 4068.7355321903983, 4171.791410429466, 4290.249206388869, 4326.783660816946, 4521.412216411878, 4549.47681016684, 4558.612517935946, 4605.608523275526, 4831.613470922318, 4874.268859671078, 4888.340074090023, 4915.606751459911, 4939.135651261051, 4785.521447855222, 4876.341693871317, 4878.853634390974, 5015.673981191211, 5026.874328141789, 4591.632669386475, 4618.0, 4631.652626053059, 4635.258358662598, 4652.511486293958, 4641.2109941310055, 4965.230389289666, 5017.247412888023, 5035.597152227813, 5074.416442109131, 4684.976575117103, 4783.258594917794, 4831.95168048322, 4853.126437241331, 4859.586935110485, 4809.639277054235, 4897.240927656219, 4933.531314525186, 4945.109880221523, 4974.875628109254, 4657.906841863144, 4749.928751068736, 4882.755862206946, 4884.267359896044, 4918.532739389752, 4755.619550435957, 4785.832495862698, 4818.229083346648, 4853.126437241331, 4868.172410690191, 3795.5635101963076, 3796.297684928242, 3845.615438456132, 3859.1895701902913, 3907.5115610548683, 3368.882089126918, 3443.3974054540354, 3508.0, 3541.15012397028, 3571.4642803579673, 4552.795124219418, 4582.175208462442, 4658.883527911829, 4672.883177920579, 4705.60002399793, 4946.925796113062, 4982.0, 4992.475790041994, 4999.525045120708, 5056.241563765465, 4432.0, 4441.356003379492, 4542.954570454319, 4568.109218702321, 4570.108828778356, 4311.07311927937, 4313.223619748475, 4387.692861499664, 4388.05656783793, 4446.333050042519, 4939.456659767423, 4992.550670439678, 5013.3983921928875, 5053.166227572483, 5122.334096567422, 4704.670673052853, 4803.567678908915, 4879.731614761222, 4905.117078925685, 4995.125852975787, 4954.108260513142, 4969.428515720739, 5005.674631148963, 5032.547070763649, 5103.387593488805, 4553.704009239389, 4807.591354734886, 4860.441049279378, 4867.172580661367, 4917.28699338601, 4523.23105072132, 4665.393498845128, 4675.836345727883, 4711.1519926413575, 4784.880377990578, 4694.882627934329, 4731.3612662291525, 4751.049790041936, 4775.42694876617, 4788.473267940593, 4708.764561771966, 4723.905521889612, 4746.5490778376, 4755.38180036593, 4793.448753393404, 4535.727856328631, 4697.8355757548325, 4702.717836929795, 4710.952890471051, 4786.282057691375, 4735.408073990751, 4761.16679581065, 4773.355596994361, 4794.472608013186, 4898.657094003528, 4406.0, 4543.65922555803, 4610.239310513728, 4677.064587082665, 4731.077439899324], "mootools.html": [1455.5633310006995, 1459.3068292561031, 1517.6964607078587, 1535.8464153584644, 1559.4230134850104, 5888.676122813244, 5937.109433584965, 6611.4049735523795, 6787.457003439719, 6827.146606674166, 6478.319776423478, 6537.575057621251, 6574.506911981596, 6617.503687223453, 6708.597484150954, 1842.4933143385542, 1874.7469091672585, 1875.3342563390004, 1883.3690713610956, 1890.5840715042737, 1902.590942947266, 1906.856985726069, 1930.2664987304804, 1946.2506934830121, 1960.549073713047, 1853.4439668099583, 1880.6238752249606, 1899.8575106866972, 1903.4765439504108, 1912.8756630818953, 1841.640880028395, 1899.8955057471903, 1909.1885948471984, 1921.7117432385114, 1930.2954421636073, 1845.7323688065155, 1865.6082222733241, 1878.0985127138913, 1888.3673969220329, 1931.748872646561, 6586.637734924578, 6609.20689517261, 6636.502262330297, 6705.865882682368, 6713.227978782454, 3996.200759848013, 4050.5949405059555, 4060.20825938942, 4094.9385759213637, 4122.835086596562, 2102.495401103724, 2147.70064111212, 2352.141468364052, 2417.431903502693, 2422.454947636785, 739.1056821246299, 747.0698979770167, 748.494766032931, 759.8556274307864, 778.7897267737679, 8647.870281945712, 8668.60991255395, 8706.04233534317, 8775.0, 8802.075782042857, 3623.384024715752, 3653.415453527423, 3706.8887933362043, 3719.274741425396, 3723.1809002020054, 7667.348275396542, 7670.923290767132, 7676.0, 7692.0, 7718.266764657348, 4091.5499295077516, 4109.198706252252, 4139.751614903055, 4147.212029714405, 4149.896252593649, 3714.57282412526, 3733.775973441602, 3773.5471743390967, 3786.9964459418275, 3791.9810400947817, 3065.6781037991136, 3105.6894310568764, 3109.9533506997413, 3131.1858916681826, 3147.937041259208, 986.1371300112402, 989.6239429016928, 989.7129832348683, 997.9002099789963, 998.1964518562627, 1116.1182665694173, 1137.2096393006946, 1139.1228753859482, 1143.2968724234536, 1163.4938801621322, 6152.507799376039, 6214.689265536705, 6276.0, 6340.239171299474, 6340.429361357407, 373.93456145174486, 375.14841310226177, 375.61687079179086, 376.4391057324621, 379.12233180187775, 4898.044881248194, 4912.582430493377, 4992.375953005874, 4996.7001979881325, 5005.599552035828, 7116.359527642537, 7193.100862392201, 7388.926110738931, 7567.810804729926, 7664.540127592362, 7674.117476490163, 7674.234925966947, 7699.422543309274, 7702.037245344332, 7842.960785196037, 6138.631682099089, 6176.6911654418, 6244.0321750128805, 6251.562390632612, 6286.9056964145575, 5873.94126058751, 5957.314908785545, 5972.402759723993, 5978.133170690313, 5996.130561068708, 6620.404163625104, 6846.4522838173825, 6859.725610975505, 6887.862242755217, 6968.65156742171, 6938.791836244921, 7064.894026589708, 7102.3962963148715, 7108.218096009538, 7265.818354541178, 5686.203931449518, 5740.598158129058, 5818.50542703858, 5823.883522329615, 5848.093545500455, 6266.530010249158, 6270.874582508415, 6311.810645680637, 6313.3686631336495, 6315.621062736251, 5731.455511726546, 5815.592908496534, 5945.524358051259, 5945.583809133319, 6049.971504844275, 5484.232207490874, 5690.374058853606, 5769.365369809401, 5815.185873977562, 5917.704114794157, 5872.354041055395, 5900.498457630978, 5967.37342579023, 5990.101484777319, 5994.28068631767, 5391.784328626811, 5409.0, 5445.101558243004, 5459.099248623933, 5462.262594549685, 5395.622306438669, 5441.7279136043835, 5463.125899856004, 5474.206240095244, 5575.99632066232], "ext.html": [487.6220928780195, 487.914614942385, 495.7769003948222, 498.9422424460145, 503.90425819094384, 35358.46962295564, 36185.45721814172, 36418.635813641886, 36489.087772805695, 36605.633943660556, 37517.437238441446, 38744.418833717515, 38809.22381552367, 38915.61084389162, 39221.21557568847, 7821.491603045798, 7967.123616402191, 8076.273135417811, 8108.0, 8165.510069395826, 7974.242446967529, 7986.041674999008, 8036.357091432671, 8139.715109971152, 8160.836783264331, 7957.084935232436, 7986.960065199666, 8019.719309824157, 8030.839383212332, 8062.798430039266, 7930.286274235317, 7975.561344126071, 7988.241117093896, 8030.0, 8056.033276006917, 7959.840803183962, 8022.799430014238, 8080.474769139987, 8099.514029158269, 8145.918540814575, 35411.5835366585, 35557.0, 35600.64399355999, 35659.64340356589, 35973.28053438917, 2161.0, 2374.3589230907733, 2478.529079474894, 2528.8103392245657, 2708.9458210835674, 24292.757072429227, 24444.633330500055, 24708.382290442703, 24719.62920556193, 24960.126395576248, 2027.7059826325249, 2077.470245087508, 2078.262216912989, 2110.4407332056862, 2122.0875023739786, 212953.0, 214644.0, 215016.0, 215873.0, 217007.0, 37874.62125378766, 38595.22809543793, 38673.80663096667, 52888.0, 53246.20130698042, 36580.81709591435, 36723.816380918455, 36865.0, 37003.81498092492, 37133.58631688932, 12098.092643051807, 12157.696057598454, 12168.939155304166, 12190.695232619255, 12196.39018049094, 9421.05789421066, 9524.095210954949, 9550.474723890253, 9557.808843823084, 9560.760980975392, 12610.117291789487, 12726.0, 12772.680682982815, 12779.361031948365, 12811.935940320238, 5452.91820622691, 5587.972060139673, 5614.466625670555, 5687.7156142192725, 5690.374058853523, 772.8531578999972, 879.6877108626474, 911.6900253913701, 916.0, 963.4508330251689, 23751.0, 24428.26715198547, 24534.50930981406, 24575.0, 24587.262382128563, 934.7429456899407, 955.9569819358006, 956.8803899512561, 974.6637410093506, 1024.7950409918046, 12322.568710095104, 12920.806187907188, 12947.0, 12962.611121666365, 13011.739765204642, 343877.0, 347965.0, 349754.0, 350081.0, 351787.0980966595, 52161.0, 52325.47674523282, 52342.0, 52370.476295236556, 52537.47462525326, 1161.651504548632, 1168.2348062019391, 1178.6994316449423, 1201.2672269915345, 1204.680759598707, 24170.758292417555, 24480.877595611906, 24510.264692059267, 24626.753732462446, 24693.87653061723, 41409.79295103505, 41783.0, 41943.79028104962, 42003.36994945017, 42114.0, 240965.0, 242654.0, 244003.0, 244730.0, 247285.0, 28720.569191461727, 28748.568771468028, 39679.801600991814, 40958.0, 41157.1768564633, 38007.0, 38529.614703853724, 38589.61410385973, 38862.6113738859, 39511.2097758049, 31719.84140079377, 31979.68020319767, 32227.516587251677, 32808.50787238146, 33142.337153257286, 32195.678043219268, 32196.678033220305, 32426.675733242366, 32544.0, 32931.34137317288, 33157.0, 34941.0, 35601.46597800983, 35955.64044359523, 36056.0, 25921.22236332913, 27756.583651244844, 27801.165965021082, 27940.58089128624, 27995.720042799312, 21312.573748525254, 21442.142314307253, 21462.892685536473, 21766.891165544705, 21871.0], "prototype.html": [268.5595623177988, 273.2090597719602, 275.2348471249926, 277.32886414876, 278.7226709424123, 5369.114096174127, 5409.188621706741, 5442.482964118412, 5454.372747134081, 5557.027520183967, 5422.75597598108, 5452.073147564914, 5488.91766623501, 5578.30271216098, 5614.859628509289, 4132.690048246379, 4208.452901122865, 4214.6838987075935, 4219.0, 4226.239276930151, 4177.268977928866, 4211.915761684764, 4233.597808208216, 4238.7032907696475, 4259.6805239607, 3910.8240129194114, 4154.43915071466, 4173.4157217989505, 4190.811413486401, 4204.747715137101, 4093.7339072960312, 4099.672026237894, 4120.91758164835, 4125.154343359604, 4128.091819799639, 3497.6327485613897, 3502.4921386399083, 3520.260745243502, 3529.38235808735, 3533.116720819795, 5369.785208591652, 5380.650257733235, 5390.380106287748, 5413.64811287269, 5420.864478388033, 4519.909601807945, 4658.371119898804, 4659.44086709597, 4669.859904202879, 4678.228092364756, 5723.599348045638, 5727.140928860705, 5820.970895145497, 5825.009748342792, 5832.2418085649015, 3843.6540711336115, 3845.2309538092213, 3873.5545412277665, 3877.941830872539, 3884.4561761353434, 5999.100134979744, 6015.729292181863, 6033.276006879159, 6077.088436734481, 6090.512758979316, 3752.5121734174927, 3917.118648304109, 3927.116398810245, 3932.823022963916, 3948.723589348718, 3951.4665520154413, 3969.761814291152, 3986.5216174059296, 3993.820278087493, 3994.6404823566018, 4662.463816661059, 4677.462091859412, 4686.5782079613, 4702.1065997461055, 4709.152352576569, 5765.827025189251, 5790.565707571949, 5827.883442331215, 5833.941660583425, 5840.503557197686, 1365.9795103073461, 1393.8745512903683, 1395.4418232706998, 1399.6011136825955, 1413.5123382433044, 866.2117473099449, 883.0727735877304, 885.623609965762, 896.090468174803, 896.1441823058963, 5438.91841622376, 5440.564754819605, 5482.506574408322, 5521.061419558685, 5531.059719847555, 5962.403759624003, 6004.579679422486, 6074.574779765374, 6075.939240607626, 6077.118817771398, 5470.863228419322, 5481.890362192814, 5483.533899618577, 5512.724363781795, 5542.39033706292, 3132.577102091234, 3232.563603913489, 3246.366958443128, 3283.326917981808, 3301.108700650811, 6133.3866613338305, 6166.630002199882, 6171.691415429211, 6222.471089957314, 6272.5922815016875, 6156.29202641693, 6252.562320637512, 6256.5307601930035, 6268.310485846553, 6288.52836037299, 6043.456088951927, 6104.084387341934, 6167.105769663373, 6253.6873156342, 6296.464800492009, 6080.574359794772, 6082.300535438481, 6121.265448146251, 6143.508519318354, 6173.9073913892225, 5971.104334349709, 6004.42957918997, 6008.098785182257, 6010.429009244115, 6028.2163318770035, 6269.780557680459, 6278.811635650938, 6311.90532142009, 6312.3056463788025, 6323.936760632519, 3937.9409308860963, 4057.695672824609, 4102.774347410802, 4135.379693046068, 4140.0891803803115, 6014.1580178775885, 6019.939800601938, 6042.0, 6042.274927008787, 6050.818475445743, 5805.8548536286935, 5882.23530940975, 5899.879022985619, 5929.555283353679, 5933.762649493972, 5737.91393129095, 5894.616849904743, 5921.526277897844, 5926.377730338425, 5934.495567876779, 5770.884582308414, 5826.0387036140255, 5827.155062515827, 5833.416658334133, 5849.034909239927, 5884.6469211845715, 5908.822735317947, 5922.615030023035, 5926.1999630049395, 5934.732937017931, 5585.664860108406, 5682.943170568242, 5713.685747283939, 5796.855078623068, 5851.244626612084], "yui.html": [636.6434796513953, 638.8850006998741, 638.9009703495957, 663.8572706868023, 669.0532895952226, 11616.186866919319, 11708.414579271044, 12013.999999999989, 12128.514859405614, 12169.939150304235, 11313.717157071056, 11321.433928303593, 11418.54325826966, 11462.083033357332, 11486.655400337982, 615.7506209984963, 631.4254028833763, 752.8945947567331, 769.8152443413568, 780.2158830375465, 734.8750712378882, 768.5849641193777, 769.1270408086806, 778.1634742651644, 781.8709912864399, 805.6777289084355, 813.040612077751, 818.1327792539927, 820.6676296100089, 824.5918270456133, 802.835418739157, 802.9317508011768, 811.1847593168857, 811.4360519438992, 814.5275740070745, 599.2808629644401, 599.553332767087, 600.3486217454067, 608.5192697768757, 608.7625825927892, 11615.477303521277, 11693.415329233589, 11745.706357341049, 11817.881821181763, 11875.940620296844, 8230.62962166704, 8730.956345218297, 8815.77960550985, 9716.174125199366, 10499.73750656232, 7611.847763044708, 7772.844543109106, 7918.287354138155, 7988.400869934778, 8101.351891848638, 2578.432744796142, 2658.734126587345, 2682.758551730334, 2721.877515511807, 2778.8884446221473, 40525.0, 40659.390109148386, 40834.79582602098, 40868.59131408678, 40927.590724092675, 5620.1569764534825, 5762.567807414461, 5893.410658934158, 5959.195508606283, 5979.133025711248, 10231.43727095002, 10275.794484110425, 10378.221633377527, 10407.843882341771, 10414.854366019732, 5092.210707340369, 5143.434222235551, 5180.481951804864, 5288.233206185082, 5333.57331413486, 3101.17818778024, 3178.0465860241834, 3208.8876889308763, 3228.2413632796274, 3251.869925203013, 2253.3352660965056, 2277.5558766040795, 2285.611446054175, 2294.586974344634, 2297.368223738485, 340.5861877818413, 340.7291203493229, 346.6983724159997, 347.25340517886747, 347.9304139172125, 505.2244804225496, 508.659198337115, 516.9302144210559, 528.5269683633204, 552.2930648769582, 7027.824304392431, 7091.361777439952, 7531.0209672743285, 7736.497127686683, 7755.573443460664, 439.1918869280539, 460.61078388761445, 518.9662671926312, 535.788363596385, 593.2525018476664, 3166.6200055992967, 3291.769576129696, 3326.4012477754236, 3454.602720687153, 3475.252820643523, 51666.48333516692, 51896.0, 52742.0, 53353.46646533562, 53519.0, 45551.0, 45564.772176138904, 45773.08453830905, 45851.77074114608, 47052.0, 41892.58107418887, 42571.36142957858, 42576.0, 42619.147617047485, 42999.35500967488, 6741.0, 6834.829129271808, 6896.0, 7000.47496437759, 7054.894176587458, 30549.23626909345, 31094.22264443407, 31150.68849311478, 31575.0, 32029.359412811147, 37593.43609845909, 37702.62297376991, 39384.80307598443, 41290.79354603208, 41605.0, 8346.123657015925, 8575.656973720981, 8654.177853103945, 8851.513166775889, 8982.371234013557, 9064.410813297114, 9099.135582119688, 9119.133682300171, 9163.587638556148, 9240.399374040666, 8411.3270938326, 8479.745607631781, 8488.915110848813, 8692.261157801659, 8852.3803333766, 8523.318134549098, 8775.736727898173, 8779.20987111163, 8817.647294108421, 9018.323625727966, 8239.0, 8399.622017009371, 8661.566921654017, 8676.219140277406, 8790.868136978079, 6474.838129046811, 6527.2167339919515, 6670.566413183127, 6747.898781518379, 6834.794956151323, 6109.327973922954, 6515.153030106246, 6716.361945615159, 6720.193576770819, 6800.557963732342]}, "summary": {"lowerIsBetter": false, "suite": 5646.160550369438, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5688.608128000293, "unit": "ms", "value": 5688.608128000293}, "dojo.html": {"lowerIsBetter": false, "filtered": 4486.394981454641, "unit": "ms", "value": 4486.394981454641}, "mootools.html": {"lowerIsBetter": false, "filtered": 3688.840471094179, "unit": "ms", "value": 3688.840471094179}, "ext.html": {"lowerIsBetter": false, "filtered": 15774.242928667361, "unit": "ms", "value": 15774.242928667361}, "prototype.html": {"lowerIsBetter": false, "filtered": 4333.732969241063, "unit": "ms", "value": 4333.732969241063}, "yui.html": {"lowerIsBetter": false, "filtered": 5033.5210620741045, "unit": "ms", "value": 5033.5210620741045}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0089.e"}, "testrun": {"date": 1447732978, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116174203", "branch": "Mozilla-Inbound", "revision": "204a1746f4213c92d3d0f8ca908e5e604d75b038"}}, {"talos_counters": {}, "results": {"audio-dft": [191.0, 204.0, 206.0, 199.0, 201.0, 195.0, 194.0, 202.0, 205.0, 195.0], "ai-astar": [127.0, 124.0, 135.0, 134.0, 129.0, 139.0, 133.0, 136.0, 132.0, 128.0], "imaging-gaussian-blur": [142.0, 142.0, 149.0, 136.0, 150.0, 142.0, 143.0, 149.0, 149.0, 136.0], "audio-beat-detection": [180.0, 162.0, 185.0, 195.0, 158.0, 182.0, 180.0, 156.0, 199.0, 157.0], "json-stringify-tinderbox": [80.0, 83.0, 84.0, 87.0, 87.0, 89.0, 88.0, 86.0, 86.0, 86.0], "stanford-crypto-pbkdf2": [169.0, 188.0, 189.0, 188.0, 181.0, 180.0, 181.0, 187.0, 192.0, 168.0], "json-parse-financial": [75.0, 75.0, 78.0, 80.0, 83.0, 80.0, 81.0, 88.0, 78.0, 81.0], "stanford-crypto-sha256-iterative": [78.0, 85.0, 87.0, 89.0, 88.0, 88.0, 91.0, 88.0, 89.0, 84.0], "audio-fft": [85.0, 90.0, 99.0, 149.0, 81.0, 85.0, 84.0, 87.0, 117.0, 82.0], "imaging-darkroom": [158.0, 157.0, 156.0, 150.0, 157.0, 156.0, 151.0, 157.0, 156.0, 150.0], "stanford-crypto-ccm": [153.0, 162.0, 158.0, 166.0, 159.0, 157.0, 153.0, 170.0, 167.0, 165.0], "audio-oscillator": [103.0, 105.0, 153.0, 107.0, 110.0, 111.0, 152.0, 105.0, 105.0, 150.0], "stanford-crypto-aes": [101.0, 107.0, 108.0, 108.0, 109.0, 106.0, 107.0, 103.0, 106.0, 103.0], "imaging-desaturate": [118.0, 127.0, 118.0, 136.0, 125.0, 122.0, 118.0, 118.0, 119.0, 127.0]}, "summary": {"lowerIsBetter": true, "suite": 1845.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 95.9, "unit": "ms", "value": 95.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 182.3, "unit": "ms", "value": 182.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 175.4, "unit": "ms", "value": 175.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 161.0, "unit": "ms", "value": 161.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 154.8, "unit": "ms", "value": 154.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 79.9, "unit": "ms", "value": 79.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 120.1, "unit": "ms", "value": 120.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 131.7, "unit": "ms", "value": 131.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 199.2, "unit": "ms", "value": 199.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 86.7, "unit": "ms", "value": 86.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 85.6, "unit": "ms", "value": 85.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 143.8, "unit": "ms", "value": 143.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 105.8, "unit": "ms", "value": 105.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 122.8, "unit": "ms", "value": 122.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0089.e"}, "testrun": {"date": 1447732978, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116174203", "branch": "Mozilla-Inbound", "revision": "204a1746f4213c92d3d0f8ca908e5e604d75b038"}}, {"talos_counters": {}, "results": {"DeltaBlue": [227.89425706472196], "Encrypt": [368.3241252302026], "NavierStokes": [6622.516556291391], "Decrypt": [7299.270072992701], "Splay": [889.8305084745763], "Richards": [190.83969465648855], "RegExp": [33540.983606557376], "Earley": [1037.3056994818653], "Boyer": [15149.253731343284], "RayTrace": [1303.7809647979138]}, "summary": {"lowerIsBetter": false, "suite": 16312.412720956669, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 290.12578399999995, "unit": "score", "value": 290.12578399999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 722.6814149999998, "unit": "score", "value": 722.6814149999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 224.08400000000015, "unit": "score", "value": 224.08400000000015}, "Decrypt": {"lowerIsBetter": false, "filtered": 36.466797000000014, "unit": "score", "value": 36.466797000000014}, "Splay": {"lowerIsBetter": false, "filtered": 91.58036190476187, "unit": "score", "value": 91.58036190476187}, "RegExp": {"lowerIsBetter": false, "filtered": 27.160354349951106, "unit": "score", "value": 27.160354349951106}, "Richards": {"lowerIsBetter": false, "filtered": 184.98247999999998, "unit": "score", "value": 184.98247999999998}, "Earley": {"lowerIsBetter": false, "filtered": 642.4943006993005, "unit": "score", "value": 642.4943006993005}, "Boyer": {"lowerIsBetter": false, "filtered": 43.99312413793104, "unit": "score", "value": 43.99312413793104}, "RayTrace": {"lowerIsBetter": false, "filtered": 567.5715630000001, "unit": "score", "value": 567.5715630000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0089.e"}, "testrun": {"date": 1447732978, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116174203", "branch": "Mozilla-Inbound", "revision": "204a1746f4213c92d3d0f8ca908e5e604d75b038"}}] 20:23:11 INFO - RETURN: dromaeo_css: 5646.16 20:23:11 INFO - RETURN: kraken: 1845.00 20:23:11 INFO - RETURN: v8_7: 16312.41 20:23:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "16312.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1845.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5646.16"}}} 20:23:11 INFO - Return code: 0 20:23:11 INFO - # TBPL SUCCESS # 20:23:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:23:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:23:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:23:11 INFO - 2015-11-16 20:23:11.814 screenresolution[2640:81454] starting screenresolution argv=screenresolution get 20:23:11 INFO - 2015-11-16 20:23:11.817 screenresolution[2640:81454] Display 0: 1600x1200x32@60 20:23:11 INFO - 2015-11-16 20:23:11.824 screenresolution[2641:81457] starting screenresolution argv=screenresolution list 20:23:11 INFO - Available Modes on Display 0 20:23:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:23:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:23:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:23:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:23:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:23:12 INFO - Intel HD Graphics 3000: 20:23:12 INFO - Chipset Model: Intel HD Graphics 3000 20:23:12 INFO - Type: GPU 20:23:12 INFO - Bus: Built-In 20:23:12 INFO - VRAM (Total): 512 MB 20:23:12 INFO - VRAM (Dynamic, Max): 10 20:23:12 INFO - Vendor: Intel (0x8086) 20:23:12 INFO - Device ID: 0x0116 20:23:12 INFO - Revision ID: 0x0009 20:23:12 INFO - Displays: 20:23:12 INFO - Display: 20:23:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:23:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:23:12 INFO - Display Serial Number: 1600x1200 60 20:23:12 INFO - Main Display: Yes 20:23:12 INFO - Mirror: Off 20:23:12 INFO - Online: Yes 20:23:12 INFO - Rotation: Supported 20:23:12 INFO - Return code: 0 20:23:12 INFO - Running post-action listener: _resource_record_post_action 20:23:12 INFO - Running post-run listener: _resource_record_post_run 20:23:13 INFO - Total resource usage - Wall time: 1256s; CPU: 30.0%; Read bytes: 0; Write bytes: 686446592; Read time: 0; Write time: 54968 20:23:13 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 339165696; Write bytes: 334288896; Read time: 35727; Write time: 3990 20:23:13 INFO - run-tests - Wall time: 1215s; CPU: 30.0%; Read bytes: 0; Write bytes: 340799488; Read time: 0; Write time: 49831 20:23:13 INFO - Running post-run listener: _upload_blobber_files 20:23:13 INFO - Blob upload gear active. 20:23:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:23:13 INFO - Copying logs to upload dir... 20:23:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1307.699632 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2015-11-16 20:23:13.266971) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:23:13.270184) ========= 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.r5WUpzmyLD/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.SxCb2VhwUx/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010486 build_url: 'https://queue.taskcluster.net/v1/task/ywXr4XLEREuFBtq7h--ivw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.03 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:23:13.306673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:23:13.307094) ========= 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.r5WUpzmyLD/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.SxCb2VhwUx/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005506 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:23:13.357116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 20:23:13.357472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 20:23:13.357999) ========= ========= Total master_lag: 0.26 =========