builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0101 starttime: 1447860799.7 results: success (0) buildid: 20151118055225 builduid: 37d3acdba6c4433b845d2e92124a4771 revision: 7b0d3fa99e655643a36575b8714e5c7420d29588 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:19.697925) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:19.698407) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:19.698941) ========= 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.rhe8LQnt06/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.3bJWa8BDaw/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.006479 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.016212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.016511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.046990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.047312) ========= 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.rhe8LQnt06/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.3bJWa8BDaw/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.029827 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.098395) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.098664) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.099005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.099278) ========= 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.rhe8LQnt06/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.3bJWa8BDaw/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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-18 07:33:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.69M=0.001s 2015-11-18 07:33:20 (8.69 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.228042 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.349363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.349648) ========= 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.rhe8LQnt06/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.3bJWa8BDaw/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.175108 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.571536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:20.571895) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7b0d3fa99e655643a36575b8714e5c7420d29588 --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 7b0d3fa99e655643a36575b8714e5c7420d29588 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rhe8LQnt06/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.3bJWa8BDaw/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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-18 07:33:20,665 truncating revision to first 12 chars 2015-11-18 07:33:20,665 Setting DEBUG logging. 2015-11-18 07:33:20,665 attempt 1/10 2015-11-18 07:33:20,665 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7b0d3fa99e65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 07:33:20,938 unpacking tar archive at: mozilla-inbound-7b0d3fa99e65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659558 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.265575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.265897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.288412) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.288707) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:21.289138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 16 secs) (at 2015-11-18 07:33:21.293486) ========= /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.rhe8LQnt06/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.3bJWa8BDaw/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 07:33:21 INFO - MultiFileLogger online at 20151118 07:33:21 in /builds/slave/test 07:33:21 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 07:33:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:21 INFO - {'append_to_log': False, 07:33:21 INFO - 'base_work_dir': '/builds/slave/test', 07:33:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:33:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:21 INFO - 'branch': 'Mozilla-Inbound', 07:33:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:21 INFO - 'config_files': ('talos/mac_config.py',), 07:33:21 INFO - 'default_actions': ('clobber', 07:33:21 INFO - 'read-buildbot-config', 07:33:21 INFO - 'download-and-extract', 07:33:21 INFO - 'populate-webroot', 07:33:21 INFO - 'create-virtualenv', 07:33:21 INFO - 'install', 07:33:21 INFO - 'run-tests'), 07:33:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:21 INFO - 'download_minidump_stackwalk': True, 07:33:21 INFO - 'download_symbols': 'ondemand', 07:33:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:21 INFO - 'installer_path': 'installer.exe', 07:33:21 INFO - 'log_level': 'info', 07:33:21 INFO - 'log_name': 'talos', 07:33:21 INFO - 'log_to_console': True, 07:33:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:33:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:33:21 INFO - 'opt_config_files': (), 07:33:21 INFO - 'pip_index': False, 07:33:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:21 INFO - 'cmd': ('bash', 07:33:21 INFO - '-c', 07:33:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:21 INFO - 'enabled': True, 07:33:21 INFO - 'halt_on_failure': False, 07:33:21 INFO - 'name': 'check_screen_resolution'},), 07:33:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:21 INFO - 'cmd': ('bash', 07:33:21 INFO - '-c', 07:33:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:21 INFO - 'enabled': True, 07:33:21 INFO - 'halt_on_failure': False, 07:33:21 INFO - 'name': 'check_screen_resolution'},), 07:33:21 INFO - 'run_cmd_checks_enabled': True, 07:33:21 INFO - 'sps_profile': False, 07:33:21 INFO - 'sps_profile_interval': 0, 07:33:21 INFO - 'suite': 'dromaeojs-e10s', 07:33:21 INFO - 'system_bits': '64', 07:33:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:21 INFO - 'title': 't-yosemite-r5-0101', 07:33:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:21 INFO - 'use_talos_json': True, 07:33:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:21 INFO - 'work_dir': 'build'} 07:33:21 INFO - ##### 07:33:21 INFO - ##### Running clobber step. 07:33:21 INFO - ##### 07:33:21 INFO - Running pre-action listener: _resource_record_pre_action 07:33:21 INFO - Running main action method: clobber 07:33:21 INFO - rmtree: /builds/slave/test/build 07:33:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:27 INFO - Running post-action listener: _resource_record_post_action 07:33:27 INFO - ##### 07:33:27 INFO - ##### Running read-buildbot-config step. 07:33:27 INFO - ##### 07:33:27 INFO - Running pre-action listener: _resource_record_pre_action 07:33:27 INFO - Running main action method: read_buildbot_config 07:33:27 INFO - Using buildbot properties: 07:33:27 INFO - { 07:33:27 INFO - "properties": { 07:33:27 INFO - "buildnumber": 215, 07:33:27 INFO - "product": "firefox", 07:33:27 INFO - "script_repo_revision": "production", 07:33:27 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 07:33:27 INFO - "repository": "", 07:33:27 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 07:33:27 INFO - "buildid": "20151118055225", 07:33:27 INFO - "slavename": "t-yosemite-r5-0101", 07:33:27 INFO - "pgo_build": "False", 07:33:27 INFO - "basedir": "/builds/slave/test", 07:33:27 INFO - "project": "", 07:33:27 INFO - "platform": "yosemite", 07:33:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:33:27 INFO - "slavebuilddir": "test", 07:33:27 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 07:33:27 INFO - "branch": "mozilla-inbound", 07:33:27 INFO - "repo_path": "integration/mozilla-inbound", 07:33:27 INFO - "stage_platform": "macosx64", 07:33:27 INFO - "builduid": "37d3acdba6c4433b845d2e92124a4771", 07:33:27 INFO - "revision": "7b0d3fa99e655643a36575b8714e5c7420d29588" 07:33:27 INFO - }, 07:33:27 INFO - "sourcestamp": { 07:33:27 INFO - "repository": "", 07:33:27 INFO - "hasPatch": false, 07:33:27 INFO - "project": "", 07:33:27 INFO - "branch": "mozilla-inbound-macosx64-talos", 07:33:27 INFO - "changes": [ 07:33:27 INFO - { 07:33:27 INFO - "category": null, 07:33:27 INFO - "files": [ 07:33:27 INFO - { 07:33:27 INFO - "url": null, 07:33:27 INFO - "name": "https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:33:27 INFO - } 07:33:27 INFO - ], 07:33:27 INFO - "repository": "", 07:33:27 INFO - "rev": "7b0d3fa99e655643a36575b8714e5c7420d29588", 07:33:27 INFO - "who": "cbook@mozilla.com", 07:33:27 INFO - "when": 1447860721, 07:33:27 INFO - "number": 6677298, 07:33:27 INFO - "comments": "Merge mozilla-central to mozilla-inbound", 07:33:27 INFO - "project": "", 07:33:27 INFO - "at": "Wed 18 Nov 2015 07:32:01", 07:33:27 INFO - "branch": "mozilla-inbound-macosx64-talos", 07:33:27 INFO - "revlink": "", 07:33:27 INFO - "properties": [ 07:33:27 INFO - [ 07:33:27 INFO - "buildid", 07:33:27 INFO - "20151118055225", 07:33:27 INFO - "Change" 07:33:27 INFO - ], 07:33:27 INFO - [ 07:33:27 INFO - "builduid", 07:33:27 INFO - "37d3acdba6c4433b845d2e92124a4771", 07:33:27 INFO - "Change" 07:33:27 INFO - ], 07:33:27 INFO - [ 07:33:27 INFO - "pgo_build", 07:33:27 INFO - "False", 07:33:27 INFO - "Change" 07:33:27 INFO - ] 07:33:27 INFO - ], 07:33:27 INFO - "revision": "7b0d3fa99e655643a36575b8714e5c7420d29588" 07:33:27 INFO - } 07:33:27 INFO - ], 07:33:27 INFO - "revision": "7b0d3fa99e655643a36575b8714e5c7420d29588" 07:33:27 INFO - } 07:33:27 INFO - } 07:33:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:33:27 INFO - Running post-action listener: _resource_record_post_action 07:33:27 INFO - ##### 07:33:27 INFO - ##### Running download-and-extract step. 07:33:27 INFO - ##### 07:33:27 INFO - Running pre-action listener: _resource_record_pre_action 07:33:27 INFO - Running main action method: download_and_extract 07:33:27 INFO - mkdir: /builds/slave/test/build/tests 07:33: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')]} 07:33:27 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:33:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json 07:33:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json 07:33:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:33:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:33:28 INFO - Downloaded 1149 bytes. 07:33:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:33:28 INFO - Using the following test package requirements: 07:33:28 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:33:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:28 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:33:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:28 INFO - u'jsshell-mac.zip'], 07:33:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:28 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:33:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:33:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:28 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:33:28 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:28 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:33:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:28 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:33:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:33:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:33:28 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:33:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:33:28 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')]} 07:33:28 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:33:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:30 INFO - Downloaded 17463805 bytes. 07:33:30 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 07:33:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:33:38 INFO - Return code: 0 07:33:38 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 07:33:38 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')]} 07:33:38 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:33:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:46 INFO - Downloaded 17463805 bytes. 07:33:46 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 07:33:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:33:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:33:55 INFO - Return code: 0 07:33: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')]} 07:33:55 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:33:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:33:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:33:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:33:56 INFO - Downloaded 11130997 bytes. 07:33:56 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 07:33:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:33:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:33:57 INFO - Return code: 0 07:33: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')]} 07:33:57 INFO - https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:33:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:33:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:33:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:33:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nmlDtIdTRlCTuTufa1PEQA/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 07:34:01 INFO - Downloaded 108849351 bytes. 07:34:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:34:01 INFO - mkdir: /builds/slave/test/properties 07:34:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:01 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:01 INFO - Contents: 07:34:01 INFO - build_url:https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:34:01 INFO - Running post-action listener: _resource_record_post_action 07:34:01 INFO - Running post-action listener: set_extra_try_arguments 07:34:01 INFO - ##### 07:34:01 INFO - ##### Running populate-webroot step. 07:34:01 INFO - ##### 07:34:01 INFO - Running pre-action listener: _resource_record_pre_action 07:34:01 INFO - Running main action method: populate_webroot 07:34:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:34:01 INFO - '../fennec_ids.txt'], 07:34:01 INFO - 'tests': ['tcheck2']}, 07:34:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:01 INFO - '--tppagecycles', 07:34:01 INFO - '7'], 07:34:01 INFO - 'tests': ['tsvgm']}}, 07:34:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:34:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:34:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:34:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:01 INFO - 'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:01 INFO - 'tests': ['damp', 'tps']}, 07:34:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:01 INFO - 'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['damp', 'tps']}, 07:34:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:34:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:01 INFO - 'other': {'tests': ['a11yr', 07:34:01 INFO - 'ts_paint', 07:34:01 INFO - 'tpaint', 07:34:01 INFO - 'sessionrestore', 07:34:01 INFO - 'sessionrestore_no_auto_restore']}, 07:34:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['a11yr', 07:34:01 INFO - 'ts_paint', 07:34:01 INFO - 'tpaint', 07:34:01 INFO - 'sessionrestore', 07:34:01 INFO - 'sessionrestore_no_auto_restore']}, 07:34:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['a11yr', 07:34:01 INFO - 'ts_paint', 07:34:01 INFO - 'tpaint', 07:34:01 INFO - 'sessionrestore', 07:34:01 INFO - 'sessionrestore_no_auto_restore']}, 07:34:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['a11yr', 07:34:01 INFO - 'ts_paint', 07:34:01 INFO - 'tpaint', 07:34:01 INFO - 'sessionrestore', 07:34:01 INFO - 'sessionrestore_no_auto_restore']}, 07:34:01 INFO - 'other_l64': {'tests': ['a11yr', 07:34:01 INFO - 'ts_paint', 07:34:01 INFO - 'tpaint', 07:34:01 INFO - 'sessionrestore', 07:34:01 INFO - 'sessionrestore_no_auto_restore']}, 07:34:01 INFO - 'other_nol64': {'tests': ['a11yr', 07:34:01 INFO - 'ts_paint', 07:34:01 INFO - 'tpaint', 07:34:01 INFO - 'sessionrestore', 07:34:01 INFO - 'sessionrestore_no_auto_restore']}, 07:34:01 INFO - 'svgr': {'tests': ['tsvgx', 07:34:01 INFO - 'tsvgr_opacity', 07:34:01 INFO - 'tart', 07:34:01 INFO - 'tscrollx', 07:34:01 INFO - 'cart']}, 07:34:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['tsvgx', 07:34:01 INFO - 'tsvgr_opacity', 07:34:01 INFO - 'tart', 07:34:01 INFO - 'tscrollx', 07:34:01 INFO - 'cart']}, 07:34:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:01 INFO - 'tests': ['tp5o']}, 07:34:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:01 INFO - 'talos_options': ['--e10s'], 07:34:01 INFO - 'tests': ['tp5o']}, 07:34:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:01 INFO - 'talos_options': ['--xperf_path', 07:34:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:01 INFO - 'tests': ['tp5n']}, 07:34:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:01 INFO - 'talos_options': ['--e10s', 07:34:01 INFO - '--xperf_path', 07:34:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:01 INFO - 'tests': ['tp5n']}}, 07:34:01 INFO - 'talos.zip': {'path': '', 07:34:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:01 INFO - Running post-action listener: _resource_record_post_action 07:34:01 INFO - ##### 07:34:01 INFO - ##### Running create-virtualenv step. 07:34:01 INFO - ##### 07:34:01 INFO - Running pre-action listener: _resource_record_pre_action 07:34:01 INFO - Running main action method: create_virtualenv 07:34:01 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:01 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 07:34:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:02 INFO - Using real prefix '/tools/python27' 07:34:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:03 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:07 INFO - Installing pip.................done. 07:34:07 INFO - Return code: 0 07:34:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c7f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdf3d5e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bc69f0>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bb98c8>, '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.rhe8LQnt06/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.3bJWa8BDaw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 07:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhe8LQnt06/Render', 07:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:07 INFO - 'HOME': '/Users/cltbld', 07:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:07 INFO - 'LOGNAME': 'cltbld', 07:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:07 INFO - 'MOZ_NO_REMOTE': '1', 07:34:07 INFO - 'NO_EM_RESTART': '1', 07:34:07 INFO - 'PAGER': '/bin/cat', 07:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:07 INFO - 'PWD': '/builds/slave/test', 07:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:07 INFO - 'SHELL': '/bin/bash', 07:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3bJWa8BDaw/Listeners', 07:34:07 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 07:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:07 INFO - 'USER': 'cltbld', 07:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:07 INFO - 'XPC_FLAGS': '0x0', 07:34:07 INFO - 'XPC_SERVICE_NAME': '0', 07:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:08 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 07:34:08 INFO - Cleaning up... 07:34:08 INFO - Return code: 0 07:34:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:34:08 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')]} 07:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:08 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')]} 07:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:08 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 0x101ca2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c7f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdf3d5e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bc69f0>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bb98c8>, '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.rhe8LQnt06/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.3bJWa8BDaw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 07:34:08 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 07:34:08 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 07:34:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhe8LQnt06/Render', 07:34:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:08 INFO - 'HOME': '/Users/cltbld', 07:34:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:08 INFO - 'LOGNAME': 'cltbld', 07:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:08 INFO - 'MOZ_NO_REMOTE': '1', 07:34:08 INFO - 'NO_EM_RESTART': '1', 07:34:08 INFO - 'PAGER': '/bin/cat', 07:34:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:08 INFO - 'PWD': '/builds/slave/test', 07:34:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:08 INFO - 'SHELL': '/bin/bash', 07:34:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3bJWa8BDaw/Listeners', 07:34:08 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 07:34:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:08 INFO - 'USER': 'cltbld', 07:34:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:08 INFO - 'XPC_FLAGS': '0x0', 07:34:08 INFO - 'XPC_SERVICE_NAME': '0', 07:34:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:08 INFO - Downloading/unpacking psutil>=0.7.1 07:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:11 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:34:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:11 INFO - Installing collected packages: psutil 07:34:11 INFO - Running setup.py install for psutil 07:34:11 INFO - building 'psutil._psutil_osx' extension 07:34:11 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 07:34:14 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 07:34:14 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 07:34:14 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 07:34:14 INFO - building 'psutil._psutil_posix' extension 07:34:14 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 07:34:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:34:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:34:14 INFO - ^ 07:34:14 INFO - 1 warning generated. 07:34:14 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 07:34:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:14 INFO - Successfully installed psutil 07:34:14 INFO - Cleaning up... 07:34:15 INFO - Return code: 0 07:34:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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', '--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 0x101ca2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c7f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdf3d5e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bc69f0>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bb98c8>, '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.rhe8LQnt06/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.3bJWa8BDaw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 07:34:15 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 07:34:15 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 07:34:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhe8LQnt06/Render', 07:34:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:15 INFO - 'HOME': '/Users/cltbld', 07:34:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:15 INFO - 'LOGNAME': 'cltbld', 07:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:15 INFO - 'MOZ_NO_REMOTE': '1', 07:34:15 INFO - 'NO_EM_RESTART': '1', 07:34:15 INFO - 'PAGER': '/bin/cat', 07:34:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:15 INFO - 'PWD': '/builds/slave/test', 07:34:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:15 INFO - 'SHELL': '/bin/bash', 07:34:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3bJWa8BDaw/Listeners', 07:34:15 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 07:34:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:15 INFO - 'USER': 'cltbld', 07:34:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:15 INFO - 'XPC_FLAGS': '0x0', 07:34:15 INFO - 'XPC_SERVICE_NAME': '0', 07:34:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:34:15 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 07:34:15 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 07:34:15 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 07:34:15 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 07:34:15 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 07:34:15 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 07:34:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:34:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:34:18 INFO - Installing collected packages: mozsystemmonitor 07:34:18 INFO - Running setup.py install for mozsystemmonitor 07:34:18 INFO - Successfully installed mozsystemmonitor 07:34:18 INFO - Cleaning up... 07:34:18 INFO - Return code: 0 07:34:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34:18 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')]} 07:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:18 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')]} 07:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:18 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 0x101ca2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c7f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdf3d5e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bc69f0>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bb98c8>, '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.rhe8LQnt06/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.3bJWa8BDaw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 07:34:18 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 07:34:18 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 07:34:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhe8LQnt06/Render', 07:34:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:18 INFO - 'HOME': '/Users/cltbld', 07:34:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:18 INFO - 'LOGNAME': 'cltbld', 07:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:18 INFO - 'MOZ_NO_REMOTE': '1', 07:34:18 INFO - 'NO_EM_RESTART': '1', 07:34:18 INFO - 'PAGER': '/bin/cat', 07:34:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:18 INFO - 'PWD': '/builds/slave/test', 07:34:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:18 INFO - 'SHELL': '/bin/bash', 07:34:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3bJWa8BDaw/Listeners', 07:34:18 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 07:34:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:18 INFO - 'USER': 'cltbld', 07:34:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:18 INFO - 'XPC_FLAGS': '0x0', 07:34:18 INFO - 'XPC_SERVICE_NAME': '0', 07:34:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:18 INFO - Downloading/unpacking blobuploader==1.2.4 07:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:21 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:34:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:34:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 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 07:34:22 INFO - Downloading docopt-0.6.1.tar.gz 07:34:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:22 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:22 INFO - Running setup.py install for blobuploader 07:34:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:23 INFO - Running setup.py install for requests 07:34:23 INFO - Running setup.py install for docopt 07:34:23 INFO - Successfully installed blobuploader requests docopt 07:34:23 INFO - Cleaning up... 07:34:23 INFO - Return code: 0 07:34:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:23 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')]} 07:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:23 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')]} 07:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:23 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 0x101ca2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c7f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdf3d5e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bc69f0>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bb98c8>, '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.rhe8LQnt06/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.3bJWa8BDaw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 07:34:23 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 07:34:23 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 07:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhe8LQnt06/Render', 07:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:23 INFO - 'HOME': '/Users/cltbld', 07:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:23 INFO - 'LOGNAME': 'cltbld', 07:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:23 INFO - 'MOZ_NO_REMOTE': '1', 07:34:23 INFO - 'NO_EM_RESTART': '1', 07:34:23 INFO - 'PAGER': '/bin/cat', 07:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:23 INFO - 'PWD': '/builds/slave/test', 07:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:23 INFO - 'SHELL': '/bin/bash', 07:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3bJWa8BDaw/Listeners', 07:34:23 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 07:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:23 INFO - 'USER': 'cltbld', 07:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:23 INFO - 'XPC_FLAGS': '0x0', 07:34:23 INFO - 'XPC_SERVICE_NAME': '0', 07:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:24 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-OlnXBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:24 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-S7MyAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:24 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-cI3ewV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:24 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-BJXDiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:24 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-hjagNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:24 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-B7BYV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:25 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Xw0jH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:25 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-aYFjIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:25 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ZDL8QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:25 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-FDrvCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:25 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Qu2t_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:25 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-CBZV1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:25 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ux49j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:26 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-WIoEnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:26 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-vwf2Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:26 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ugTFdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:26 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-TImoEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:26 INFO - Running setup.py install for manifestparser 07:34:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:26 INFO - Running setup.py install for mozcrash 07:34:26 INFO - Running setup.py install for mozdebug 07:34:27 INFO - Running setup.py install for mozdevice 07:34:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:27 INFO - Running setup.py install for mozfile 07:34:27 INFO - Running setup.py install for mozhttpd 07:34:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:27 INFO - Running setup.py install for mozinfo 07:34:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:27 INFO - Running setup.py install for mozInstall 07:34:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Running setup.py install for mozleak 07:34:28 INFO - Running setup.py install for mozlog 07:34:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Running setup.py install for moznetwork 07:34:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:28 INFO - Running setup.py install for mozprocess 07:34:28 INFO - Running setup.py install for mozprofile 07:34:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Running setup.py install for mozrunner 07:34:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Running setup.py install for mozscreenshot 07:34:29 INFO - Running setup.py install for moztest 07:34:29 INFO - Running setup.py install for mozversion 07:34:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:29 INFO - Cleaning up... 07:34:29 INFO - Return code: 0 07:34:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:29 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 0x101ca2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c7f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdf3d5e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bc69f0>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bb98c8>, '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.rhe8LQnt06/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.3bJWa8BDaw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 07:34:29 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 07:34:29 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 07:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhe8LQnt06/Render', 07:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:29 INFO - 'HOME': '/Users/cltbld', 07:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:29 INFO - 'LOGNAME': 'cltbld', 07:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:29 INFO - 'MOZ_NO_REMOTE': '1', 07:34:29 INFO - 'NO_EM_RESTART': '1', 07:34:29 INFO - 'PAGER': '/bin/cat', 07:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:29 INFO - 'PWD': '/builds/slave/test', 07:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:29 INFO - 'SHELL': '/bin/bash', 07:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3bJWa8BDaw/Listeners', 07:34:29 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 07:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:29 INFO - 'USER': 'cltbld', 07:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:29 INFO - 'XPC_FLAGS': '0x0', 07:34:29 INFO - 'XPC_SERVICE_NAME': '0', 07:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-2_EeKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-0nnY8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-HVeCLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-APbiAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-BPRfnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:30 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)) 07:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-wyrU30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Qh2nxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-WRoiqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-26XdeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-MOLd3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ZXhfOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-tbszeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-hSNQH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:32 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-VNnWdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:32 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-9k_SST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:32 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-bGnlXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:32 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-EVSU4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:35 INFO - Downloading blessings-1.5.1.tar.gz 07:34:35 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 07:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:35 INFO - Installing collected packages: blessings 07:34:35 INFO - Running setup.py install for blessings 07:34:35 INFO - Successfully installed blessings 07:34:35 INFO - Cleaning up... 07:34:35 INFO - Return code: 0 07:34:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:36 INFO - Reading from file tmpfile_stdout 07:34:36 INFO - Current package versions: 07:34:36 INFO - blessings == 1.5.1 07:34:36 INFO - blobuploader == 1.2.4 07:34:36 INFO - docopt == 0.6.1 07:34:36 INFO - manifestparser == 1.1 07:34:36 INFO - mozInstall == 1.12 07:34:36 INFO - mozcrash == 0.16 07:34:36 INFO - mozdebug == 0.1 07:34:36 INFO - mozdevice == 0.47 07:34:36 INFO - mozfile == 1.2 07:34:36 INFO - mozhttpd == 0.7 07:34:36 INFO - mozinfo == 0.9 07:34:36 INFO - mozleak == 0.1 07:34:36 INFO - mozlog == 3.0 07:34:36 INFO - moznetwork == 0.27 07:34:36 INFO - mozprocess == 0.22 07:34:36 INFO - mozprofile == 0.27 07:34:36 INFO - mozrunner == 6.11 07:34:36 INFO - mozscreenshot == 0.1 07:34:36 INFO - mozsystemmonitor == 0.0 07:34:36 INFO - moztest == 0.7 07:34:36 INFO - mozversion == 1.4 07:34:36 INFO - psutil == 3.1.1 07:34:36 INFO - requests == 1.2.3 07:34:36 INFO - wsgiref == 0.1.2 07:34:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x101ca2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c7f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdf3d5e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bc69f0>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bb98c8>, '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.rhe8LQnt06/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.3bJWa8BDaw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 07:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 07:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 07:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhe8LQnt06/Render', 07:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:36 INFO - 'HOME': '/Users/cltbld', 07:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:36 INFO - 'LOGNAME': 'cltbld', 07:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:36 INFO - 'MOZ_NO_REMOTE': '1', 07:34:36 INFO - 'NO_EM_RESTART': '1', 07:34:36 INFO - 'PAGER': '/bin/cat', 07:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:36 INFO - 'PWD': '/builds/slave/test', 07:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:36 INFO - 'SHELL': '/bin/bash', 07:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3bJWa8BDaw/Listeners', 07:34:36 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 07:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:36 INFO - 'USER': 'cltbld', 07:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:36 INFO - 'XPC_FLAGS': '0x0', 07:34:36 INFO - 'XPC_SERVICE_NAME': '0', 07:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 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)) 07:34:36 INFO - Cleaning up... 07:34:36 INFO - Return code: 0 07:34:36 INFO - Running post-action listener: _resource_record_post_action 07:34:36 INFO - Running post-action listener: _start_resource_monitoring 07:34:36 INFO - Starting resource monitoring. 07:34:36 INFO - ##### 07:34:36 INFO - ##### Running install step. 07:34:36 INFO - ##### 07:34:36 INFO - Running pre-action listener: _resource_record_pre_action 07:34:36 INFO - Running main action method: install 07:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:36 INFO - Reading from file tmpfile_stdout 07:34:36 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:36 INFO - Reading from file tmpfile_stdout 07:34:36 INFO - Output received: 07:34:36 INFO - Usage: mozinstall [options] installer 07:34:36 INFO - Options: 07:34:36 INFO - -h, --help show this help message and exit 07:34:36 INFO - -d DEST, --destination=DEST 07:34:36 INFO - Directory to install application into. [default: 07:34:36 INFO - "/builds/slave/test"] 07:34:36 INFO - --app=APP Application being installed. [default: firefox] 07:34:36 INFO - mkdir: /builds/slave/test/build/application 07:34:36 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'] 07:34:36 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 07:35:18 INFO - Reading from file tmpfile_stdout 07:35:18 INFO - Output received: 07:35:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:35:18 INFO - Running post-action listener: _resource_record_post_action 07:35:18 INFO - ##### 07:35:18 INFO - ##### Running run-tests step. 07:35:18 INFO - ##### 07:35:18 INFO - Running pre-action listener: _resource_record_pre_action 07:35:18 INFO - Running main action method: run_tests 07:35:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:35:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:35:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:35:18 INFO - 2015-11-18 07:35:18.574 screenresolution[1631:7748] starting screenresolution argv=screenresolution get 07:35:18 INFO - 2015-11-18 07:35:18.578 screenresolution[1631:7748] Display 0: 1600x1200x32@60 07:35:18 INFO - 2015-11-18 07:35:18.585 screenresolution[1632:7750] starting screenresolution argv=screenresolution list 07:35:18 INFO - Available Modes on Display 0 07:35:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:35:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:35:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:35:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:35:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:35:18 INFO - Intel HD Graphics 3000: 07:35:18 INFO - Chipset Model: Intel HD Graphics 3000 07:35:18 INFO - Type: GPU 07:35:18 INFO - Bus: Built-In 07:35:18 INFO - VRAM (Total): 512 MB 07:35:18 INFO - VRAM (Dynamic, Max): 10 07:35:18 INFO - Vendor: Intel (0x8086) 07:35:18 INFO - Device ID: 0x0116 07:35:18 INFO - Revision ID: 0x0009 07:35:18 INFO - Displays: 07:35:18 INFO - Display: 07:35:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:35:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:35:18 INFO - Display Serial Number: 1600x1200 60 07:35:18 INFO - Main Display: Yes 07:35:18 INFO - Mirror: Off 07:35:18 INFO - Online: Yes 07:35:18 INFO - Rotation: Supported 07:35:18 INFO - Return code: 0 07:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:18 INFO - Python 2.7.3 07:35:18 INFO - Return code: 0 07:35:18 INFO - grabbing minidump binary from tooltool 07:35:18 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')]} 07:35:18 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 0x101bc69f0>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bb98c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:18 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 07:35:18 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 07:35:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:18 INFO - Return code: 0 07:35:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:35:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:35:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35:18 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/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] in /builds/slave/test/build 07:35:18 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/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0101 --webServer localhost 07:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhe8LQnt06/Render', 07:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:18 INFO - 'HOME': '/Users/cltbld', 07:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:18 INFO - 'LOGNAME': 'cltbld', 07:35:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:18 INFO - 'MOZ_NO_REMOTE': '1', 07:35:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:18 INFO - 'NO_EM_RESTART': '1', 07:35:18 INFO - 'PAGER': '/bin/cat', 07:35:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:18 INFO - 'PWD': '/builds/slave/test', 07:35:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:18 INFO - 'SHELL': '/bin/bash', 07:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3bJWa8BDaw/Listeners', 07:35:18 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 07:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:18 INFO - 'USER': 'cltbld', 07:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:18 INFO - 'XPC_FLAGS': '0x0', 07:35:18 INFO - 'XPC_SERVICE_NAME': '0', 07:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:35:18 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/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] with output_timeout 3600 07:35:19 INFO - mozversion INFO | application_buildid: 20151118055225 07:35:19 INFO - mozversion INFO | application_changeset: 7b0d3fa99e655643a36575b8714e5c7420d29588 07:35:19 INFO - mozversion INFO | application_display_name: Nightly 07:35:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:19 INFO - mozversion INFO | application_name: Firefox 07:35:19 INFO - mozversion INFO | application_remotingname: firefox 07:35:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:35:19 INFO - mozversion INFO | application_vendor: Mozilla 07:35:19 INFO - mozversion INFO | application_version: 45.0a1 07:35:19 INFO - mozversion INFO | platform_buildid: 20151118055225 07:35:19 INFO - mozversion INFO | platform_changeset: 7b0d3fa99e655643a36575b8714e5c7420d29588 07:35:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:35:19 INFO - mozversion INFO | platform_version: 45.0a1 07:35:19 INFO - 2015-11-18 07:35:19,350 DEBUG : using testdate: 1447860919 07:35:19 INFO - 2015-11-18 07:35:19,350 DEBUG : actual date: 1447860919 07:35:19 INFO - 2015-11-18 07:35:19,359 INFO : starting webserver on 'localhost:49277' 07:35:19 INFO - 2015-11-18 07:35:19,360 INFO : Starting test suite t-yosemite-r5-0101.e 07:35:19 INFO - 2015-11-18 07:35:19,360 INFO : Starting test dromaeo_css 07:35:19 INFO - 2015-11-18 07:35:19,360 DEBUG : operating with platform_type : mac_ 07:35:19 INFO - 2015-11-18 07:35:19,361 INFO : Initialising browser for dromaeo_css test... 07:35:19 INFO - 2015-11-18 07:35:19,399 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp2kB9yn/profile http://localhost:49277/getInfo.html 07:35:24 INFO - 2015-11-18 07:35:24,225 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:35:24 INFO - 2015-11-18 07:35:24,225 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:35:24 INFO - 2015-11-18 07:35:24,225 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:35:24 INFO - 2015-11-18 07:35:24,225 DEBUG : BROWSER_OUTPUT: __metrics 07:35:24 INFO - 2015-11-18 07:35:24,966 INFO : Browser initialized. 07:35:24 INFO - 2015-11-18 07:35:24,967 INFO : Running cycle 1/1 for dromaeo_css test... 07:35:24 INFO - 2015-11-18 07:35:24,967 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp2kB9yn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:35:37 INFO - 2015-11-18 07:35:37,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 240386048 07:35:37 INFO - 2015-11-18 07:35:37,227 DEBUG : BROWSER_OUTPUT: 07:36:27 INFO - 2015-11-18 07:36:27,081 DEBUG : BROWSER_OUTPUT: 1447860987080 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] 07:38:36 INFO - 2015-11-18 07:38:36,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 07:38:37 INFO - 2015-11-18 07:38:37,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 268529664 07:38:37 INFO - 2015-11-18 07:38:37,941 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 07:41:40 INFO - 2015-11-18 07:41:40,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 273154048 07:41:40 INFO - 2015-11-18 07:41:40,765 DEBUG : BROWSER_OUTPUT: 07:44:42 INFO - 2015-11-18 07:44:42,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 07:44:43 INFO - 2015-11-18 07:44:43,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 274579456 07:44:43 INFO - 2015-11-18 07:44:43,123 DEBUG : BROWSER_OUTPUT: 07:47:44 INFO - 2015-11-18 07:47:44,867 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 07:47:45 INFO - 2015-11-18 07:47:45,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 277688320 07:47:45 INFO - 2015-11-18 07:47:45,473 DEBUG : BROWSER_OUTPUT: 07:50:48 INFO - 2015-11-18 07:50:48,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 07:50:48 INFO - 2015-11-18 07:50:48,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 283828224 07:50:48 INFO - 2015-11-18 07:50:48,755 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 07:53:51 INFO - 2015-11-18 07:53:51,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 287928320 07:53:51 INFO - 2015-11-18 07:53:51,356 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,356 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:53:51 INFO - 2015-11-18 07:53:51,356 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:53:51 INFO - 2015-11-18 07:53:51,356 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:53:51 INFO - 2015-11-18 07:53:51,356 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:53:51 INFO - 2015-11-18 07:53:51,356 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2565.653636759037;2594.935126621834;2633.9078132265363;2655.5352813257673;2659.867006649667;4372.628326592236;4422.27032539631;4439.822407103712;4554.567316104969;4575;4318.9352159717555;4334.41485399471;4357.869263922087;4407.140607581523;4414.690971631979;4143.254214241435;4145.5647157048525;4186.37204419338;4300.096979634281;4361.803718832644;4254.340577210537;4297.119090586422;4304.913901721964;4316.805743741524;4319.136172765444;81.95780812037961;4144.6062624050965;4174.958250417488;4251.893702657443;4363.672724545656;4164.416981622575;4176.561461046576;4196.097838964607;4233.957660423387;4260.084081922401;4154.792260386968;4172.228137794517;4202.222588821078;4214.325707886754;4249.893752656209;4109.013836679205;4317.244482215599;4336.848210312624;4388.802503887301;4444.511103778582;4729.4797572267025;4744.667873248874;4752.382190315237;4769.499202583714;4802;4774.73738944358;4787.234042553175;4825.951740482586;4860.149473842063;4865.416150062015;4284.357346398034;4397.670174736908;4422.911541769146;4482.910341793178;4499.482559505699;4764.571188593043;4851.466338702739;4854.708717476963;4860.3195552622665;4903.313536104948;4656.790444430008;4665.650076244296;4671.672982891233;4737.336772851803;4803.639727020487;4634.86445820776;4647.9767601161775;4666.393368862094;4749.501302363202;4758.809647614056;4695.765211739467;4714.81140754366;4727.692699974491;4737.857864264078;4764.97553026101;4492.820287188476;4695.5304469552775;4698.765061746899;4714.811407543729;4745.477997420281;3658.762180458262;3686.5207523022373;3708.332500149999;3715.9628403715615;3729.4778730977687;3362.4283871741864;3374.763766536368;3409.6760807723226;3409.7954122752712;3424.8972530824117;4283.914321713611;4413.117376524644;4459.910801783946;4460.420145381145;4467.843625473093;4745.738984355825;4762.9523704763205;4779.330893674888;4809.567138957511;4890.902181956412;4484.663650226246;4507.864764057083;4512.842050528216;4520.0507893342765;4548.340490628841;4108.137291168888;4119.485064366954;4203.936940945889;4240;4274.422952901318;4929.433115191727;4941.085899108676;4962.007598480246;4965.702057876539;4983.07813054586;4829.95170048295;4839.661223714306;4845.733484658378;4891.388576427947;4933.087378834927;4765.332853400458;4771.76141192932;4791.760411979457;4896.583790377857;4933.333999909966;4718.292256161603;4729.125111854318;4773.856784296477;4777.450593181689;4832.830850920342;4773.570378665937;4777.331173635764;4813.590844778093;4825.300331451849;4933.186024305949;4454.109178164315;4523.457185137673;4683.086798074342;4691.03833714081;4694.201985662377;4582.175208462509;4597.977010114928;4600.240960241523;4621.260598304255;4688.390509233915;4504.076664283749;4513.684042117152;4540;4551.294549344857;4588.197065513455;4470.910581788411;4541.205289074464;4588.793504292248;4604.194266003503;4709.7174169549935;4569.086182763527;4571.405717256735;4615.2154133798;4617.053504031733;4705.082508910729 07:53:51 INFO - 2015-11-18 07:53:51,361 DEBUG : BROWSER_OUTPUT: |1;ext.html;454.11221062822165;463.25416080111023;465.53446553446554;489.20748387612076;504.069990866851;32891;33978;34044.82977585115;34310.14224644385;34492.31015379694;35871;35921.2815743685;36397.81801090998;36453.53197020448;36553.268934621294;7666.31003209711;7878.487898286593;7910.050793904739;8013.759587212393;8021.278084972351;7789.104253010892;7809.219078092202;7850.293473587376;7954.642041108135;7974;7735.497192682457;7800.687972481122;7816.140224575321;7933.325667318285;7977.920220797776;7653.540787552737;7735.303822655988;7749.651265693001;7782.299593036654;7837.529748215125;7664.578448185348;7756.806079847993;7765.339946104588;7857.842843143105;7909.564973926432;33388.165295867795;33581.49627755586;33584.328313433594;33797.155071123176;34200.31599368023;2536.921808231513;2546.414324705328;2902.6516817981765;3034.1049390429876;3067.938641227185;23059.423514412105;23362.64956025661;23727.1695490657;23741.643875341884;24076.879615601985;2034.1112479372282;2042.5812708394744;2054.3836848945257;2061.1446249806313;2088.6553718636405;230537;230726;230822;231393;234979;42423.78788106101;44108.779456102515;49845;50227.49772502228;51818.22272665913;50722;50897.23654145191;51048.234276485884;51355.48644513507;51624.22563661548;12063;12276.938615306866;12289.324087175291;12291.938540307241;12486.438110285058;9270.165685088374;9280.0719928008;9290.535473226311;9306.348555601044;9366.62533498666;16247.431339903047;16331.305334619654;16443.424480143378;16464.83535164633;16515;6777.9661101695165;6904.447644188453;6929.475515386708;6942.340477654615;7002.159740831133;744.0922075068407;785.3363907498155;809.6761295481855;819.0130892274794;948.3314263444255;23466.413339666302;23682;23715;23880.761192387854;23909.880450597637;861.7199410191713;878.6617152396245;901.0718959471754;963.6675347005272;1014.599233302856;12604.621861344174;12718;12853.742925141632;13271.535496257779;13351.265680387478;279525;279880;279977;281339;282067;45709;46210.768946155724;46366.5363346369;46391.30413043807;46426;1121.1703339528854;1130.8190689489643;1144.2390810111183;1150.9597164099216;1163.4764356039984;24017.27948161558;24426.633600496363;24676.259712208663;24706.752932470445;24738;40551.18897621972;40947.181056379304;40957;41015.794921025205;41029.38455923104;248376;249402;250219;251028;253261;25199.622005669564;35799.82100089483;36878.8156059218;37085.443718343704;37177.81411092927;38911.61088389193;40419.1916161681;40615;40680.18639627132;41225.38161927513;32387.19032024218;32505.837470812494;32938.68245270258;33556.328873422884;33774.3245135091;31825.522617161223;32274.19314517062;32520;32710.672893270763;33236.335273294884;32948;33097.17257068496;33187.50218746672;33695;33753.15617109494;27021.379761958447;28573.428531429672;29015.12954611365;29071.854640726662;29317.41365172727;21066.47333816667;21810.890945545172;21816.781832181474;21820.45448863791;22095.44761380978 07:53:51 INFO - 2015-11-18 07:53:51,361 DEBUG : BROWSER_OUTPUT: |2;jquery.html;275.71601250711774;276.78904791537025;276.8781736036144;278.3875473957294;289.1484577918031;12162.270263784158;14428.13431194129;14604.853951460482;14946.5516034519;15207.92396038021;14468.131912085282;14517;14691.632709182275;14957;15013.399464021453;3768.868089616857;3893.8637147699837;3935.5867633898456;4005.1388951375448;4590.724556526602;3883.1457079442475;3932.2725295820223;3945.782981935992;3996.9800150999204;4011.618896204856;3779.697624190072;3822.522184726909;3888.786116763577;3984.342583473723;4138.420621113047;3163.3198862244612;3896.7856767877756;3898.5516665583536;3971.543272523668;3973.3443981742976;3138.030391554685;3316.635170131308;3322.401967645823;3361.9327613447595;3447.24160684649;10614.840777388268;10676.893231067745;10928.508217130247;10985.945070274678;11034;1598.1130472587708;1618.166644178249;1624.4233297179567;1630.8369163083714;1695.6778212139777;7836.216378362175;7920.5247685139075;8169.877451838227;8209.38429617781;8243.587820608946;1245.2092920995142;1312.2716892124963;1314.8685131486775;1335.7261761338902;1374.2098293481188;47994.7600262;49099.263511047364;49211.26183107256;49235.753821231025;49847;5402.675839449567;5452.945470545244;5462.371827239839;5496.6701997880255;5501.092319767194;6121.418465245794;6135.754569817157;6145.784897528565;6174.043023331391;6205.348438413992;4354.782260886943;4434.5122036576595;4437.201303765289;4439;4509.842155524541;4636.235021221528;4677.041206552649;4682.531746825291;4715.269133284346;4746.0745154694505;2416.9274921752376;2462.630605409167;2473;2474.789642880339;2487.0549191307186;879.5470332778624;879.7184900831801;882.6910581296495;885.5882014862991;923.9651590218998;346.23827579325587;354.62232722150827;361.3784291019442;375.9642833930772;381.6679488844723;8365.707200247962;8739;8821.647134114564;8864.335174861912;9010.05394433575;336.132777434224;337.8091378371212;344.1036100957021;344.2426661345051;346.7330155780086;4650.209464391061;4895.118878601815;5218.739063046833;5231.136862417735;5255.737213139328;318780;324609;326893;330664;331449;49214.261786073235;52368.73815630897;52817.471825282024;52989.470105299224;54570.99999999921;389.2778895149457;401.4440000599191;402.29799000743304;403.50570551074696;404.20573572929334;8683.305335573014;8773.38586298953;8813.867791982997;8946;9092.272618190662;26917.865410673603;27191.59212611852;27965.72034279631;28117.718822812327;28482.145535633965;36321;36934.8153259232;37369.69206077774;37640;37816.05459863525;5062.367204099488;5148.407933087593;5185.792568297225;5207.81772637971;5267.894642107213;9640.42157470554;9705.272104592324;9922.057404546556;9946.204303655546;9960.950195249266;8396.244338009608;8479.61841717112;8704.825903481767;8744.737657870273;8761.342899282707;8241.464304820167;8310.833783324179;8413.495190288602;8439.240468357877;8621.698240561802;8562.78593035179;8622.223999839794;8639.265662418766;8788.077251888715;8932.151445612657;5096.668716533413;5119.667221630582;5145.742712864417;5155.3813542373655;5157.871053223549;8488.151184881463;8531.445456045338;8568.186022327869;8648.740537783877;8676.869846952175 07:53:51 INFO - 2015-11-18 07:53:51,364 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1156.8785277545858;1177.8115501519753;1346.9695682802655;1485.1163557683174;1490.284663361587;5442.945570544293;5561.833145005646;6095.878082438354;6324.430801227894;6371.872562548746;5774.047282198443;6084.756609735617;6132;6171.567990240685;6207.162033125526;1749.0817320906563;1767;1771.2914834066348;1773.521149289691;1797;1792.3905872003515;1797.9550511237194;1807.1416077363278;1820.062667726122;1826.7351234071118;1714.3228424772208;1743.8430541251284;1751.702210624197;1761.806201317854;1770.0530216334264;1734.236935748273;1765.3291749135374;1789.838914497695;1798.199801088516;1815.9092045397808;1752.6319472910704;1762.9206685699173;1785.1342099081935;1802.4772815883377;1810.5835657798648;6087.908681369783;6126.816195514097;6132.785352512686;6134.9079763803575;6177.876442471171;3678;3697.131174174067;3701.2597480504005;3714.23858109087;3755.3052685253315;2069.1309649947057;2079.750429948416;2377.679013333195;2412.0713525292713;2461.9876900615563;753.175273075981;759.7794252924999;766.7316439246275;787.7321710618418;789.4828887078972;7717.575533345664;7852.3325517331095;7864.842703145962;7874.881876771796;7890.132085470594;3341.916452088717;3367.966320336814;3369.528266042756;3428.1086917401653;3433.1760377509218;6876.656167191721;6883.139607549057;6922.203946546111;6944.131983502062;6984.965075174591;3736.9065773355883;3775.962240377616;3800.3349413852466;3811.6950643948417;3833.6166383361997;3448.4482482803132;3465.7054150396993;3483.808390538494;3490.3717330880177;3515.34966031285;2896.9275768105967;2898.4637841999297;2915.154605164521;2931.1792698044583;2939.779516536268;865.1262225152641;868.1969178509853;869.2437579306044;880.2605811118691;883.0639522106587;1060.5492665617082;1082.658962426833;1087.2932593814085;1088.9618863339745;1122.71370800447;5741.311042674905;5751.1085781703905;5760.884782304331;5830.47525722687;5894.557908156906;404.0424194658619;407.21407683171765;409.5945014435747;410.3024857741851;411.35212041035487;4520.954790452053;4558.726476411426;4586.082783443325;4626.352310676508;4628.120657075212;6625.569337993015;6650.434713049445;6789.966050169717;6974.407175390149;7100.538464999759;6797.558158719767;6896.103506544217;6936.445084393236;6942.51402401827;6972.546784458994;5609.186667933127;5714.142878568248;5725.799597014085;5763.625364351304;5803.390643982406;5413.269208656939;5446.128619420873;5460.31746031746;5491.835244942658;5534.031544479781;6214.5960512568345;6272.247330320391;6284.151639528605;6345.302016778059;6451.451626611791;6494.350564943468;6498.772542960974;6502.902456463252;6540.018997150465;6551.967240163769;5298.470152984671;5306.814261500829;5346.064438723286;5394.08300588893;5412.107002344569;5825.3592104867585;5836.241288632451;5849.970750146222;5908.645481271137;5937.19847820556;5448.536874365724;5508.889822203613;5548.167774833807;5598.1322894951345;5667.2349232854685;5299.735013249399;5346.385165705994;5424.159255315432;5534.08687566547;5562.554995600423;5386.676799392049;5472.20653005304;5536.892621475801;5554.555635549227;5569.830335629563;4967.3045773591;5052.1411360069615;5060.873478163076;5086.262491938574;5107.2594473800345;5087.008033433445;5127.154019586876;5129.6665716729785;5179.171332586768;5225.608079394136 07:53:51 INFO - 2015-11-18 07:53:51,365 DEBUG : BROWSER_OUTPUT: |4;prototype.html;248.97510248975098;258.53721837910143;258.5539943597294;263.42836045780655;264.5238570572968;5305.522502974732;5377.300950876385;5399.460053994599;5454.836354909359;5547.0015397228535;5248.5538729207965;5330.413654498002;5350;5372.973135134329;5489.615726899118;4178.937315940263;4233.788310584474;4236.449261595988;4239.491261048678;4247.5964783345535;4148.439960605325;4221.7889105544755;4236.766977816219;4254;4295.484541854982;4103.8563650272245;4126.958730412703;4161.895952601194;4175.791210439465;4234.9364759528635;4112.177564487115;4135.73117747347;4152.854650087233;4180.644645205146;4219.746815191098;3523.612402635708;3548.982255088734;3569.7322700797545;3608.0799396154075;3617.385044542434;5061.544460998528;5173.586113110942;5230.241614965808;5280.683159010472;5288.0745869472685;4634.2585186370015;4654.488006319302;4658.720476771371;4662.137504561633;4717.150912835688;5644.520215781664;5658.490735833753;5698.088305871041;5741.081426971665;5757.769689212469;3856.730028897978;3870.41943708446;3873.32216862048;3904.1996390740114;3918.608139186087;5783.797567085132;5871.267975947106;5937;5969.164316995624;5976.61152025117;3933.9213215735526;3935.330993731073;3940.2907476654477;3962.841486340514;3964.266610677034;4002.1795531915886;4002.8999275017777;4004.1190937993597;4075;4079.326911059642;4606.447226332862;4636.884077898012;4641.373414589055;4676.321933319649;4712.811487540528;5495.368032676213;5639.6334238274385;5663.065594176997;5683.801066962719;5770.278715160605;1342.90599658023;1365.9180449173082;1367.699106196635;1383.2876068824564;1391.7077413743227;856.5289090999925;865.9956700216585;879.2833840420037;894.0612357025097;900.1943260781695;5342.465753424704;5356.625036247503;5377.462253774591;5401.756920938567;5433.864153396117;5850.385709500526;5862.325832529228;5876;5947.910781338283;5950.761969521257;5360.946390536044;5372.91940620891;5394.91907621386;5434.91847622286;5449.373322068013;3147.0873446700202;3177.8411079446396;3200.823954682515;3210.678932106771;3266.738660907122;6093.634381937098;6138.693065346715;6220.875582488325;6231.376862313732;6236.937630623726;5828.970855145782;6012.30858451275;6065.969670151621;6118.908216376758;6163.044728067157;6120.693965301806;6157.568970172135;6170;6172.475339596095;6226.097215903668;5962.761489540369;6008.369121242382;6042.335343112166;6049.243844519435;6073;5552.222688823649;5785.103308987113;5866.941330586639;5919.141724450017;5943.019401798655;6121.908171377522;6141.140240366263;6151.72317245716;6236.220472440945;6236.968815155895;3628.4760400632326;3753.9061523462133;3767.3030489359558;3811.371123764548;3841.654251117413;5833.416658334133;5913.142594323885;5942.881142377042;5973.402659733992;6003.129546215861;5705.828825135252;5710.457506536873;5728.283964504437;5753.309602847685;5821.679807610622;5681.318241810844;5724.313082430135;5744.3681195067675;5748.39641837601;5808.6224395414165;5462.672239665632;5596.440355964533;5598.300212473441;5600.327960644749;5700.25896633435;5685;5725.914111288417;5732.111522713986;5775.711214439345;5843.474087332161;5618.494335509824;5630.549556035426;5630.774769009194;5734.655920644775;5740.942590574041 07:53:51 INFO - 2015-11-18 07:53:51,368 DEBUG : BROWSER_OUTPUT: |5;yui.html;628.8930881750102;633.5185259203005;658.7332130487155;671.1141293492585;672.6647604505057;11476.426178691063;11669.183157179;11731.237469564483;12078.456469458873;12175.269483830976;11309.604163854267;11338.546458141664;11451.770964580724;11504.827427588592;11537.711557211074;603.9003564411867;619.6003577692386;740.9296116868902;753.7625647920914;780.6018930345537;739.4269441183072;750.2160242546524;757.2654525110634;758.2152472191283;766.9875763991533;797.1709422200933;798.7843282313772;804.4610111225493;808.3412019204329;809.4333966223637;781.5662307419379;787.4645241235958;788.3574886467511;788.9250521200477;791.7426836278232;588.5085953229059;589.8436914217735;590.7873165660359;595.7259660556149;596.269569777024;11346.43267836613;11461.942690286494;11482.770344593146;11525.250858694159;11630.592929247521;9521.714348569554;9649.90350096497;9983.550740216635;10065.748356291151;10310.43292618913;7849.411294152961;7852.882206766903;7947.125816160218;8018.639161237758;8189;2706.1260375221573;2753.8072334936564;2776.5141100307364;2791.3440341519727;2819.2810833237395;41189.79405102955;41571.1685766286;41676.58323416757;41870.790646046575;43568.564314356765;7674.616269186518;7685.269899359552;7964.442489025829;8111.3916456266015;8276.26198498322;16197.190140493163;16378.50864474044;16546.751798723028;16559.17204139788;16565.834341656428;5901.940980590139;5902.173695682608;5917.55618328627;6109.969450152809;6121.47967422774;3077.7999430036975;3124.0940127363265;3160.3205310858275;3189.2983543620367;3208.4545627243424;2546.719860815309;2558.8976440942524;2567.435164263859;2597.909073182467;2606.609008648718;343.8069897455824;349.86705052080555;355.5111721383098;359.6044351213644;360.423322683704;418.70690516638473;442.17313623524217;448.5895405703744;498.5737194698553;534.8101423994503;6624.8012559623285;7041.5422997505;7051.682674279669;7286.307800758919;7488.9625551871895;420.6277444461612;426.8506022892025;463.97216167030086;527.1328664347127;536.7516109989467;3011.1869795155185;3303.900882973515;3307.107081088141;3381.3575420669995;3382.8815991440183;50532;51198.74400627973;51826.48173518292;52094.73952630288;52349.2147617786;43858;44434;44451.777741111735;45408.3188752169;45503.317450238275;40289;40574.39138412926;40799.388009179886;41148.38277425841;41239.587604123575;6624.238212605419;6676.365745254193;6686.431653309523;6708.698108585223;6751.93248067513;29374.853125734233;29613.85193074021;29743.25641858971;30541;30560.235994100327;37312.81343593264;37861.81069094637;40025.399619005155;40500;40571;6044.184035155197;6050.757969681164;6056.3035250946705;6189.907151392823;6387.233531976192;8811.33914956368;8923.643054277756;9180.908190918006;9209.907900920905;10522.053015228666;9125.543722813965;9306.581203845708;9359.204467620328;9807.06832850878;9881.50592470388;8898.73303800887;8925.018247992846;8983.609834099489;9140.817183656423;9698.224142068759;8776.429532080394;9227.86158207614;9319.767005824908;9415.858762118436;9463.952680236554;7682.270184332479;7751.379889608705;8194.34445244391;8204;8616.439931404439;7033.226345101933;7170.354668079898;7466;7675.961620191863;7897.24976127267 07:53:51 INFO - 2015-11-18 07:53:51,368 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:53:51 INFO - 2015-11-18 07:53:51,368 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:53:51 INFO - 2015-11-18 07:53:51,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 07:53:51 INFO - 2015-11-18 07:53:51,369 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:53:51 INFO - 2015-11-18 07:53:51,369 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862031353__endTimestamp 07:53:51 INFO - 2015-11-18 07:53:51,369 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,369 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:53:51 INFO - 2015-11-18 07:53:51,369 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:53:51 INFO - 2015-11-18 07:53:51,369 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,370 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4423.78 Median:4569.09 stddev:577.40 (12.6%) stddev-sans-first:560.46 07:53:51 INFO - 2015-11-18 07:53:51,370 DEBUG : BROWSER_OUTPUT: Values: 2565.7 2594.9 2633.9 2655.5 2659.9 4372.6 4422.3 4439.8 4554.6 4575.0 4318.9 4334.4 4357.9 4407.1 4414.7 4143.3 4145.6 4186.4 4300.1 4361.8 4254.3 4297.1 4304.9 4316.8 4319.1 82.0 4144.6 4175.0 4251.9 4363.7 4164.4 4176.6 4196.1 4234.0 4260.1 4154.8 4172.2 4202.2 4214.3 4249.9 4109.0 4317.2 4336.8 4388.8 4444.5 4729.5 4744.7 4752.4 4769.5 4802.0 4774.7 4787.2 4826.0 4860.1 4865.4 4284.4 4397.7 4422.9 4482.9 4499.5 4764.6 4851.5 4854.7 4860.3 4903.3 4656.8 4665.7 4671.7 4737.3 4803.6 4634.9 4648.0 4666.4 4749.5 4758.8 4695.8 4714.8 4727.7 4737.9 4765.0 4492.8 4695.5 4698.8 4714.8 4745.5 3658.8 3686.5 3708.3 3716.0 3729.5 3362.4 3374.8 3409.7 3409.8 3424.9 4283.9 4413.1 4459.9 4460.4 4467.8 4745.7 4763.0 4779.3 4809.6 4890.9 4484.7 4507.9 4512.8 4520.1 4548.3 4108.1 4119.5 4203.9 4240.0 4274.4 4929.4 4941.1 4962.0 4965.7 4983.1 4830.0 4839.7 4845.7 4891.4 4933.1 4765.3 4771.8 4791.8 4896.6 4933.3 4718.3 4729.1 4773.9 4777.5 4832.8 4773.6 4777.3 4813.6 4825.3 4933.2 4454.1 4523.5 4683.1 4691.0 4694.2 4582.2 4598.0 4600.2 4621.3 4688.4 4504.1 4513.7 4540.0 4551.3 4588.2 4470.9 4541.2 4588.8 4604.2 4709.7 4569.1 4571.4 4615.2 4617.1 4705.1 07:53:51 INFO - 2015-11-18 07:53:51,370 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,370 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40378.74 Median:33785.74 stddev:66622.33 (197.2%) stddev-sans-first:66741.78 07:53:51 INFO - 2015-11-18 07:53:51,372 DEBUG : BROWSER_OUTPUT: Values: 454.1 463.3 465.5 489.2 504.1 32891.0 33978.0 34044.8 34310.1 34492.3 35871.0 35921.3 36397.8 36453.5 36553.3 7666.3 7878.5 7910.1 8013.8 8021.3 7789.1 7809.2 7850.3 7954.6 7974.0 7735.5 7800.7 7816.1 7933.3 7977.9 7653.5 7735.3 7749.7 7782.3 7837.5 7664.6 7756.8 7765.3 7857.8 7909.6 33388.2 33581.5 33584.3 33797.2 34200.3 2536.9 2546.4 2902.7 3034.1 3067.9 23059.4 23362.6 23727.2 23741.6 24076.9 2034.1 2042.6 2054.4 2061.1 2088.7 230537.0 230726.0 230822.0 231393.0 234979.0 42423.8 44108.8 49845.0 50227.5 51818.2 50722.0 50897.2 51048.2 51355.5 51624.2 12063.0 12276.9 12289.3 12291.9 12486.4 9270.2 9280.1 9290.5 9306.3 9366.6 16247.4 16331.3 16443.4 16464.8 16515.0 6778.0 6904.4 6929.5 6942.3 7002.2 744.1 785.3 809.7 819.0 948.3 23466.4 23682.0 23715.0 23880.8 23909.9 861.7 878.7 901.1 963.7 1014.6 12604.6 12718.0 12853.7 13271.5 13351.3 279525.0 279880.0 279977.0 281339.0 282067.0 45709.0 46210.8 46366.5 46391.3 46426.0 1121.2 1130.8 1144.2 1151.0 1163.5 24017.3 24426.6 24676.3 24706.8 24738.0 40551.2 40947.2 40957.0 41015.8 41029.4 248376.0 249402.0 250219.0 251028.0 253261.0 25199.6 35799.8 36878.8 37085.4 37177.8 38911.6 40419.2 40615.0 40680.2 41225.4 32387.2 32505.8 32938.7 33556.3 33774.3 31825.5 32274.2 32520.0 32710.7 33236.3 32948.0 33097.2 33187.5 33695.0 33753.2 27021.4 28573.4 29015.1 29071.9 29317.4 21066.5 21810.9 21816.8 21820.5 22095.4 07:53:51 INFO - 2015-11-18 07:53:51,372 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,372 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:18483.40 Median:4435.86 stddev:53650.70 (1209.5%) stddev-sans-first:53783.79 07:53:51 INFO - 2015-11-18 07:53:51,373 DEBUG : BROWSER_OUTPUT: Values: 275.7 276.8 276.9 278.4 289.1 12162.3 14428.1 14604.9 14946.6 15207.9 14468.1 14517.0 14691.6 14957.0 15013.4 3768.9 3893.9 3935.6 4005.1 4590.7 3883.1 3932.3 3945.8 3997.0 4011.6 3779.7 3822.5 3888.8 3984.3 4138.4 3163.3 3896.8 3898.6 3971.5 3973.3 3138.0 3316.6 3322.4 3361.9 3447.2 10614.8 10676.9 10928.5 10985.9 11034.0 1598.1 1618.2 1624.4 1630.8 1695.7 7836.2 7920.5 8169.9 8209.4 8243.6 1245.2 1312.3 1314.9 1335.7 1374.2 47994.8 49099.3 49211.3 49235.8 49847.0 5402.7 5452.9 5462.4 5496.7 5501.1 6121.4 6135.8 6145.8 6174.0 6205.3 4354.8 4434.5 4437.2 4439.0 4509.8 4636.2 4677.0 4682.5 4715.3 4746.1 2416.9 2462.6 2473.0 2474.8 2487.1 879.5 879.7 882.7 885.6 924.0 346.2 354.6 361.4 376.0 381.7 8365.7 8739.0 8821.6 8864.3 9010.1 336.1 337.8 344.1 344.2 346.7 4650.2 4895.1 5218.7 5231.1 5255.7 318780.0 324609.0 326893.0 330664.0 331449.0 49214.3 52368.7 52817.5 52989.5 54571.0 389.3 401.4 402.3 403.5 404.2 8683.3 8773.4 8813.9 8946.0 9092.3 26917.9 27191.6 27965.7 28117.7 28482.1 36321.0 36934.8 37369.7 37640.0 37816.1 5062.4 5148.4 5185.8 5207.8 5267.9 9640.4 9705.3 9922.1 9946.2 9961.0 8396.2 8479.6 8704.8 8744.7 8761.3 8241.5 8310.8 8413.5 8439.2 8621.7 8562.8 8622.2 8639.3 8788.1 8932.2 5096.7 5119.7 5145.7 5155.4 5157.9 8488.2 8531.4 8568.2 8648.7 8676.9 07:53:51 INFO - 2015-11-18 07:53:51,374 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,374 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4219.96 Median:5390.38 stddev:2141.45 (39.7%) stddev-sans-first:2135.08 07:53:51 INFO - 2015-11-18 07:53:51,375 DEBUG : BROWSER_OUTPUT: Values: 1156.9 1177.8 1347.0 1485.1 1490.3 5442.9 5561.8 6095.9 6324.4 6371.9 5774.0 6084.8 6132.0 6171.6 6207.2 1749.1 1767.0 1771.3 1773.5 1797.0 1792.4 1798.0 1807.1 1820.1 1826.7 1714.3 1743.8 1751.7 1761.8 1770.1 1734.2 1765.3 1789.8 1798.2 1815.9 1752.6 1762.9 1785.1 1802.5 1810.6 6087.9 6126.8 6132.8 6134.9 6177.9 3678.0 3697.1 3701.3 3714.2 3755.3 2069.1 2079.8 2377.7 2412.1 2462.0 753.2 759.8 766.7 787.7 789.5 7717.6 7852.3 7864.8 7874.9 7890.1 3341.9 3368.0 3369.5 3428.1 3433.2 6876.7 6883.1 6922.2 6944.1 6985.0 3736.9 3776.0 3800.3 3811.7 3833.6 3448.4 3465.7 3483.8 3490.4 3515.3 2896.9 2898.5 2915.2 2931.2 2939.8 865.1 868.2 869.2 880.3 883.1 1060.5 1082.7 1087.3 1089.0 1122.7 5741.3 5751.1 5760.9 5830.5 5894.6 404.0 407.2 409.6 410.3 411.4 4521.0 4558.7 4586.1 4626.4 4628.1 6625.6 6650.4 6790.0 6974.4 7100.5 6797.6 6896.1 6936.4 6942.5 6972.5 5609.2 5714.1 5725.8 5763.6 5803.4 5413.3 5446.1 5460.3 5491.8 5534.0 6214.6 6272.2 6284.2 6345.3 6451.5 6494.4 6498.8 6502.9 6540.0 6552.0 5298.5 5306.8 5346.1 5394.1 5412.1 5825.4 5836.2 5850.0 5908.6 5937.2 5448.5 5508.9 5548.2 5598.1 5667.2 5299.7 5346.4 5424.2 5534.1 5562.6 5386.7 5472.2 5536.9 5554.6 5569.8 4967.3 5052.1 5060.9 5086.3 5107.3 5087.0 5127.2 5129.7 5179.2 5225.6 07:53:51 INFO - 2015-11-18 07:53:51,375 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,375 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4771.47 Median:5442.15 stddev:1469.28 (27.0%) stddev-sans-first:1433.65 07:53:51 INFO - 2015-11-18 07:53:51,376 DEBUG : BROWSER_OUTPUT: Values: 249.0 258.5 258.6 263.4 264.5 5305.5 5377.3 5399.5 5454.8 5547.0 5248.6 5330.4 5350.0 5373.0 5489.6 4178.9 4233.8 4236.4 4239.5 4247.6 4148.4 4221.8 4236.8 4254.0 4295.5 4103.9 4127.0 4161.9 4175.8 4234.9 4112.2 4135.7 4152.9 4180.6 4219.7 3523.6 3549.0 3569.7 3608.1 3617.4 5061.5 5173.6 5230.2 5280.7 5288.1 4634.3 4654.5 4658.7 4662.1 4717.2 5644.5 5658.5 5698.1 5741.1 5757.8 3856.7 3870.4 3873.3 3904.2 3918.6 5783.8 5871.3 5937.0 5969.2 5976.6 3933.9 3935.3 3940.3 3962.8 3964.3 4002.2 4002.9 4004.1 4075.0 4079.3 4606.4 4636.9 4641.4 4676.3 4712.8 5495.4 5639.6 5663.1 5683.8 5770.3 1342.9 1365.9 1367.7 1383.3 1391.7 856.5 866.0 879.3 894.1 900.2 5342.5 5356.6 5377.5 5401.8 5433.9 5850.4 5862.3 5876.0 5947.9 5950.8 5360.9 5372.9 5394.9 5434.9 5449.4 3147.1 3177.8 3200.8 3210.7 3266.7 6093.6 6138.7 6220.9 6231.4 6236.9 5829.0 6012.3 6066.0 6118.9 6163.0 6120.7 6157.6 6170.0 6172.5 6226.1 5962.8 6008.4 6042.3 6049.2 6073.0 5552.2 5785.1 5866.9 5919.1 5943.0 6121.9 6141.1 6151.7 6236.2 6237.0 3628.5 3753.9 3767.3 3811.4 3841.7 5833.4 5913.1 5942.9 5973.4 6003.1 5705.8 5710.5 5728.3 5753.3 5821.7 5681.3 5724.3 5744.4 5748.4 5808.6 5462.7 5596.4 5598.3 5600.3 5700.3 5685.0 5725.9 5732.1 5775.7 5843.5 5618.5 5630.5 5630.8 5734.7 5740.9 07:53:51 INFO - 2015-11-18 07:53:51,377 DEBUG : BROWSER_OUTPUT: 07:53:51 INFO - 2015-11-18 07:53:51,377 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11704.78 Median:3246.36 stddev:14156.80 (436.1%) stddev-sans-first:14172.08 07:53:51 INFO - 2015-11-18 07:53:51,378 DEBUG : BROWSER_OUTPUT: Values: 628.9 633.5 658.7 671.1 672.7 11476.4 11669.2 11731.2 12078.5 12175.3 11309.6 11338.5 11451.8 11504.8 11537.7 603.9 619.6 740.9 753.8 780.6 739.4 750.2 757.3 758.2 767.0 797.2 798.8 804.5 808.3 809.4 781.6 787.5 788.4 788.9 791.7 588.5 589.8 590.8 595.7 596.3 11346.4 11461.9 11482.8 11525.3 11630.6 9521.7 9649.9 9983.6 10065.7 10310.4 7849.4 7852.9 7947.1 8018.6 8189.0 2706.1 2753.8 2776.5 2791.3 2819.3 41189.8 41571.2 41676.6 41870.8 43568.6 7674.6 7685.3 7964.4 8111.4 8276.3 16197.2 16378.5 16546.8 16559.2 16565.8 5901.9 5902.2 5917.6 6110.0 6121.5 3077.8 3124.1 3160.3 3189.3 3208.5 2546.7 2558.9 2567.4 2597.9 2606.6 343.8 349.9 355.5 359.6 360.4 418.7 442.2 448.6 498.6 534.8 6624.8 7041.5 7051.7 7286.3 7489.0 420.6 426.9 464.0 527.1 536.8 3011.2 3303.9 3307.1 3381.4 3382.9 50532.0 51198.7 51826.5 52094.7 52349.2 43858.0 44434.0 44451.8 45408.3 45503.3 40289.0 40574.4 40799.4 41148.4 41239.6 6624.2 6676.4 6686.4 6708.7 6751.9 29374.9 29613.9 29743.3 30541.0 30560.2 37312.8 37861.8 40025.4 40500.0 40571.0 6044.2 6050.8 6056.3 6189.9 6387.2 8811.3 8923.6 9180.9 9209.9 10522.1 9125.5 9306.6 9359.2 9807.1 9881.5 8898.7 8925.0 8983.6 9140.8 9698.2 8776.4 9227.9 9319.8 9415.9 9464.0 7682.3 7751.4 8194.3 8204.0 8616.4 7033.2 7170.4 7466.0 7676.0 7897.2 07:53:51 INFO - 2015-11-18 07:53:51,379 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:53:51 INFO - 2015-11-18 07:53:51,379 DEBUG : BROWSER_OUTPUT: 07:53:52 INFO - 2015-11-18 07:53:52,019 INFO : Browser exited with error code: 0 07:53:52 INFO - 2015-11-18 07:53:52,051 INFO : Completed test dromaeo_css (00:18:32) 07:53:52 INFO - 2015-11-18 07:53:52,051 INFO : Starting test kraken 07:53:52 INFO - 2015-11-18 07:53:52,051 DEBUG : operating with platform_type : mac_ 07:53:52 INFO - 2015-11-18 07:53:52,051 INFO : Initialising browser for kraken test... 07:53:52 INFO - 2015-11-18 07:53:52,066 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpqrjd5X/profile http://localhost:49277/getInfo.html 07:53:55 INFO - 2015-11-18 07:53:55,734 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:53:55 INFO - 2015-11-18 07:53:55,735 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:53:55 INFO - 2015-11-18 07:53:55,735 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:53:55 INFO - 2015-11-18 07:53:55,735 DEBUG : BROWSER_OUTPUT: __metrics 07:53:56 INFO - 2015-11-18 07:53:56,483 INFO : Browser initialized. 07:53:56 INFO - 2015-11-18 07:53:56,484 INFO : Running cycle 1/1 for kraken test... 07:53:56 INFO - 2015-11-18 07:53:56,484 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpqrjd5X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:54:08 INFO - 2015-11-18 07:54:08,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 242143232 07:54:08 INFO - 2015-11-18 07:54:08,705 DEBUG : BROWSER_OUTPUT: 07:54:11 INFO - 2015-11-18 07:54:11,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 07:54:12 INFO - 2015-11-18 07:54:12,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 260186112 07:54:12 INFO - 2015-11-18 07:54:12,274 DEBUG : BROWSER_OUTPUT: 07:54:15 INFO - 2015-11-18 07:54:15,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 07:54:15 INFO - 2015-11-18 07:54:15,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 267530240 07:54:15 INFO - 2015-11-18 07:54:15,951 DEBUG : BROWSER_OUTPUT: 07:54:19 INFO - 2015-11-18 07:54:19,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 07:54:19 INFO - 2015-11-18 07:54:19,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 268722176 07:54:19 INFO - 2015-11-18 07:54:19,876 DEBUG : BROWSER_OUTPUT: 07:54:22 INFO - 2015-11-18 07:54:22,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 07:54:22 INFO - 2015-11-18 07:54:22,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 269402112 07:54:22 INFO - 2015-11-18 07:54:22,725 DEBUG : BROWSER_OUTPUT: 07:54:25 INFO - 2015-11-18 07:54:25,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:25 INFO - 2015-11-18 07:54:25,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 269643776 07:54:25 INFO - 2015-11-18 07:54:25,706 DEBUG : BROWSER_OUTPUT: 07:54:29 INFO - 2015-11-18 07:54:29,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:29 INFO - 2015-11-18 07:54:29,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 267739136 07:54:29 INFO - 2015-11-18 07:54:29,826 DEBUG : BROWSER_OUTPUT: 07:54:33 INFO - 2015-11-18 07:54:33,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:34 INFO - 2015-11-18 07:54:34,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 266268672 07:54:34 INFO - 2015-11-18 07:54:34,080 DEBUG : BROWSER_OUTPUT: 07:54:37 INFO - 2015-11-18 07:54:37,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 07:54:37 INFO - 2015-11-18 07:54:37,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 268283904 07:54:37 INFO - 2015-11-18 07:54:37,989 DEBUG : BROWSER_OUTPUT: 07:54:39 INFO - 2015-11-18 07:54:39,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:40 INFO - 2015-11-18 07:54:40,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 269053952 07:54:40 INFO - 2015-11-18 07:54:40,347 DEBUG : BROWSER_OUTPUT: 07:54:42 INFO - 2015-11-18 07:54:42,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:43 INFO - 2015-11-18 07:54:43,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 267919360 07:54:43 INFO - 2015-11-18 07:54:43,050 DEBUG : BROWSER_OUTPUT: 07:54:45 INFO - 2015-11-18 07:54:45,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:46 INFO - 2015-11-18 07:54:46,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 267898880 07:54:46 INFO - 2015-11-18 07:54:46,041 DEBUG : BROWSER_OUTPUT: 07:54:49 INFO - 2015-11-18 07:54:49,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:49 INFO - 2015-11-18 07:54:49,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 267968512 07:54:49 INFO - 2015-11-18 07:54:49,660 DEBUG : BROWSER_OUTPUT: 07:54:52 INFO - 2015-11-18 07:54:52,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:53 INFO - 2015-11-18 07:54:53,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 267988992 07:54:53 INFO - 2015-11-18 07:54:53,269 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 07:54:55 INFO - 2015-11-18 07:54:55,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 269725696 07:54:55 INFO - 2015-11-18 07:54:55,461 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,461 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:54:55 INFO - 2015-11-18 07:54:55,461 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:54:55 INFO - 2015-11-18 07:54:55,461 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:54:55 INFO - 2015-11-18 07:54:55,461 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:54:55 INFO - 2015-11-18 07:54:55,462 DEBUG : BROWSER_OUTPUT: |0;ai-astar;130;131;137;136;138;150;145;142;137;138 07:54:55 INFO - 2015-11-18 07:54:55,462 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;181;169;192;205;163;178;177;164;201;165 07:54:55 INFO - 2015-11-18 07:54:55,462 DEBUG : BROWSER_OUTPUT: |2;audio-dft;199;215;209;206;202;201;202;201;204;199 07:54:55 INFO - 2015-11-18 07:54:55,462 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;88;97;147;86;86;91;90;123;83 07:54:55 INFO - 2015-11-18 07:54:55,463 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;102;108;152;109;114;113;146;108;109;152 07:54:55 INFO - 2015-11-18 07:54:55,463 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;150;142;142;157;154;149;148;150;150;143 07:54:55 INFO - 2015-11-18 07:54:55,463 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;157;165;161;156;157;156;156;156;164;161 07:54:55 INFO - 2015-11-18 07:54:55,463 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;134;123;137;124;126;123;117;123;134 07:54:55 INFO - 2015-11-18 07:54:55,463 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;73;75;78;80;78;79;86;77;78 07:54:55 INFO - 2015-11-18 07:54:55,463 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;82;87;86;88;88;89;89;92;94 07:54:55 INFO - 2015-11-18 07:54:55,463 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;102;105;111;113;111;112;107;106;110;109 07:54:55 INFO - 2015-11-18 07:54:55,463 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;162;173;160;173;162;171;166;160;155;163 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;183;191;193;194;191;178;191;193;191;179 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;85;90;91;88;92;94;93;92;88 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,755 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862095455__endTimestamp 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,464 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:54:55 INFO - 2015-11-18 07:54:55,465 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:54:55 INFO - 2015-11-18 07:54:55,465 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,465 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:138.40 Median:138.00 stddev:6.02 (4.4%) stddev-sans-first:5.57 07:54:55 INFO - 2015-11-18 07:54:55,465 DEBUG : BROWSER_OUTPUT: Values: 130.0 131.0 137.0 136.0 138.0 150.0 145.0 142.0 137.0 138.0 07:54:55 INFO - 2015-11-18 07:54:55,465 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,465 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:179.50 Median:179.50 stddev:15.32 (8.5%) stddev-sans-first:16.24 07:54:55 INFO - 2015-11-18 07:54:55,465 DEBUG : BROWSER_OUTPUT: Values: 181.0 169.0 192.0 205.0 163.0 178.0 177.0 164.0 201.0 165.0 07:54:55 INFO - 2015-11-18 07:54:55,465 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,466 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:203.80 Median:203.00 stddev:5.01 (2.5%) stddev-sans-first:5.00 07:54:55 INFO - 2015-11-18 07:54:55,466 DEBUG : BROWSER_OUTPUT: Values: 199.0 215.0 209.0 206.0 202.0 201.0 202.0 201.0 204.0 199.0 07:54:55 INFO - 2015-11-18 07:54:55,466 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,466 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.00 Median:87.00 stddev:21.35 (24.5%) stddev-sans-first:21.63 07:54:55 INFO - 2015-11-18 07:54:55,466 DEBUG : BROWSER_OUTPUT: Values: 79.0 88.0 97.0 147.0 86.0 86.0 91.0 90.0 123.0 83.0 07:54:55 INFO - 2015-11-18 07:54:55,466 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,466 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:121.30 Median:113.50 stddev:20.13 (17.7%) stddev-sans-first:20.10 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: Values: 102.0 108.0 152.0 109.0 114.0 113.0 146.0 108.0 109.0 152.0 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:148.50 Median:150.00 stddev:4.99 (3.3%) stddev-sans-first:5.27 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: Values: 150.0 142.0 142.0 157.0 154.0 149.0 148.0 150.0 150.0 143.0 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:158.90 Median:159.00 stddev:3.54 (2.2%) stddev-sans-first:3.69 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: Values: 157.0 165.0 161.0 156.0 157.0 156.0 156.0 156.0 164.0 161.0 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,467 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.90 Median:125.00 stddev:6.87 (5.5%) stddev-sans-first:6.67 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: Values: 118.0 134.0 123.0 137.0 124.0 126.0 123.0 117.0 123.0 134.0 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:77.10 Median:78.00 stddev:4.91 (6.3%) stddev-sans-first:3.60 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: Values: 67.0 73.0 75.0 78.0 80.0 78.0 79.0 86.0 77.0 78.0 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:87.50 Median:88.50 stddev:4.17 (4.7%) stddev-sans-first:3.43 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 87.0 86.0 88.0 88.0 89.0 89.0 92.0 94.0 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:108.60 Median:110.50 stddev:3.50 (3.2%) stddev-sans-first:2.78 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: Values: 102.0 105.0 111.0 113.0 111.0 112.0 107.0 106.0 110.0 109.0 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:164.50 Median:164.50 stddev:6.10 (3.7%) stddev-sans-first:6.40 07:54:55 INFO - 2015-11-18 07:54:55,468 DEBUG : BROWSER_OUTPUT: Values: 162.0 173.0 160.0 173.0 162.0 171.0 166.0 160.0 155.0 163.0 07:54:55 INFO - 2015-11-18 07:54:55,469 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,469 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.40 Median:191.00 stddev:6.02 (3.2%) stddev-sans-first:6.06 07:54:55 INFO - 2015-11-18 07:54:55,469 DEBUG : BROWSER_OUTPUT: Values: 183.0 191.0 193.0 194.0 191.0 178.0 191.0 193.0 191.0 179.0 07:54:55 INFO - 2015-11-18 07:54:55,469 DEBUG : BROWSER_OUTPUT: 07:54:55 INFO - 2015-11-18 07:54:55,469 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.40 Median:91.50 stddev:4.01 (4.4%) stddev-sans-first:2.87 07:54:55 INFO - 2015-11-18 07:54:55,469 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 90.0 91.0 88.0 92.0 94.0 93.0 92.0 88.0 07:54:55 INFO - 2015-11-18 07:54:55,469 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:54:55 INFO - 2015-11-18 07:54:55,469 DEBUG : BROWSER_OUTPUT: 07:54:56 INFO - 2015-11-18 07:54:56,195 INFO : Browser exited with error code: 0 07:54:56 INFO - 2015-11-18 07:54:56,250 INFO : Completed test kraken (00:01:04) 07:54:56 INFO - 2015-11-18 07:54:56,251 INFO : Starting test v8_7 07:54:56 INFO - 2015-11-18 07:54:56,251 DEBUG : operating with platform_type : mac_ 07:54:56 INFO - 2015-11-18 07:54:56,251 INFO : Initialising browser for v8_7 test... 07:54:56 INFO - 2015-11-18 07:54:56,268 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpMDPwM_/profile http://localhost:49277/getInfo.html 07:54:59 INFO - 2015-11-18 07:54:59,609 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:54:59 INFO - 2015-11-18 07:54:59,609 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:54:59 INFO - 2015-11-18 07:54:59,609 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:54:59 INFO - 2015-11-18 07:54:59,609 DEBUG : BROWSER_OUTPUT: __metrics 07:55:00 INFO - 2015-11-18 07:55:00,352 INFO : Browser initialized. 07:55:00 INFO - 2015-11-18 07:55:00,353 INFO : Running cycle 1/1 for v8_7 test... 07:55:00 INFO - 2015-11-18 07:55:00,353 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpMDPwM_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:55:12 INFO - 2015-11-18 07:55:12,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 240939008 07:55:12 INFO - 2015-11-18 07:55:12,588 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/v8_7/run.html (next: http://localhost:49277/tests/v8_7/run.html) 07:55:35 INFO - 2015-11-18 07:55:35,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 261750784 07:55:35 INFO - 2015-11-18 07:55:35,490 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,490 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:55:35 INFO - 2015-11-18 07:55:35,491 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:55:35 INFO - 2015-11-18 07:55:35,491 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:55:35 INFO - 2015-11-18 07:55:35,491 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:55:35 INFO - 2015-11-18 07:55:35,491 DEBUG : BROWSER_OUTPUT: |0;Richards;196.61816751867872 07:55:35 INFO - 2015-11-18 07:55:35,491 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;234.46658851113716 07:55:35 INFO - 2015-11-18 07:55:35,491 DEBUG : BROWSER_OUTPUT: |2;Encrypt;379.5066413662239 07:55:35 INFO - 2015-11-18 07:55:35,491 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7485.074626865671 07:55:35 INFO - 2015-11-18 07:55:35,492 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1378.7878787878788 07:55:35 INFO - 2015-11-18 07:55:35,492 DEBUG : BROWSER_OUTPUT: |5;Earley;1068.3030949839915 07:55:35 INFO - 2015-11-18 07:55:35,492 DEBUG : BROWSER_OUTPUT: |6;Boyer;15890.625 07:55:35 INFO - 2015-11-18 07:55:35,492 DEBUG : BROWSER_OUTPUT: |7;RegExp;34517.24137931035 07:55:35 INFO - 2015-11-18 07:55:35,492 DEBUG : BROWSER_OUTPUT: |8;Splay;796.8253968253969 07:55:35 INFO - 2015-11-18 07:55:35,492 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6802.721088435374 07:55:35 INFO - 2015-11-18 07:55:35,492 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862135488__endTimestamp 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:196.62 Median:196.62 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: Values: 196.6 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,493 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:234.47 Median:234.47 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,494 DEBUG : BROWSER_OUTPUT: Values: 234.5 07:55:35 INFO - 2015-11-18 07:55:35,494 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,494 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:379.51 Median:379.51 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,494 DEBUG : BROWSER_OUTPUT: Values: 379.5 07:55:35 INFO - 2015-11-18 07:55:35,494 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,494 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7485.07 Median:7485.07 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,495 DEBUG : BROWSER_OUTPUT: Values: 7485.1 07:55:35 INFO - 2015-11-18 07:55:35,495 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,495 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1378.79 Median:1378.79 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,495 DEBUG : BROWSER_OUTPUT: Values: 1378.8 07:55:35 INFO - 2015-11-18 07:55:35,495 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,495 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1068.30 Median:1068.30 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,496 DEBUG : BROWSER_OUTPUT: Values: 1068.3 07:55:35 INFO - 2015-11-18 07:55:35,496 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,496 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15890.63 Median:15890.63 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,496 DEBUG : BROWSER_OUTPUT: Values: 15890.6 07:55:35 INFO - 2015-11-18 07:55:35,496 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,496 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34517.24 Median:34517.24 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,497 DEBUG : BROWSER_OUTPUT: Values: 34517.2 07:55:35 INFO - 2015-11-18 07:55:35,497 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,497 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:796.83 Median:796.83 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,497 DEBUG : BROWSER_OUTPUT: Values: 796.8 07:55:35 INFO - 2015-11-18 07:55:35,497 DEBUG : BROWSER_OUTPUT: 07:55:35 INFO - 2015-11-18 07:55:35,497 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6802.72 Median:6802.72 stddev:0.00 (0.0%) 07:55:35 INFO - 2015-11-18 07:55:35,498 DEBUG : BROWSER_OUTPUT: Values: 6802.7 07:55:35 INFO - 2015-11-18 07:55:35,498 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:55:35 INFO - 2015-11-18 07:55:35,498 DEBUG : BROWSER_OUTPUT: 07:55:36 INFO - 2015-11-18 07:55:36,254 INFO : Browser exited with error code: 0 07:55:36 INFO - 2015-11-18 07:55:36,278 INFO : Completed test v8_7 (00:00:40) 07:55:36 INFO - 2015-11-18 07:55:36,413 INFO : Completed test suite (00:20:17) 07:55:36 INFO - 2015-11-18 07:55:36,413 DEBUG : Working with test: dromaeo_css 07:55:36 INFO - 2015-11-18 07:55:36,413 DEBUG : Generating results file: dromaeo_css 07:55:36 INFO - 2015-11-18 07:55:36,414 DEBUG : Working with test: kraken 07:55:36 INFO - 2015-11-18 07:55:36,414 DEBUG : Generating results file: kraken 07:55:36 INFO - 2015-11-18 07:55:36,414 INFO : javascript benchmark 07:55:36 INFO - 2015-11-18 07:55:36,415 DEBUG : Working with test: v8_7 07:55:36 INFO - 2015-11-18 07:55:36,415 DEBUG : Generating results file: v8_7 07:55:36 INFO - 2015-11-18 07:55:36,415 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:55:36 INFO - 2015-11-18 07:55:36,488 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 07:55:36 INFO - 2015-11-18 07:55:36,488 DEBUG : process_Request line: dromaeo_css 5533.87 graph.html#tests=[[72,63,57]] 07:55:36 INFO - 2015-11-18 07:55:36,488 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:55:36 INFO - 2015-11-18 07:55:36,523 DEBUG : process_Request line: kraken 1888.80 graph.html#tests=[[232,63,57]] 07:55:36 INFO - 2015-11-18 07:55:36,523 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:55:36 INFO - 2015-11-18 07:55:36,640 DEBUG : process_Request line: v8_7 16004.54 graph.html#tests=[[230,63,57]] 07:55:36 INFO - 2015-11-18 07:55:36,641 INFO : javascript benchmark 07:55:36 INFO - 2015-11-18 07:55:36,643 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2565.653636759037, 2594.935126621834, 2633.9078132265363, 2655.5352813257673, 2659.867006649667, 4372.628326592236, 4422.27032539631, 4439.822407103712, 4554.567316104969, 4575.0, 4318.9352159717555, 4334.41485399471, 4357.869263922087, 4407.140607581523, 4414.690971631979, 4143.254214241435, 4145.5647157048525, 4186.37204419338, 4300.096979634281, 4361.803718832644, 4254.340577210537, 4297.119090586422, 4304.913901721964, 4316.805743741524, 4319.136172765444, 81.95780812037961, 4144.6062624050965, 4174.958250417488, 4251.893702657443, 4363.672724545656, 4164.416981622575, 4176.561461046576, 4196.097838964607, 4233.957660423387, 4260.084081922401, 4154.792260386968, 4172.228137794517, 4202.222588821078, 4214.325707886754, 4249.893752656209, 4109.013836679205, 4317.244482215599, 4336.848210312624, 4388.802503887301, 4444.511103778582, 4729.4797572267025, 4744.667873248874, 4752.382190315237, 4769.499202583714, 4802.0, 4774.73738944358, 4787.234042553175, 4825.951740482586, 4860.149473842063, 4865.416150062015, 4284.357346398034, 4397.670174736908, 4422.911541769146, 4482.910341793178, 4499.482559505699, 4764.571188593043, 4851.466338702739, 4854.708717476963, 4860.3195552622665, 4903.313536104948, 4656.790444430008, 4665.650076244296, 4671.672982891233, 4737.336772851803, 4803.639727020487, 4634.86445820776, 4647.9767601161775, 4666.393368862094, 4749.501302363202, 4758.809647614056, 4695.765211739467, 4714.81140754366, 4727.692699974491, 4737.857864264078, 4764.97553026101, 4492.820287188476, 4695.5304469552775, 4698.765061746899, 4714.811407543729, 4745.477997420281, 3658.762180458262, 3686.5207523022373, 3708.332500149999, 3715.9628403715615, 3729.4778730977687, 3362.4283871741864, 3374.763766536368, 3409.6760807723226, 3409.7954122752712, 3424.8972530824117, 4283.914321713611, 4413.117376524644, 4459.910801783946, 4460.420145381145, 4467.843625473093, 4745.738984355825, 4762.9523704763205, 4779.330893674888, 4809.567138957511, 4890.902181956412, 4484.663650226246, 4507.864764057083, 4512.842050528216, 4520.0507893342765, 4548.340490628841, 4108.137291168888, 4119.485064366954, 4203.936940945889, 4240.0, 4274.422952901318, 4929.433115191727, 4941.085899108676, 4962.007598480246, 4965.702057876539, 4983.07813054586, 4829.95170048295, 4839.661223714306, 4845.733484658378, 4891.388576427947, 4933.087378834927, 4765.332853400458, 4771.76141192932, 4791.760411979457, 4896.583790377857, 4933.333999909966, 4718.292256161603, 4729.125111854318, 4773.856784296477, 4777.450593181689, 4832.830850920342, 4773.570378665937, 4777.331173635764, 4813.590844778093, 4825.300331451849, 4933.186024305949, 4454.109178164315, 4523.457185137673, 4683.086798074342, 4691.03833714081, 4694.201985662377, 4582.175208462509, 4597.977010114928, 4600.240960241523, 4621.260598304255, 4688.390509233915, 4504.076664283749, 4513.684042117152, 4540.0, 4551.294549344857, 4588.197065513455, 4470.910581788411, 4541.205289074464, 4588.793504292248, 4604.194266003503, 4709.7174169549935, 4569.086182763527, 4571.405717256735, 4615.2154133798, 4617.053504031733, 4705.082508910729], "unit": "ms", "name": "dojo.html", "value": 4390.650021906806}, {"lowerIsBetter": false, "replicates": [454.11221062822165, 463.25416080111023, 465.53446553446554, 489.20748387612076, 504.069990866851, 32891.0, 33978.0, 34044.82977585115, 34310.14224644385, 34492.31015379694, 35871.0, 35921.2815743685, 36397.81801090998, 36453.53197020448, 36553.268934621294, 7666.31003209711, 7878.487898286593, 7910.050793904739, 8013.759587212393, 8021.278084972351, 7789.104253010892, 7809.219078092202, 7850.293473587376, 7954.642041108135, 7974.0, 7735.497192682457, 7800.687972481122, 7816.140224575321, 7933.325667318285, 7977.920220797776, 7653.540787552737, 7735.303822655988, 7749.651265693001, 7782.299593036654, 7837.529748215125, 7664.578448185348, 7756.806079847993, 7765.339946104588, 7857.842843143105, 7909.564973926432, 33388.165295867795, 33581.49627755586, 33584.328313433594, 33797.155071123176, 34200.31599368023, 2536.921808231513, 2546.414324705328, 2902.6516817981765, 3034.1049390429876, 3067.938641227185, 23059.423514412105, 23362.64956025661, 23727.1695490657, 23741.643875341884, 24076.879615601985, 2034.1112479372282, 2042.5812708394744, 2054.3836848945257, 2061.1446249806313, 2088.6553718636405, 230537.0, 230726.0, 230822.0, 231393.0, 234979.0, 42423.78788106101, 44108.779456102515, 49845.0, 50227.49772502228, 51818.22272665913, 50722.0, 50897.23654145191, 51048.234276485884, 51355.48644513507, 51624.22563661548, 12063.0, 12276.938615306866, 12289.324087175291, 12291.938540307241, 12486.438110285058, 9270.165685088374, 9280.0719928008, 9290.535473226311, 9306.348555601044, 9366.62533498666, 16247.431339903047, 16331.305334619654, 16443.424480143378, 16464.83535164633, 16515.0, 6777.9661101695165, 6904.447644188453, 6929.475515386708, 6942.340477654615, 7002.159740831133, 744.0922075068407, 785.3363907498155, 809.6761295481855, 819.0130892274794, 948.3314263444255, 23466.413339666302, 23682.0, 23715.0, 23880.761192387854, 23909.880450597637, 861.7199410191713, 878.6617152396245, 901.0718959471754, 963.6675347005272, 1014.599233302856, 12604.621861344174, 12718.0, 12853.742925141632, 13271.535496257779, 13351.265680387478, 279525.0, 279880.0, 279977.0, 281339.0, 282067.0, 45709.0, 46210.768946155724, 46366.5363346369, 46391.30413043807, 46426.0, 1121.1703339528854, 1130.8190689489643, 1144.2390810111183, 1150.9597164099216, 1163.4764356039984, 24017.27948161558, 24426.633600496363, 24676.259712208663, 24706.752932470445, 24738.0, 40551.18897621972, 40947.181056379304, 40957.0, 41015.794921025205, 41029.38455923104, 248376.0, 249402.0, 250219.0, 251028.0, 253261.0, 25199.622005669564, 35799.82100089483, 36878.8156059218, 37085.443718343704, 37177.81411092927, 38911.61088389193, 40419.1916161681, 40615.0, 40680.18639627132, 41225.38161927513, 32387.19032024218, 32505.837470812494, 32938.68245270258, 33556.328873422884, 33774.3245135091, 31825.522617161223, 32274.19314517062, 32520.0, 32710.672893270763, 33236.335273294884, 32948.0, 33097.17257068496, 33187.50218746672, 33695.0, 33753.15617109494, 27021.379761958447, 28573.428531429672, 29015.12954611365, 29071.854640726662, 29317.41365172727, 21066.47333816667, 21810.890945545172, 21816.781832181474, 21820.45448863791, 22095.44761380978], "unit": "ms", "name": "ext.html", "value": 15844.262651184787}, {"lowerIsBetter": false, "replicates": [275.71601250711774, 276.78904791537025, 276.8781736036144, 278.3875473957294, 289.1484577918031, 12162.270263784158, 14428.13431194129, 14604.853951460482, 14946.5516034519, 15207.92396038021, 14468.131912085282, 14517.0, 14691.632709182275, 14957.0, 15013.399464021453, 3768.868089616857, 3893.8637147699837, 3935.5867633898456, 4005.1388951375448, 4590.724556526602, 3883.1457079442475, 3932.2725295820223, 3945.782981935992, 3996.9800150999204, 4011.618896204856, 3779.697624190072, 3822.522184726909, 3888.786116763577, 3984.342583473723, 4138.420621113047, 3163.3198862244612, 3896.7856767877756, 3898.5516665583536, 3971.543272523668, 3973.3443981742976, 3138.030391554685, 3316.635170131308, 3322.401967645823, 3361.9327613447595, 3447.24160684649, 10614.840777388268, 10676.893231067745, 10928.508217130247, 10985.945070274678, 11034.0, 1598.1130472587708, 1618.166644178249, 1624.4233297179567, 1630.8369163083714, 1695.6778212139777, 7836.216378362175, 7920.5247685139075, 8169.877451838227, 8209.38429617781, 8243.587820608946, 1245.2092920995142, 1312.2716892124963, 1314.8685131486775, 1335.7261761338902, 1374.2098293481188, 47994.7600262, 49099.263511047364, 49211.26183107256, 49235.753821231025, 49847.0, 5402.675839449567, 5452.945470545244, 5462.371827239839, 5496.6701997880255, 5501.092319767194, 6121.418465245794, 6135.754569817157, 6145.784897528565, 6174.043023331391, 6205.348438413992, 4354.782260886943, 4434.5122036576595, 4437.201303765289, 4439.0, 4509.842155524541, 4636.235021221528, 4677.041206552649, 4682.531746825291, 4715.269133284346, 4746.0745154694505, 2416.9274921752376, 2462.630605409167, 2473.0, 2474.789642880339, 2487.0549191307186, 879.5470332778624, 879.7184900831801, 882.6910581296495, 885.5882014862991, 923.9651590218998, 346.23827579325587, 354.62232722150827, 361.3784291019442, 375.9642833930772, 381.6679488844723, 8365.707200247962, 8739.0, 8821.647134114564, 8864.335174861912, 9010.05394433575, 336.132777434224, 337.8091378371212, 344.1036100957021, 344.2426661345051, 346.7330155780086, 4650.209464391061, 4895.118878601815, 5218.739063046833, 5231.136862417735, 5255.737213139328, 318780.0, 324609.0, 326893.0, 330664.0, 331449.0, 49214.261786073235, 52368.73815630897, 52817.471825282024, 52989.470105299224, 54570.99999999921, 389.2778895149457, 401.4440000599191, 402.29799000743304, 403.50570551074696, 404.20573572929334, 8683.305335573014, 8773.38586298953, 8813.867791982997, 8946.0, 9092.272618190662, 26917.865410673603, 27191.59212611852, 27965.72034279631, 28117.718822812327, 28482.145535633965, 36321.0, 36934.8153259232, 37369.69206077774, 37640.0, 37816.05459863525, 5062.367204099488, 5148.407933087593, 5185.792568297225, 5207.81772637971, 5267.894642107213, 9640.42157470554, 9705.272104592324, 9922.057404546556, 9946.204303655546, 9960.950195249266, 8396.244338009608, 8479.61841717112, 8704.825903481767, 8744.737657870273, 8761.342899282707, 8241.464304820167, 8310.833783324179, 8413.495190288602, 8439.240468357877, 8621.698240561802, 8562.78593035179, 8622.223999839794, 8639.265662418766, 8788.077251888715, 8932.151445612657, 5096.668716533413, 5119.667221630582, 5145.742712864417, 5155.3813542373655, 5157.871053223549, 8488.151184881463, 8531.445456045338, 8568.186022327869, 8648.740537783877, 8676.869846952175], "unit": "ms", "name": "jquery.html", "value": 5449.600823866724}, {"lowerIsBetter": false, "replicates": [1156.8785277545858, 1177.8115501519753, 1346.9695682802655, 1485.1163557683174, 1490.284663361587, 5442.945570544293, 5561.833145005646, 6095.878082438354, 6324.430801227894, 6371.872562548746, 5774.047282198443, 6084.756609735617, 6132.0, 6171.567990240685, 6207.162033125526, 1749.0817320906563, 1767.0, 1771.2914834066348, 1773.521149289691, 1797.0, 1792.3905872003515, 1797.9550511237194, 1807.1416077363278, 1820.062667726122, 1826.7351234071118, 1714.3228424772208, 1743.8430541251284, 1751.702210624197, 1761.806201317854, 1770.0530216334264, 1734.236935748273, 1765.3291749135374, 1789.838914497695, 1798.199801088516, 1815.9092045397808, 1752.6319472910704, 1762.9206685699173, 1785.1342099081935, 1802.4772815883377, 1810.5835657798648, 6087.908681369783, 6126.816195514097, 6132.785352512686, 6134.9079763803575, 6177.876442471171, 3678.0, 3697.131174174067, 3701.2597480504005, 3714.23858109087, 3755.3052685253315, 2069.1309649947057, 2079.750429948416, 2377.679013333195, 2412.0713525292713, 2461.9876900615563, 753.175273075981, 759.7794252924999, 766.7316439246275, 787.7321710618418, 789.4828887078972, 7717.575533345664, 7852.3325517331095, 7864.842703145962, 7874.881876771796, 7890.132085470594, 3341.916452088717, 3367.966320336814, 3369.528266042756, 3428.1086917401653, 3433.1760377509218, 6876.656167191721, 6883.139607549057, 6922.203946546111, 6944.131983502062, 6984.965075174591, 3736.9065773355883, 3775.962240377616, 3800.3349413852466, 3811.6950643948417, 3833.6166383361997, 3448.4482482803132, 3465.7054150396993, 3483.808390538494, 3490.3717330880177, 3515.34966031285, 2896.9275768105967, 2898.4637841999297, 2915.154605164521, 2931.1792698044583, 2939.779516536268, 865.1262225152641, 868.1969178509853, 869.2437579306044, 880.2605811118691, 883.0639522106587, 1060.5492665617082, 1082.658962426833, 1087.2932593814085, 1088.9618863339745, 1122.71370800447, 5741.311042674905, 5751.1085781703905, 5760.884782304331, 5830.47525722687, 5894.557908156906, 404.0424194658619, 407.21407683171765, 409.5945014435747, 410.3024857741851, 411.35212041035487, 4520.954790452053, 4558.726476411426, 4586.082783443325, 4626.352310676508, 4628.120657075212, 6625.569337993015, 6650.434713049445, 6789.966050169717, 6974.407175390149, 7100.538464999759, 6797.558158719767, 6896.103506544217, 6936.445084393236, 6942.51402401827, 6972.546784458994, 5609.186667933127, 5714.142878568248, 5725.799597014085, 5763.625364351304, 5803.390643982406, 5413.269208656939, 5446.128619420873, 5460.31746031746, 5491.835244942658, 5534.031544479781, 6214.5960512568345, 6272.247330320391, 6284.151639528605, 6345.302016778059, 6451.451626611791, 6494.350564943468, 6498.772542960974, 6502.902456463252, 6540.018997150465, 6551.967240163769, 5298.470152984671, 5306.814261500829, 5346.064438723286, 5394.08300588893, 5412.107002344569, 5825.3592104867585, 5836.241288632451, 5849.970750146222, 5908.645481271137, 5937.19847820556, 5448.536874365724, 5508.889822203613, 5548.167774833807, 5598.1322894951345, 5667.2349232854685, 5299.735013249399, 5346.385165705994, 5424.159255315432, 5534.08687566547, 5562.554995600423, 5386.676799392049, 5472.20653005304, 5536.892621475801, 5554.555635549227, 5569.830335629563, 4967.3045773591, 5052.1411360069615, 5060.873478163076, 5086.262491938574, 5107.2594473800345, 5087.008033433445, 5127.154019586876, 5129.6665716729785, 5179.171332586768, 5225.608079394136], "unit": "ms", "name": "mootools.html", "value": 3440.20391882803}, {"lowerIsBetter": false, "replicates": [248.97510248975098, 258.53721837910143, 258.5539943597294, 263.42836045780655, 264.5238570572968, 5305.522502974732, 5377.300950876385, 5399.460053994599, 5454.836354909359, 5547.0015397228535, 5248.5538729207965, 5330.413654498002, 5350.0, 5372.973135134329, 5489.615726899118, 4178.937315940263, 4233.788310584474, 4236.449261595988, 4239.491261048678, 4247.5964783345535, 4148.439960605325, 4221.7889105544755, 4236.766977816219, 4254.0, 4295.484541854982, 4103.8563650272245, 4126.958730412703, 4161.895952601194, 4175.791210439465, 4234.9364759528635, 4112.177564487115, 4135.73117747347, 4152.854650087233, 4180.644645205146, 4219.746815191098, 3523.612402635708, 3548.982255088734, 3569.7322700797545, 3608.0799396154075, 3617.385044542434, 5061.544460998528, 5173.586113110942, 5230.241614965808, 5280.683159010472, 5288.0745869472685, 4634.2585186370015, 4654.488006319302, 4658.720476771371, 4662.137504561633, 4717.150912835688, 5644.520215781664, 5658.490735833753, 5698.088305871041, 5741.081426971665, 5757.769689212469, 3856.730028897978, 3870.41943708446, 3873.32216862048, 3904.1996390740114, 3918.608139186087, 5783.797567085132, 5871.267975947106, 5937.0, 5969.164316995624, 5976.61152025117, 3933.9213215735526, 3935.330993731073, 3940.2907476654477, 3962.841486340514, 3964.266610677034, 4002.1795531915886, 4002.8999275017777, 4004.1190937993597, 4075.0, 4079.326911059642, 4606.447226332862, 4636.884077898012, 4641.373414589055, 4676.321933319649, 4712.811487540528, 5495.368032676213, 5639.6334238274385, 5663.065594176997, 5683.801066962719, 5770.278715160605, 1342.90599658023, 1365.9180449173082, 1367.699106196635, 1383.2876068824564, 1391.7077413743227, 856.5289090999925, 865.9956700216585, 879.2833840420037, 894.0612357025097, 900.1943260781695, 5342.465753424704, 5356.625036247503, 5377.462253774591, 5401.756920938567, 5433.864153396117, 5850.385709500526, 5862.325832529228, 5876.0, 5947.910781338283, 5950.761969521257, 5360.946390536044, 5372.91940620891, 5394.91907621386, 5434.91847622286, 5449.373322068013, 3147.0873446700202, 3177.8411079446396, 3200.823954682515, 3210.678932106771, 3266.738660907122, 6093.634381937098, 6138.693065346715, 6220.875582488325, 6231.376862313732, 6236.937630623726, 5828.970855145782, 6012.30858451275, 6065.969670151621, 6118.908216376758, 6163.044728067157, 6120.693965301806, 6157.568970172135, 6170.0, 6172.475339596095, 6226.097215903668, 5962.761489540369, 6008.369121242382, 6042.335343112166, 6049.243844519435, 6073.0, 5552.222688823649, 5785.103308987113, 5866.941330586639, 5919.141724450017, 5943.019401798655, 6121.908171377522, 6141.140240366263, 6151.72317245716, 6236.220472440945, 6236.968815155895, 3628.4760400632326, 3753.9061523462133, 3767.3030489359558, 3811.371123764548, 3841.654251117413, 5833.416658334133, 5913.142594323885, 5942.881142377042, 5973.402659733992, 6003.129546215861, 5705.828825135252, 5710.457506536873, 5728.283964504437, 5753.309602847685, 5821.679807610622, 5681.318241810844, 5724.313082430135, 5744.3681195067675, 5748.39641837601, 5808.6224395414165, 5462.672239665632, 5596.440355964533, 5598.300212473441, 5600.327960644749, 5700.25896633435, 5685.0, 5725.914111288417, 5732.111522713986, 5775.711214439345, 5843.474087332161, 5618.494335509824, 5630.549556035426, 5630.774769009194, 5734.655920644775, 5740.942590574041], "unit": "ms", "name": "prototype.html", "value": 4268.886649706136}, {"lowerIsBetter": false, "replicates": [628.8930881750102, 633.5185259203005, 658.7332130487155, 671.1141293492585, 672.6647604505057, 11476.426178691063, 11669.183157179, 11731.237469564483, 12078.456469458873, 12175.269483830976, 11309.604163854267, 11338.546458141664, 11451.770964580724, 11504.827427588592, 11537.711557211074, 603.9003564411867, 619.6003577692386, 740.9296116868902, 753.7625647920914, 780.6018930345537, 739.4269441183072, 750.2160242546524, 757.2654525110634, 758.2152472191283, 766.9875763991533, 797.1709422200933, 798.7843282313772, 804.4610111225493, 808.3412019204329, 809.4333966223637, 781.5662307419379, 787.4645241235958, 788.3574886467511, 788.9250521200477, 791.7426836278232, 588.5085953229059, 589.8436914217735, 590.7873165660359, 595.7259660556149, 596.269569777024, 11346.43267836613, 11461.942690286494, 11482.770344593146, 11525.250858694159, 11630.592929247521, 9521.714348569554, 9649.90350096497, 9983.550740216635, 10065.748356291151, 10310.43292618913, 7849.411294152961, 7852.882206766903, 7947.125816160218, 8018.639161237758, 8189.0, 2706.1260375221573, 2753.8072334936564, 2776.5141100307364, 2791.3440341519727, 2819.2810833237395, 41189.79405102955, 41571.1685766286, 41676.58323416757, 41870.790646046575, 43568.564314356765, 7674.616269186518, 7685.269899359552, 7964.442489025829, 8111.3916456266015, 8276.26198498322, 16197.190140493163, 16378.50864474044, 16546.751798723028, 16559.17204139788, 16565.834341656428, 5901.940980590139, 5902.173695682608, 5917.55618328627, 6109.969450152809, 6121.47967422774, 3077.7999430036975, 3124.0940127363265, 3160.3205310858275, 3189.2983543620367, 3208.4545627243424, 2546.719860815309, 2558.8976440942524, 2567.435164263859, 2597.909073182467, 2606.609008648718, 343.8069897455824, 349.86705052080555, 355.5111721383098, 359.6044351213644, 360.423322683704, 418.70690516638473, 442.17313623524217, 448.5895405703744, 498.5737194698553, 534.8101423994503, 6624.8012559623285, 7041.5422997505, 7051.682674279669, 7286.307800758919, 7488.9625551871895, 420.6277444461612, 426.8506022892025, 463.97216167030086, 527.1328664347127, 536.7516109989467, 3011.1869795155185, 3303.900882973515, 3307.107081088141, 3381.3575420669995, 3382.8815991440183, 50532.0, 51198.74400627973, 51826.48173518292, 52094.73952630288, 52349.2147617786, 43858.0, 44434.0, 44451.777741111735, 45408.3188752169, 45503.317450238275, 40289.0, 40574.39138412926, 40799.388009179886, 41148.38277425841, 41239.587604123575, 6624.238212605419, 6676.365745254193, 6686.431653309523, 6708.698108585223, 6751.93248067513, 29374.853125734233, 29613.85193074021, 29743.25641858971, 30541.0, 30560.235994100327, 37312.81343593264, 37861.81069094637, 40025.399619005155, 40500.0, 40571.0, 6044.184035155197, 6050.757969681164, 6056.3035250946705, 6189.907151392823, 6387.233531976192, 8811.33914956368, 8923.643054277756, 9180.908190918006, 9209.907900920905, 10522.053015228666, 9125.543722813965, 9306.581203845708, 9359.204467620328, 9807.06832850878, 9881.50592470388, 8898.73303800887, 8925.018247992846, 8983.609834099489, 9140.817183656423, 9698.224142068759, 8776.429532080394, 9227.86158207614, 9319.767005824908, 9415.858762118436, 9463.952680236554, 7682.270184332479, 7751.379889608705, 8194.34445244391, 8204.0, 8616.439931404439, 7033.226345101933, 7170.354668079898, 7466.0, 7675.961620191863, 7897.24976127267], "unit": "ms", "name": "yui.html", "value": 5157.775108442363}], "name": "dromaeo_css", "value": 5533.870731999821}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [130.0, 131.0, 137.0, 136.0, 138.0, 150.0, 145.0, 142.0, 137.0, 138.0], "unit": "ms", "name": "ai-astar", "value": 138.4}, {"lowerIsBetter": true, "replicates": [181.0, 169.0, 192.0, 205.0, 163.0, 178.0, 177.0, 164.0, 201.0, 165.0], "unit": "ms", "name": "audio-beat-detection", "value": 179.5}, {"lowerIsBetter": true, "replicates": [199.0, 215.0, 209.0, 206.0, 202.0, 201.0, 202.0, 201.0, 204.0, 199.0], "unit": "ms", "name": "audio-dft", "value": 203.8}, {"lowerIsBetter": true, "replicates": [79.0, 88.0, 97.0, 147.0, 86.0, 86.0, 91.0, 90.0, 123.0, 83.0], "unit": "ms", "name": "audio-fft", "value": 97.0}, {"lowerIsBetter": true, "replicates": [102.0, 108.0, 152.0, 109.0, 114.0, 113.0, 146.0, 108.0, 109.0, 152.0], "unit": "ms", "name": "audio-oscillator", "value": 121.3}, {"lowerIsBetter": true, "replicates": [150.0, 142.0, 142.0, 157.0, 154.0, 149.0, 148.0, 150.0, 150.0, 143.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 148.5}, {"lowerIsBetter": true, "replicates": [157.0, 165.0, 161.0, 156.0, 157.0, 156.0, 156.0, 156.0, 164.0, 161.0], "unit": "ms", "name": "imaging-darkroom", "value": 158.9}, {"lowerIsBetter": true, "replicates": [118.0, 134.0, 123.0, 137.0, 124.0, 126.0, 123.0, 117.0, 123.0, 134.0], "unit": "ms", "name": "imaging-desaturate", "value": 125.9}, {"lowerIsBetter": true, "replicates": [67.0, 73.0, 75.0, 78.0, 80.0, 78.0, 79.0, 86.0, 77.0, 78.0], "unit": "ms", "name": "json-parse-financial", "value": 77.1}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 87.0, 86.0, 88.0, 88.0, 89.0, 89.0, 92.0, 94.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 87.5}, {"lowerIsBetter": true, "replicates": [102.0, 105.0, 111.0, 113.0, 111.0, 112.0, 107.0, 106.0, 110.0, 109.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 108.6}, {"lowerIsBetter": true, "replicates": [162.0, 173.0, 160.0, 173.0, 162.0, 171.0, 166.0, 160.0, 155.0, 163.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 164.5}, {"lowerIsBetter": true, "replicates": [183.0, 191.0, 193.0, 194.0, 191.0, 178.0, 191.0, 193.0, 191.0, 179.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 188.4}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 90.0, 91.0, 88.0, 92.0, 94.0, 93.0, 92.0, 88.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 89.4}], "name": "kraken", "value": 1888.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [196.61816751867872], "unit": "score", "name": "Richards", "value": 179.54597199999998}, {"lowerIsBetter": false, "replicates": [234.46658851113716], "unit": "score", "name": "DeltaBlue", "value": 281.99327000000005}, {"lowerIsBetter": false, "replicates": [379.5066413662239], "unit": "score", "name": "Encrypt", "value": 701.3869350000001}, {"lowerIsBetter": false, "replicates": [7485.074626865671], "unit": "score", "name": "Decrypt", "value": 35.56156929212365}, {"lowerIsBetter": false, "replicates": [1378.7878787878788], "unit": "score", "name": "RayTrace", "value": 536.6953186813186}, {"lowerIsBetter": false, "replicates": [1068.3030949839915], "unit": "score", "name": "Earley", "value": 623.851979020979}, {"lowerIsBetter": false, "replicates": [15890.625], "unit": "score", "name": "Boyer", "value": 41.94064110127831}, {"lowerIsBetter": false, "replicates": [34517.24137931035], "unit": "score", "name": "RegExp", "value": 26.392172827172836}, {"lowerIsBetter": false, "replicates": [796.8253968253969], "unit": "score", "name": "Splay", "value": 102.26958167330682}, {"lowerIsBetter": false, "replicates": [6802.721088435374], "unit": "score", "name": "NavierStokes", "value": 218.1480000000001}], "name": "v8_7", "value": 16004.540970007125}]} 07:55:36 INFO - RETURN: dromaeo_css: 5533.87 07:55:36 INFO - RETURN: kraken: 1888.80 07:55:36 INFO - RETURN: v8_7: 16004.54 07:55:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "16004.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1888.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5533.87"}}} 07:55:36 INFO - Return code: 0 07:55:36 INFO - # TBPL SUCCESS # 07:55:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:36 INFO - 2015-11-18 07:55:36.772 screenresolution[1665:10667] starting screenresolution argv=screenresolution get 07:55:36 INFO - 2015-11-18 07:55:36.775 screenresolution[1665:10667] Display 0: 1600x1200x32@60 07:55:36 INFO - 2015-11-18 07:55:36.781 screenresolution[1666:10670] starting screenresolution argv=screenresolution list 07:55:36 INFO - Available Modes on Display 0 07:55:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:37 INFO - Intel HD Graphics 3000: 07:55:37 INFO - Chipset Model: Intel HD Graphics 3000 07:55:37 INFO - Type: GPU 07:55:37 INFO - Bus: Built-In 07:55:37 INFO - VRAM (Total): 512 MB 07:55:37 INFO - VRAM (Dynamic, Max): 10 07:55:37 INFO - Vendor: Intel (0x8086) 07:55:37 INFO - Device ID: 0x0116 07:55:37 INFO - Revision ID: 0x0009 07:55:37 INFO - Displays: 07:55:37 INFO - Display: 07:55:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:37 INFO - Display Serial Number: 1600x1200 60 07:55:37 INFO - Main Display: Yes 07:55:37 INFO - Mirror: Off 07:55:37 INFO - Online: Yes 07:55:37 INFO - Rotation: Supported 07:55:37 INFO - Return code: 0 07:55:37 INFO - Running post-action listener: _resource_record_post_action 07:55:37 INFO - Running post-run listener: _resource_record_post_run 07:55:38 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 39785472; Write bytes: 693218304; Read time: 5794; Write time: 67705 07:55:38 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 343427584; Write bytes: 345307136; Read time: 37275; Write time: 9262 07:55:38 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 37725184; Write bytes: 346260480; Read time: 5408; Write time: 58401 07:55:38 INFO - Running post-run listener: _upload_blobber_files 07:55:38 INFO - Blob upload gear active. 07:55:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:55:38 INFO - Copying logs to upload dir... 07:55:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1336.889381 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 16 secs) (at 2015-11-18 07:55:38.220386) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:55:38.223748) ========= 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.rhe8LQnt06/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.3bJWa8BDaw/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010381 build_url: 'https://queue.taskcluster.net/v1/task/nmlDtIdTRlCTuTufa1PEQA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:55:38.250582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:55:38.250900) ========= 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.rhe8LQnt06/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.3bJWa8BDaw/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:55:38.300012) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:55:38.300326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:55:38.300673) ========= ========= Total master_lag: 0.53 =========