builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0043 starttime: 1447379796.89 results: success (0) buildid: 20151112165437 builduid: f094a62d15044e938fed5c9d8ccdd77e revision: 0c648a1efbe06b5ec866ba058d18256b80808b46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:36.889001) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:36.889436) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:36.889835) ========= 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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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.006109 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:36.965993) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:36.966335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:36.988707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:36.989075) ========= 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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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.017926 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.037393) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.042779) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.043203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.043490) ========= 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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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-12 17:56:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-12 17:56:37 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.206672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.269891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.270222) ========= 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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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.122115 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.406614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.406964) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c648a1efbe06b5ec866ba058d18256b80808b46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0c648a1efbe06b5ec866ba058d18256b80808b46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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-12 17:56:37,481 truncating revision to first 12 chars 2015-11-12 17:56:37,481 Setting DEBUG logging. 2015-11-12 17:56:37,481 attempt 1/10 2015-11-12 17:56:37,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c648a1efbe0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 17:56:37,777 unpacking tar archive at: fx-team-0c648a1efbe0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540718 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.966333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.966672) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.979315) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.979659) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 17:56:37.980096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2015-11-12 17:56:37.980409) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 17:56:38 INFO - MultiFileLogger online at 20151112 17:56:38 in /builds/slave/test 17:56:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:56:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:56:38 INFO - {'append_to_log': False, 17:56:38 INFO - 'base_work_dir': '/builds/slave/test', 17:56:38 INFO - 'blob_upload_branch': 'Fx-Team', 17:56:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:56:38 INFO - 'branch': 'Fx-Team', 17:56:38 INFO - 'buildbot_json_path': 'buildprops.json', 17:56:38 INFO - 'config_files': ('talos/mac_config.py',), 17:56:38 INFO - 'default_actions': ('clobber', 17:56:38 INFO - 'read-buildbot-config', 17:56:38 INFO - 'download-and-extract', 17:56:38 INFO - 'populate-webroot', 17:56:38 INFO - 'create-virtualenv', 17:56:38 INFO - 'install', 17:56:38 INFO - 'run-tests'), 17:56:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:56:38 INFO - 'download_minidump_stackwalk': True, 17:56:38 INFO - 'download_symbols': 'ondemand', 17:56:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:56:38 INFO - 'tooltool.py': '/tools/tooltool.py', 17:56:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:56:38 INFO - '/tools/misc-python/virtualenv.py')}, 17:56:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:56:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:56:38 INFO - 'installer_path': 'installer.exe', 17:56:38 INFO - 'log_level': 'info', 17:56:38 INFO - 'log_name': 'talos', 17:56:38 INFO - 'log_to_console': True, 17:56:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:56:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:56:38 INFO - 'opt_config_files': (), 17:56:38 INFO - 'pip_index': False, 17:56:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:56:38 INFO - 'cmd': ('bash', 17:56:38 INFO - '-c', 17:56:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:56:38 INFO - 'enabled': True, 17:56:38 INFO - 'halt_on_failure': False, 17:56:38 INFO - 'name': 'check_screen_resolution'},), 17:56:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:56:38 INFO - 'cmd': ('bash', 17:56:38 INFO - '-c', 17:56:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:56:38 INFO - 'enabled': True, 17:56:38 INFO - 'halt_on_failure': False, 17:56:38 INFO - 'name': 'check_screen_resolution'},), 17:56:38 INFO - 'run_cmd_checks_enabled': True, 17:56:38 INFO - 'sps_profile': False, 17:56:38 INFO - 'sps_profile_interval': 0, 17:56:38 INFO - 'suite': 'dromaeojs', 17:56:38 INFO - 'system_bits': '64', 17:56:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:56:38 INFO - 'title': 't-yosemite-r5-0043', 17:56:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:56:38 INFO - 'use_talos_json': True, 17:56:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:56:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:56:38 INFO - 'work_dir': 'build'} 17:56:38 INFO - ##### 17:56:38 INFO - ##### Running clobber step. 17:56:38 INFO - ##### 17:56:38 INFO - Running pre-action listener: _resource_record_pre_action 17:56:38 INFO - Running main action method: clobber 17:56:38 INFO - rmtree: /builds/slave/test/build 17:56:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:56:41 INFO - Running post-action listener: _resource_record_post_action 17:56:41 INFO - ##### 17:56:41 INFO - ##### Running read-buildbot-config step. 17:56:41 INFO - ##### 17:56:41 INFO - Running pre-action listener: _resource_record_pre_action 17:56:41 INFO - Running main action method: read_buildbot_config 17:56:41 INFO - Using buildbot properties: 17:56:41 INFO - { 17:56:41 INFO - "properties": { 17:56:41 INFO - "buildnumber": 1236, 17:56:41 INFO - "product": "firefox", 17:56:41 INFO - "script_repo_revision": "production", 17:56:41 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 17:56:41 INFO - "repository": "", 17:56:41 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 17:56:41 INFO - "buildid": "20151112165437", 17:56:41 INFO - "slavename": "t-yosemite-r5-0043", 17:56:41 INFO - "pgo_build": "False", 17:56:41 INFO - "basedir": "/builds/slave/test", 17:56:41 INFO - "project": "", 17:56:41 INFO - "platform": "yosemite", 17:56:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:56:41 INFO - "slavebuilddir": "test", 17:56:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:56:41 INFO - "branch": "fx-team", 17:56:41 INFO - "repo_path": "integration/fx-team", 17:56:41 INFO - "stage_platform": "macosx64", 17:56:41 INFO - "builduid": "f094a62d15044e938fed5c9d8ccdd77e", 17:56:41 INFO - "revision": "0c648a1efbe06b5ec866ba058d18256b80808b46" 17:56:41 INFO - }, 17:56:41 INFO - "sourcestamp": { 17:56:41 INFO - "repository": "", 17:56:41 INFO - "hasPatch": false, 17:56:41 INFO - "project": "", 17:56:41 INFO - "branch": "fx-team-macosx64-talos", 17:56:41 INFO - "changes": [ 17:56:41 INFO - { 17:56:41 INFO - "category": null, 17:56:41 INFO - "files": [ 17:56:41 INFO - { 17:56:41 INFO - "url": null, 17:56:41 INFO - "name": "https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 17:56:41 INFO - } 17:56:41 INFO - ], 17:56:41 INFO - "repository": "", 17:56:41 INFO - "rev": "0c648a1efbe06b5ec866ba058d18256b80808b46", 17:56:41 INFO - "who": "kwierso@gmail.com", 17:56:41 INFO - "when": 1447379288, 17:56:41 INFO - "number": 6655797, 17:56:41 INFO - "comments": "Merge b2ginbound to central, a=merge", 17:56:41 INFO - "project": "", 17:56:41 INFO - "at": "Thu 12 Nov 2015 17:48:08", 17:56:41 INFO - "branch": "fx-team-macosx64-talos", 17:56:41 INFO - "revlink": "", 17:56:41 INFO - "properties": [ 17:56:41 INFO - [ 17:56:41 INFO - "buildid", 17:56:41 INFO - "20151112165437", 17:56:41 INFO - "Change" 17:56:41 INFO - ], 17:56:41 INFO - [ 17:56:41 INFO - "builduid", 17:56:41 INFO - "f094a62d15044e938fed5c9d8ccdd77e", 17:56:41 INFO - "Change" 17:56:41 INFO - ], 17:56:41 INFO - [ 17:56:41 INFO - "pgo_build", 17:56:41 INFO - "False", 17:56:41 INFO - "Change" 17:56:41 INFO - ] 17:56:41 INFO - ], 17:56:41 INFO - "revision": "0c648a1efbe06b5ec866ba058d18256b80808b46" 17:56:41 INFO - } 17:56:41 INFO - ], 17:56:41 INFO - "revision": "0c648a1efbe06b5ec866ba058d18256b80808b46" 17:56:41 INFO - } 17:56:41 INFO - } 17:56:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 17:56:41 INFO - Running post-action listener: _resource_record_post_action 17:56:41 INFO - ##### 17:56:41 INFO - ##### Running download-and-extract step. 17:56:41 INFO - ##### 17:56:41 INFO - Running pre-action listener: _resource_record_pre_action 17:56:41 INFO - Running main action method: download_and_extract 17:56:41 INFO - mkdir: /builds/slave/test/build/tests 17:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:41 INFO - https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/test_packages.json 17:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/test_packages.json 17:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:56:42 INFO - Downloaded 1149 bytes. 17:56:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:56:42 INFO - Using the following test package requirements: 17:56:42 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:56:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:56:42 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 17:56:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:56:42 INFO - u'jsshell-mac.zip'], 17:56:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:56:42 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 17:56:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:56:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:56:42 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 17:56:42 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:56:42 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 17:56:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:56:42 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 17:56:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:56:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:56:42 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 17:56:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:56:42 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')]} 17:56:42 INFO - https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/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 17:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/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 17:56:43 INFO - Downloaded 17459575 bytes. 17:56:43 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 17:56:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:56:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:56:48 INFO - Return code: 0 17:56:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:48 INFO - https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/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 17:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/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 17:56:50 INFO - Downloaded 17459575 bytes. 17:56:50 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 17:56:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:56:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:56:55 INFO - Return code: 0 17:56: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')]} 17:56:55 INFO - https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/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 17:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/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 17:56:56 INFO - Downloaded 11131693 bytes. 17:56: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 17:56:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:56:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 17:56:56 INFO - Return code: 0 17:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:56 INFO - https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:56:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:56:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:56:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 17:56:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/p9nuBOU7Q-SwNQoMrhF49w/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 17:56:59 INFO - Downloaded 108709316 bytes. 17:56:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:56:59 INFO - mkdir: /builds/slave/test/properties 17:56:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:59 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:59 INFO - Contents: 17:56:59 INFO - build_url:https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:56:59 INFO - Running post-action listener: _resource_record_post_action 17:56:59 INFO - Running post-action listener: set_extra_try_arguments 17:56:59 INFO - ##### 17:56:59 INFO - ##### Running populate-webroot step. 17:56:59 INFO - ##### 17:56:59 INFO - Running pre-action listener: _resource_record_pre_action 17:56:59 INFO - Running main action method: populate_webroot 17:56:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:56:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:56:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:56:59 INFO - '../fennec_ids.txt'], 17:56:59 INFO - 'tests': ['tcheck2']}, 17:56:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:56:59 INFO - '--tppagecycles', 17:56:59 INFO - '7'], 17:56:59 INFO - 'tests': ['tsvgm']}}, 17:56:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:56:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:56:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:56:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:56:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'tests': ['damp', 'tps']}, 17:56:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['damp', 'tps']}, 17:56:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:56:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:59 INFO - 'other': {'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore']}, 17:56:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore']}, 17:56:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore']}, 17:56:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore']}, 17:56:59 INFO - 'other_l64': {'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore']}, 17:56:59 INFO - 'other_nol64': {'tests': ['a11yr', 17:56:59 INFO - 'ts_paint', 17:56:59 INFO - 'tpaint', 17:56:59 INFO - 'sessionrestore', 17:56:59 INFO - 'sessionrestore_no_auto_restore']}, 17:56:59 INFO - 'svgr': {'tests': ['tsvgx', 17:56:59 INFO - 'tsvgr_opacity', 17:56:59 INFO - 'tart', 17:56:59 INFO - 'tscrollx', 17:56:59 INFO - 'cart']}, 17:56:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['tsvgx', 17:56:59 INFO - 'tsvgr_opacity', 17:56:59 INFO - 'tart', 17:56:59 INFO - 'tscrollx', 17:56:59 INFO - 'cart']}, 17:56:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'tests': ['tp5o']}, 17:56:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--e10s'], 17:56:59 INFO - 'tests': ['tp5o']}, 17:56:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--xperf_path', 17:56:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:59 INFO - 'tests': ['tp5n']}, 17:56:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:56:59 INFO - 'talos_options': ['--e10s', 17:56:59 INFO - '--xperf_path', 17:56:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:59 INFO - 'tests': ['tp5n']}}, 17:56:59 INFO - 'talos.zip': {'path': '', 17:56:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:56:59 INFO - Running post-action listener: _resource_record_post_action 17:56:59 INFO - ##### 17:56:59 INFO - ##### Running create-virtualenv step. 17:56:59 INFO - ##### 17:56:59 INFO - Running pre-action listener: _resource_record_pre_action 17:56:59 INFO - Running main action method: create_virtualenv 17:56:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:59 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 17:56:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:56:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:59 INFO - Using real prefix '/tools/python27' 17:56:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:57:00 INFO - Installing distribute.............................................................................................................................................................................................done. 17:57:04 INFO - Installing pip.................done. 17:57:04 INFO - Return code: 0 17:57:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ae228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22b518a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f49f0>, '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 0x10c454db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e88c8>, '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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 17:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:57:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WLiaC2FvsY/Render', 17:57:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:04 INFO - 'HOME': '/Users/cltbld', 17:57:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:04 INFO - 'LOGNAME': 'cltbld', 17:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:04 INFO - 'MOZ_NO_REMOTE': '1', 17:57:04 INFO - 'NO_EM_RESTART': '1', 17:57:04 INFO - 'PAGER': '/bin/cat', 17:57:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:04 INFO - 'PWD': '/builds/slave/test', 17:57:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:04 INFO - 'SHELL': '/bin/bash', 17:57:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTrbHi5ddU/Listeners', 17:57:04 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 17:57:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:04 INFO - 'USER': 'cltbld', 17:57:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:04 INFO - 'XPC_FLAGS': '0x0', 17:57:04 INFO - 'XPC_SERVICE_NAME': '0', 17:57:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:04 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 17:57:04 INFO - Cleaning up... 17:57:04 INFO - Return code: 0 17:57:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ae228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22b518a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f49f0>, '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 0x10c454db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e88c8>, '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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 17:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:57:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WLiaC2FvsY/Render', 17:57:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:04 INFO - 'HOME': '/Users/cltbld', 17:57:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:04 INFO - 'LOGNAME': 'cltbld', 17:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:04 INFO - 'MOZ_NO_REMOTE': '1', 17:57:04 INFO - 'NO_EM_RESTART': '1', 17:57:04 INFO - 'PAGER': '/bin/cat', 17:57:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:04 INFO - 'PWD': '/builds/slave/test', 17:57:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:04 INFO - 'SHELL': '/bin/bash', 17:57:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTrbHi5ddU/Listeners', 17:57:04 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 17:57:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:04 INFO - 'USER': 'cltbld', 17:57:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:04 INFO - 'XPC_FLAGS': '0x0', 17:57:04 INFO - 'XPC_SERVICE_NAME': '0', 17:57:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:05 INFO - Downloading/unpacking psutil>=0.7.1 17:57:05 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 17:57:05 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 17:57:05 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 17:57:05 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 17:57:05 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 17:57:05 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 17:57:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:57:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:57:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:07 INFO - Installing collected packages: psutil 17:57:07 INFO - Running setup.py install for psutil 17:57:07 INFO - building 'psutil._psutil_osx' extension 17:57:07 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 17:57:09 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 17:57:09 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 17:57:09 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 17:57:10 INFO - building 'psutil._psutil_posix' extension 17:57:10 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 17:57:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:57:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:57:10 INFO - ^ 17:57:10 INFO - 1 warning generated. 17:57:10 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 17:57:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:10 INFO - Successfully installed psutil 17:57:10 INFO - Cleaning up... 17:57:10 INFO - Return code: 0 17:57:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:57:10 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')]} 17:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:10 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')]} 17:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:10 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 0x10c7d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ae228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22b518a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f49f0>, '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 0x10c454db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e88c8>, '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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 17:57:10 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 17:57:10 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 17:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WLiaC2FvsY/Render', 17:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:10 INFO - 'HOME': '/Users/cltbld', 17:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:10 INFO - 'LOGNAME': 'cltbld', 17:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:10 INFO - 'MOZ_NO_REMOTE': '1', 17:57:10 INFO - 'NO_EM_RESTART': '1', 17:57:10 INFO - 'PAGER': '/bin/cat', 17:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:10 INFO - 'PWD': '/builds/slave/test', 17:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:10 INFO - 'SHELL': '/bin/bash', 17:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTrbHi5ddU/Listeners', 17:57:10 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 17:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:10 INFO - 'USER': 'cltbld', 17:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:10 INFO - 'XPC_FLAGS': '0x0', 17:57:10 INFO - 'XPC_SERVICE_NAME': '0', 17:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:57:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:57:13 INFO - Installing collected packages: mozsystemmonitor 17:57:13 INFO - Running setup.py install for mozsystemmonitor 17:57:13 INFO - Successfully installed mozsystemmonitor 17:57:13 INFO - Cleaning up... 17:57:13 INFO - Return code: 0 17:57:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:57:13 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')]} 17:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:13 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')]} 17:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:13 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 0x10c7d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ae228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22b518a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f49f0>, '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 0x10c454db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e88c8>, '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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 17:57:13 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 17:57:13 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 17:57:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WLiaC2FvsY/Render', 17:57:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:13 INFO - 'HOME': '/Users/cltbld', 17:57:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:13 INFO - 'LOGNAME': 'cltbld', 17:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:13 INFO - 'MOZ_NO_REMOTE': '1', 17:57:13 INFO - 'NO_EM_RESTART': '1', 17:57:13 INFO - 'PAGER': '/bin/cat', 17:57:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:13 INFO - 'PWD': '/builds/slave/test', 17:57:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:13 INFO - 'SHELL': '/bin/bash', 17:57:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTrbHi5ddU/Listeners', 17:57:13 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 17:57:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:13 INFO - 'USER': 'cltbld', 17:57:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:13 INFO - 'XPC_FLAGS': '0x0', 17:57:13 INFO - 'XPC_SERVICE_NAME': '0', 17:57:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:13 INFO - Downloading/unpacking blobuploader==1.2.4 17:57:13 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 17:57:13 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 17:57:13 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 17:57:13 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 17:57:13 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 17:57:13 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 17:57:15 INFO - Downloading blobuploader-1.2.4.tar.gz 17:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:57:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:57: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 17:57: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 17:57: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 17:57: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 17:57: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 17:57: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 17:57:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:57:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:57:16 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 17:57:16 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 17:57:16 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 17:57:16 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 17:57:16 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 17:57:16 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 17:57:17 INFO - Downloading docopt-0.6.1.tar.gz 17:57:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:57:17 INFO - Installing collected packages: blobuploader, requests, docopt 17:57:17 INFO - Running setup.py install for blobuploader 17:57:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:57:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:57:17 INFO - Running setup.py install for requests 17:57:17 INFO - Running setup.py install for docopt 17:57:17 INFO - Successfully installed blobuploader requests docopt 17:57:17 INFO - Cleaning up... 17:57:18 INFO - Return code: 0 17:57:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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')]} 17:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:18 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 0x10c7d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ae228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22b518a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f49f0>, '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 0x10c454db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e88c8>, '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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 17:57:18 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 17:57:18 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 17:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WLiaC2FvsY/Render', 17:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:18 INFO - 'HOME': '/Users/cltbld', 17:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:18 INFO - 'LOGNAME': 'cltbld', 17:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:18 INFO - 'MOZ_NO_REMOTE': '1', 17:57:18 INFO - 'NO_EM_RESTART': '1', 17:57:18 INFO - 'PAGER': '/bin/cat', 17:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:18 INFO - 'PWD': '/builds/slave/test', 17:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:18 INFO - 'SHELL': '/bin/bash', 17:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTrbHi5ddU/Listeners', 17:57:18 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 17:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:18 INFO - 'USER': 'cltbld', 17:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:18 INFO - 'XPC_FLAGS': '0x0', 17:57:18 INFO - 'XPC_SERVICE_NAME': '0', 17:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:18 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-4K8e9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:18 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-RVsCga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:18 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-jZFy0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:18 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-IaI2gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:18 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-2U6hl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:18 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-Y2sP1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-akvV0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-duYvr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-OIUMy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-sPIZMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-uC8W_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-HfMHxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-wESG85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-HjgIGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:19 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-cVvEcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:20 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-x5GAkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:20 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-r_2a0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:57:20 INFO - Running setup.py install for manifestparser 17:57:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Running setup.py install for mozcrash 17:57:20 INFO - Running setup.py install for mozdebug 17:57:20 INFO - Running setup.py install for mozdevice 17:57:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:57:20 INFO - Running setup.py install for mozfile 17:57:21 INFO - Running setup.py install for mozhttpd 17:57:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Running setup.py install for mozinfo 17:57:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Running setup.py install for mozInstall 17:57:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Running setup.py install for mozleak 17:57:21 INFO - Running setup.py install for mozlog 17:57:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:57:21 INFO - Running setup.py install for moznetwork 17:57:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:57:22 INFO - Running setup.py install for mozprocess 17:57:22 INFO - Running setup.py install for mozprofile 17:57:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:57:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:57:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:57:22 INFO - Running setup.py install for mozrunner 17:57:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:57:22 INFO - Running setup.py install for mozscreenshot 17:57:22 INFO - Running setup.py install for moztest 17:57:22 INFO - Running setup.py install for mozversion 17:57:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:57:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:57:23 INFO - Cleaning up... 17:57:23 INFO - Return code: 0 17:57:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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')]} 17:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:23 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 0x10c7d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ae228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22b518a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f49f0>, '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 0x10c454db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e88c8>, '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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 17:57:23 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 17:57:23 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 17:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WLiaC2FvsY/Render', 17:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:23 INFO - 'HOME': '/Users/cltbld', 17:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:23 INFO - 'LOGNAME': 'cltbld', 17:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:23 INFO - 'MOZ_NO_REMOTE': '1', 17:57:23 INFO - 'NO_EM_RESTART': '1', 17:57:23 INFO - 'PAGER': '/bin/cat', 17:57:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:23 INFO - 'PWD': '/builds/slave/test', 17:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:23 INFO - 'SHELL': '/bin/bash', 17:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTrbHi5ddU/Listeners', 17:57:23 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 17:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:23 INFO - 'USER': 'cltbld', 17:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:23 INFO - 'XPC_FLAGS': '0x0', 17:57:23 INFO - 'XPC_SERVICE_NAME': '0', 17:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:23 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-l2tGCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:23 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)) 17:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:23 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-cmEGsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:23 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)) 17:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:23 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-7Lnef7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:23 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)) 17:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:23 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-GKuWGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:23 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)) 17:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:23 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-UxWB00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:23 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)) 17:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:23 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-p7inYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:24 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)) 17:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:24 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-dG1ipm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:24 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)) 17:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:24 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-EWTSaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:24 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)) 17:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:24 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-5B36iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:24 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)) 17:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:24 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-C32qZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:24 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)) 17:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:24 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-s9iFSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:24 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)) 17:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:24 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-7iok_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:24 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)) 17:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:24 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-cWiISx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:24 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)) 17:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:24 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-yDSMHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:25 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-4GLjy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:25 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-JuayAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:25 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)) 17:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:25 INFO - Running setup.py (path:/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/pip-xqqWDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 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)) 17:57:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:57:25 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 17:57:25 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 17:57:25 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 17:57:25 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 17:57:25 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 17:57:25 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 17:57:27 INFO - Downloading blessings-1.5.1.tar.gz 17:57:27 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 17:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:57:27 INFO - Installing collected packages: blessings 17:57:27 INFO - Running setup.py install for blessings 17:57:27 INFO - Successfully installed blessings 17:57:27 INFO - Cleaning up... 17:57:28 INFO - Return code: 0 17:57:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:28 INFO - Reading from file tmpfile_stdout 17:57:28 INFO - Current package versions: 17:57:28 INFO - blessings == 1.5.1 17:57:28 INFO - blobuploader == 1.2.4 17:57:28 INFO - docopt == 0.6.1 17:57:28 INFO - manifestparser == 1.1 17:57:28 INFO - mozInstall == 1.12 17:57:28 INFO - mozcrash == 0.16 17:57:28 INFO - mozdebug == 0.1 17:57:28 INFO - mozdevice == 0.47 17:57:28 INFO - mozfile == 1.2 17:57:28 INFO - mozhttpd == 0.7 17:57:28 INFO - mozinfo == 0.9 17:57:28 INFO - mozleak == 0.1 17:57:28 INFO - mozlog == 3.0 17:57:28 INFO - moznetwork == 0.27 17:57:28 INFO - mozprocess == 0.22 17:57:28 INFO - mozprofile == 0.27 17:57:28 INFO - mozrunner == 6.11 17:57:28 INFO - mozscreenshot == 0.1 17:57:28 INFO - mozsystemmonitor == 0.0 17:57:28 INFO - moztest == 0.7 17:57:28 INFO - mozversion == 1.4 17:57:28 INFO - psutil == 3.1.1 17:57:28 INFO - requests == 1.2.3 17:57:28 INFO - wsgiref == 0.1.2 17:57:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57: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')]} 17:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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')]} 17:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:28 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 0x10c7d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ae228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22b518a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f49f0>, '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 0x10c454db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e88c8>, '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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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 17:57:28 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 17:57:28 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 17:57:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WLiaC2FvsY/Render', 17:57:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:28 INFO - 'HOME': '/Users/cltbld', 17:57:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:28 INFO - 'LOGNAME': 'cltbld', 17:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:28 INFO - 'MOZ_NO_REMOTE': '1', 17:57:28 INFO - 'NO_EM_RESTART': '1', 17:57:28 INFO - 'PAGER': '/bin/cat', 17:57:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:28 INFO - 'PWD': '/builds/slave/test', 17:57:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:28 INFO - 'SHELL': '/bin/bash', 17:57:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTrbHi5ddU/Listeners', 17:57:28 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 17:57:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:28 INFO - 'USER': 'cltbld', 17:57:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:28 INFO - 'XPC_FLAGS': '0x0', 17:57:28 INFO - 'XPC_SERVICE_NAME': '0', 17:57:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 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)) 17:57:28 INFO - Cleaning up... 17:57:28 INFO - Return code: 0 17:57:28 INFO - Running post-action listener: _resource_record_post_action 17:57:28 INFO - Running post-action listener: _start_resource_monitoring 17:57:28 INFO - Starting resource monitoring. 17:57:28 INFO - ##### 17:57:28 INFO - ##### Running install step. 17:57:28 INFO - ##### 17:57:28 INFO - Running pre-action listener: _resource_record_pre_action 17:57:28 INFO - Running main action method: install 17:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:28 INFO - Reading from file tmpfile_stdout 17:57:28 INFO - Detecting whether we're running mozinstall >=1.0... 17:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:57:29 INFO - Reading from file tmpfile_stdout 17:57:29 INFO - Output received: 17:57:29 INFO - Usage: mozinstall [options] installer 17:57:29 INFO - Options: 17:57:29 INFO - -h, --help show this help message and exit 17:57:29 INFO - -d DEST, --destination=DEST 17:57:29 INFO - Directory to install application into. [default: 17:57:29 INFO - "/builds/slave/test"] 17:57:29 INFO - --app=APP Application being installed. [default: firefox] 17:57:29 INFO - mkdir: /builds/slave/test/build/application 17:57:29 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'] 17:57:29 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 17:58:04 INFO - Reading from file tmpfile_stdout 17:58:04 INFO - Output received: 17:58:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:58:04 INFO - Running post-action listener: _resource_record_post_action 17:58:04 INFO - ##### 17:58:04 INFO - ##### Running run-tests step. 17:58:04 INFO - ##### 17:58:04 INFO - Running pre-action listener: _resource_record_pre_action 17:58:04 INFO - Running main action method: run_tests 17:58:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:58:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:58:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:58:04 INFO - 2015-11-12 17:58:04.930 screenresolution[1632:7584] starting screenresolution argv=screenresolution get 17:58:04 INFO - 2015-11-12 17:58:04.933 screenresolution[1632:7584] Display 0: 1600x1200x32@60 17:58:04 INFO - 2015-11-12 17:58:04.939 screenresolution[1633:7586] starting screenresolution argv=screenresolution list 17:58:04 INFO - Available Modes on Display 0 17:58:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:58:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:58:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:58:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:58:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:58:05 INFO - Intel HD Graphics 3000: 17:58:05 INFO - Chipset Model: Intel HD Graphics 3000 17:58:05 INFO - Type: GPU 17:58:05 INFO - Bus: Built-In 17:58:05 INFO - VRAM (Total): 512 MB 17:58:05 INFO - VRAM (Dynamic, Max): 10 17:58:05 INFO - Vendor: Intel (0x8086) 17:58:05 INFO - Device ID: 0x0116 17:58:05 INFO - Revision ID: 0x0009 17:58:05 INFO - Displays: 17:58:05 INFO - Display: 17:58:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:58:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:58:05 INFO - Display Serial Number: 1600x1200 60 17:58:05 INFO - Main Display: Yes 17:58:05 INFO - Mirror: Off 17:58:05 INFO - Online: Yes 17:58:05 INFO - Rotation: Supported 17:58:05 INFO - Return code: 0 17:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:58:05 INFO - Python 2.7.3 17:58:05 INFO - Return code: 0 17:58:05 INFO - grabbing minidump binary from tooltool 17:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:58:05 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 0x10c6f49f0>, '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 0x10c454db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e88c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:58:05 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 17:58:05 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 17:58:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:58:05 INFO - Return code: 0 17:58:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:58:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:58:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:58:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:58:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0043', '--webServer', 'localhost'] in /builds/slave/test/build 17:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0043 --webServer localhost 17:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WLiaC2FvsY/Render', 17:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:05 INFO - 'HOME': '/Users/cltbld', 17:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:05 INFO - 'LOGNAME': 'cltbld', 17:58:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:58:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:05 INFO - 'MOZ_NO_REMOTE': '1', 17:58:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:58:05 INFO - 'NO_EM_RESTART': '1', 17:58:05 INFO - 'PAGER': '/bin/cat', 17:58:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:05 INFO - 'PWD': '/builds/slave/test', 17:58:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:05 INFO - 'SHELL': '/bin/bash', 17:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTrbHi5ddU/Listeners', 17:58:05 INFO - 'TMPDIR': '/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/', 17:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:05 INFO - 'USER': 'cltbld', 17:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:05 INFO - 'XPC_FLAGS': '0x0', 17:58:05 INFO - 'XPC_SERVICE_NAME': '0', 17:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:58:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0043', '--webServer', 'localhost'] with output_timeout 3600 17:58:05 INFO - mozversion INFO | application_buildid: 20151112165437 17:58:05 INFO - mozversion INFO | application_changeset: 0c648a1efbe06b5ec866ba058d18256b80808b46 17:58:05 INFO - mozversion INFO | application_display_name: Nightly 17:58:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:58:05 INFO - mozversion INFO | application_name: Firefox 17:58:05 INFO - mozversion INFO | application_remotingname: firefox 17:58:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:58:05 INFO - mozversion INFO | application_vendor: Mozilla 17:58:05 INFO - mozversion INFO | application_version: 45.0a1 17:58:05 INFO - mozversion INFO | platform_buildid: 20151112165437 17:58:05 INFO - mozversion INFO | platform_changeset: 0c648a1efbe06b5ec866ba058d18256b80808b46 17:58:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:58:05 INFO - mozversion INFO | platform_version: 45.0a1 17:58:05 INFO - 2015-11-12 17:58:05,604 DEBUG : using testdate: 1447379885 17:58:05 INFO - 2015-11-12 17:58:05,604 DEBUG : actual date: 1447379885 17:58:05 INFO - 2015-11-12 17:58:05,627 INFO : starting webserver on 'localhost:49268' 17:58:05 INFO - 2015-11-12 17:58:05,628 INFO : Starting test suite t-yosemite-r5-0043 17:58:05 INFO - 2015-11-12 17:58:05,628 INFO : Starting test dromaeo_css 17:58:05 INFO - 2015-11-12 17:58:05,628 DEBUG : operating with platform_type : mac_ 17:58:05 INFO - 2015-11-12 17:58:05,629 INFO : Initialising browser for dromaeo_css test... 17:58:05 INFO - 2015-11-12 17:58:05,656 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmpCmsn7X/profile http://localhost:49268/getInfo.html 17:58:08 INFO - 2015-11-12 17:58:08,902 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:58:08 INFO - 2015-11-12 17:58:08,902 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:58:08 INFO - 2015-11-12 17:58:08,902 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:58:08 INFO - 2015-11-12 17:58:08,902 DEBUG : BROWSER_OUTPUT: __metrics 17:58:08 INFO - 2015-11-12 17:58:08,917 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:58:09 INFO - 2015-11-12 17:58:09,607 INFO : Browser initialized. 17:58:09 INFO - 2015-11-12 17:58:09,608 INFO : Running cycle 1/1 for dromaeo_css test... 17:58:09 INFO - 2015-11-12 17:58:09,608 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmpCmsn7X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:58:21 INFO - 2015-11-12 17:58:21,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 229748736 17:58:21 INFO - 2015-11-12 17:58:21,559 DEBUG : BROWSER_OUTPUT: 17:59:13 INFO - 2015-11-12 17:59:13,332 DEBUG : BROWSER_OUTPUT: 1447379953332 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] 18:01:23 INFO - 2015-11-12 18:01:23,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 18:01:24 INFO - 2015-11-12 18:01:24,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 367693824 18:01:24 INFO - 2015-11-12 18:01:24,557 DEBUG : BROWSER_OUTPUT: 18:04:27 INFO - 2015-11-12 18:04:27,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 18:04:27 INFO - 2015-11-12 18:04:27,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 364437504 18:04:27 INFO - 2015-11-12 18:04:27,873 DEBUG : BROWSER_OUTPUT: 18:07:30 INFO - 2015-11-12 18:07:30,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 18:07:30 INFO - 2015-11-12 18:07:30,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 327946240 18:07:30 INFO - 2015-11-12 18:07:30,747 DEBUG : BROWSER_OUTPUT: 18:10:32 INFO - 2015-11-12 18:10:32,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 18:10:33 INFO - 2015-11-12 18:10:33,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 321015808 18:10:33 INFO - 2015-11-12 18:10:33,338 DEBUG : BROWSER_OUTPUT: 18:13:36 INFO - 2015-11-12 18:13:36,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 18:13:36 INFO - 2015-11-12 18:13:36,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 322740224 18:13:36 INFO - 2015-11-12 18:13:36,915 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 18:16:39 INFO - 2015-11-12 18:16:39,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 366493696 18:16:39 INFO - 2015-11-12 18:16:39,901 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,901 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:16:39 INFO - 2015-11-12 18:16:39,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:16:39 INFO - 2015-11-12 18:16:39,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:16:39 INFO - 2015-11-12 18:16:39,901 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:16:39 INFO - 2015-11-12 18:16:39,901 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3135.3259049304397;3202.2954949911027;3213.309138535215;3238.0447767908463;3262.9510557341628;5138.974305128479;5216.347956505437;5320.308359913211;5333.0933741264025;5345.545628621567;5223.686578805275;5265.236540701606;5267.39424966129;5294.311739473863;5351.304330437048;4881.096997055538;4883.023395320933;4898.06936682031;4913.434954980169;5032.0690672225755;4946.431160416562;5034.874128146789;5088.465711100337;5095.363079615048;5154.896902061956;4748.548887855648;4778.665493415462;4825.879353016203;4847.272909063633;4955.331030310916;4773.427188737339;4879.560839524424;4889.1443997300685;4894.461609222983;4955.851324460272;4840.15297322967;4868.756562171912;4870.366852309213;4878.048780487807;4923.335349727777;5100.642954993152;5121.513456221653;5174.870628234325;5181.0674078665825;5215.426303106655;5473.261109750172;5503.3120859892515;5518.034343989826;5519.889602207973;5523.585731070186;5563.193336966157;5572.247746554204;5584.497395234448;5594.776208951637;5601.159826026129;5016.147254966628;5060.544550990355;5115.693058416507;5128.948710512885;5133.204353325241;5662.716864156776;5668.51817595509;5752;5774.624649397776;5786.1610066540115;5391.81128660495;5398.4871437213405;5408.59435542328;5433.157860531624;5437.809676661377;5291.153415453586;5388.110961691277;5450.809221677222;5457.836264912059;5580.748866301026;5352.545033672103;5405.891882162414;5440.483154100354;5454.7818087276855;5481.479259470344;5445.482679145475;5491.697956612425;5505.614606977473;5511.448855114537;5535.0313695104005;4088.1210539733506;4204.306289462204;4207.495100587949;4218.6414154797185;4267.146570685875;3909.9218015639526;3911.4328422378594;3963.6432721054666;3976.562578116405;4004.1791432756213;5164.173732202905;5199.376074871039;5201.609879259071;5209.739513024334;5210.505002024802;5409.810656626999;5527.723613819293;5542.528885044816;5544.168374743821;5564.582656300794;5164.535191832678;5179.067767801832;5188.0661480933795;5215.035218484517;5238.895222095613;4731.384919960383;4804.0872234275375;4806.014766972762;4920.4095508538485;4932.506749325111;5702.372738998707;5793.507551858139;5794.913076303775;5810.448007439287;5841.970790146022;5636.520895723909;5638.9436105638415;5659.094544872801;5693.174489698888;5747.770089196385;5457.69982650958;5586.441355864381;5601.271834661468;5817.418258174149;5825.737841797214;5447.972760136174;5491.066518691912;5509.3664228614225;5515.034868898007;5612.074007788832;5478.150886612581;5565.248691426606;5599.944000559943;5653.604247702786;5680.40355762639;5322.866928326823;5420.078586640359;5432.511074003359;5522.723863806874;5552.389237183826;5337.199420087018;5433.592480563894;5435.945640543702;5440.483154100354;5473.698946557977;5409.702466364388;5436.400288693692;5441.591880609049;5443.863903402446;5477.616566840283;5254.525422630317;5386.542143917811;5389.083855744611;5524.585656075891;5596.552275818006;5151.330327057459;5252.711100889488;5270.262163297218;5302.522772950453;5328.333958255218 18:16:39 INFO - 2015-11-12 18:16:39,903 DEBUG : BROWSER_OUTPUT: |1;ext.html;527.9994410591928;531.6145794299132;543.7770514089224;546.3580293155543;561.2058936604705;29507.852460737693;30695.539566906486;37314.25371492572;38349.80825095878;38439.423408648894;39775.20449591014;40090.79954600223;40281;40489;40715.796421017854;8064.677412903477;8797.82404351911;8826.558672066403;8860.24687901529;8878.778030549223;8106.432549721522;10872.238943273975;10991.61529346473;11026.779464410707;11103.777924441507;10726.356418614909;10894.727631809228;10898.073663738593;10909.127269818395;11018.834717479243;8182.386321025947;8332.791680207984;10060.396376217413;10123.139533139654;10829.945850270698;10525.21060920434;10645.627403040857;10695.144388448905;10699.465026748709;10716.249862509627;37398.813005935066;37686.81156594227;37731.62268377309;37760;37938.05154871123;2778.138776979143;2835.6530647942063;2849.1167738001286;2898.9130326090253;3357.529945807589;25978;26023.609645855326;26352.60471092935;26433.867830660725;26688.73311266882;2317.9884100579557;2338.777816107467;2345.0502546468706;2357.976420235793;2458.4468494588755;255563;256023;256616;257428;257467;47218.29172562414;47763;53910.99157109551;54634.45365546294;54667.72666136644;51487.742561287705;51828.22257666138;52010;52017.47982520126;52275.73862130741;15217.771733424008;15233.923830380778;15254.694906101815;15299.15854627984;15367.231638418034;11635.941820291013;11645.243059201124;11659.650210493699;11685.649430517098;11690.70773230659;17958.19188136537;18054.09729513519;18055.638887222183;18063.63872722538;18105.909470452563;7844.137144914055;8069.435139540175;8091.554964476893;8140.145284745135;8150.2664760171865;889.1020069729619;940.6190492850407;951.6098399656246;957.7509847439577;1095.0090168397612;26699.512760906;27162.418790604697;27392.58911116335;27578;27694.723052769616;1017.8422344536609;1048.0881632979356;1053.5364439646685;1060.5015642647943;1141.6746227325339;14109.576712698636;14177;14337.498187563386;14359.92820035893;14400.423983040771;313914;318844;319258;319718;319806;51792.741036294574;52108;52165.217521737206;52283.47716522862;52312;1343.8656134386483;1357.8777909988148;1365.904386692942;1376.0436496634943;1383.197745307719;26694.866525667247;27139.185824425298;27496.450070998868;27516.724832751417;27531.17406477809;40020.399694005195;40951.59048409478;50461.243081353074;50763.49236507588;51374.22938655998;253600;256691;259131;259776;260087;26372.8681356592;26720.19839404821;29090;29334.559981599865;29342.11973640794;38405.23189536138;39456.40815387714;39953.60046399499;40157;40530.594694052685;30730.846345769023;31885.840570796998;32206;32244.516332255505;32412.02763917086;31183.220419488785;32894.34211315808;33578.83210583931;33719.15702107467;34015.319693606485;31665.366692666477;32322.83838580792;32482.51276230811;32524;32848.34303313968;26536.191827892886;29425.264368390104;29451.551462979416;29826.254343641584;30365.240868978453;22533.43666408353;22826.46726580191;23019.88490057539;23063.308100757004;23174.42063948415 18:16:39 INFO - 2015-11-12 18:16:39,906 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.05514449253116;336.42639299993505;338.2473995360325;339.63658884993055;340.73252496790025;13711.108777929428;14117.294135293245;16672.749908751364;16728.581785455353;18699.71950420745;13717.382717777698;14736.336864841081;17038.744418833696;17159.82840171598;17423.477295681118;5308.0710875596715;5401.054815407308;5421.457854214586;5457.972710136443;5469.808556700516;3904.609539046101;5209.400918894319;5295.4704529547125;5351.464853514656;5414.945850541503;4038.6567141792984;5760.971195144019;5868.559858010645;5898.203742494773;5931.199288096116;5692.174634677948;5880.441358070976;5886.410669119336;5906.025505791561;5954.97022514889;5122.615803814729;5138.845834624967;5140.511651393112;5142.228665700175;5155.9742201288755;21129.095697805893;21200.469988250417;21472.24847130343;21530.784692153036;21606.351809445583;1923.5287354598213;2032.2229910052445;2067.1008111471556;2096.685497175436;2117.7246957895377;12892.935535322356;12939.158954667917;13098.738025239538;13380.264085475295;13387.129836560593;1643.9178041097898;1646.2756387189718;1647.365764180787;1670.6408122253774;1701.9659606807918;56815;58994;62674.68662656703;63218.0517292241;64203.357966420204;17070.317187312616;17104;17109;17370.3051877926;17461.7380739289;24770.133045343326;24876.12933547317;24954;25041.12356067529;25064.4987100257;9676.419414834992;9693.70918872435;9707.417554946725;9732.756681082888;9790.706278811647;7603.315701586884;7885.802854928558;7910.9604451977375;8216.671333146727;8249.29880960113;8091.919080809116;8131.105578386373;8153.714619988272;8182.7545173644885;8236.217559331853;2113.492761737172;3170.5402716605963;3242.0760083376126;3270.7710460268027;3306.9748378002896;433.0386541877028;446.03656102818405;455.15568620209694;463.81679236701314;466.74562363511967;11595.478203480863;11731.237469564621;11904.94047529774;11931.880681193077;11981.28112313264;398.68703068091406;444.782056792176;454.112210628221;457.40308896889877;469.7064334790756;5960.165576819249;6194.81415557534;6235.376462353728;6319.146915166394;6483.578567393104;535911;543191;543646;545728;556735;68926;69814.65092674505;70810.64594676993;71264.64367678128;72838.63580682168;482.7658585585988;495.4723219771004;496.1292930906308;498.11335822236475;499.16140883315654;10607.257491975797;10883.836742448711;11065.557377705123;11086.944565277123;11172.385518796544;30439.847800760854;32387.83806081049;32653;32689.673103268662;33248.66751332456;40420.79789601033;40628.18743625052;41140;41259.1748165041;41335;6101.176341194059;6123.969380153071;6206.565540412128;6211.9068213977735;6214.4407003369915;11040.558377664804;11315.943420282845;11444.313341199555;11481.655550333504;11824.994875435685;9945.104940555384;10063.647772327933;10177;10183.032611901857;10198.490075496344;9663.758406039906;9765.121139097515;9792.902070979198;9795.951020244853;9871.25965552572;8468.44955077918;9991.800163996824;10223.131033862204;10361.378317300987;10366.326188797704;5530.419305972815;5540.085885828793;5880.294364676266;5911.024680927599;6012.098185272244;9810.901890980998;9921.206303495848;10008.749781255527;10050.346727462691;10118.645847395306 18:16:39 INFO - 2015-11-12 18:16:39,906 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1522.2236659303765;1677.8489935905766;1763.6825371433144;1791.4177892185044;1793.2826869252297;6819.079424277721;7274.636268186589;7620.390368770499;7639.8854017189715;7661.19557446467;7421.5176013559085;7530.698772049125;7544.69821207151;7544.698212071525;7562.243775622435;2090.707300977864;2097.1192099318246;2103.453102193433;2104.7684754676975;2117.195465723031;2141.571685662866;2159.136345461812;2171.7176767020346;2178.9237376691817;2189.8029177374033;1996.7504061992252;2039.2862498125685;2053.0555944265657;2077.8441616878717;2081.105124796337;2079.3761871438583;2081.5316553775433;2084.27050532314;2085.593309304686;2088.7702352741185;2065.6882879371706;2124.383928660702;2128.6594144936735;2129.829613630906;2140.2723074154706;6665.300143484913;6918.308169183092;7431.888521672179;7482.1395539513105;7482.925170748277;4406.228909940747;4456.22016147173;4474.552544745532;4492.730436173807;4501.414816073922;2806;2890.8410037447934;2936.8531573421456;2942.867570959312;2958.9260268493244;863.1239292118505;889.488544087146;906.5731534798472;906.7959709065474;919.7700574856286;9936.403815771004;9972.052654997764;10012.449315287657;10037.548310326052;10156.39061656303;3991.4611527444004;4011.679065674739;4026.053877338823;4029.9194016119513;4060.4315395844606;8838.469691818511;8883.156100170474;8894.73315800527;8898.644054237888;9010.59452324647;4606.170889239969;4610.423697037871;4618;4643.3963584733765;4669.13620980113;4125.339945608688;4192.643625291885;4221.387898754663;4224.852130175429;4234.322508398642;3424.298018906118;3454.464557993515;3455;3501.299740052;3505.8071806050402;1089.4824958144977;1099;1099.312929419113;1105.9778804423865;1118.2507719827736;1049.6903413492885;1066.7919755647729;1069.6470164845582;1202.5911190195375;1335.5926442434957;6967.338102880219;7075.2217256101785;7114.039604653409;7120.430365570742;7199.640017999079;1020.7601213714771;1041.7812259425605;1110.616837191184;1112.8386383974278;1127.9492422840992;5356.625036247503;5652.85867853307;5685.260916080883;5717.971410143005;5733.827985160452;8254.298384637374;8945.642174313085;9054.909450905538;9095.681651142178;9115.407498512575;8590.269827064645;8855.867161992575;8915.73252802404;8920.553972301488;8930.910690893008;6935.445164386837;7084.256153103953;7095.645217739092;7132.1441427029085;7135.857282854314;7075.6815943281645;7118.679659415235;7176.7488137914925;7182.389496892613;7207.5675459472595;7518.097828260425;8057.274845263954;8081.15147909461;8139.918600813916;8172.42793004484;7924.326432253323;8154.918450815416;8164.632591533514;8296.419250652638;8301.501909885184;7227.313405226495;7326.450516211199;7350.558966462029;7424.740134095281;7425.440657461993;7298.927010729824;7373.3732632726815;7444.516106453063;7489.775306740807;7500.962495187708;6870.484713646397;6945.374916257561;6989.161300643956;7013.859722805413;7014.473914456335;6749.156355455568;6787.626680532618;6897.137857767779;6909.1018167637885;6916.619585922823;6968.163820341389;7006.824829379307;7012.824679383056;7015.403690686348;7090.680919358538;6279.340669229665;6306.558540902093;6337.524685648687;6341.048842673636;6369.01280301554;6096.817095487142;6310.652914089769;6325.778597749057;6349.984002559569;6354.52341074412 18:16:39 INFO - 2015-11-12 18:16:39,910 DEBUG : BROWSER_OUTPUT: |4;prototype.html;284.65840990811034;290.0500859684533;290.70638654958475;297.48832008944606;308.55567982105765;6134;6169.56813023088;6178.752849886005;6342.556021078526;6360.4911607071435;6206.596571222867;6214.161088253096;6217.409346112124;6229.906551401721;6263.0918516815145;4463.977680111595;4736.763161841903;4739.720275525606;4746.667733258673;4791.928121078186;4581.725096494204;4615.515370886059;4636.53634636537;4660.906781864361;4711.434627844664;4570.314452832085;4594.862154135381;4613.308003799423;4629.629629629639;4650.325702773112;4417.602415782563;4542.091581683677;4543.1140927519145;4599.885002874938;4669.136209801198;3867.1878905429894;3882.7282090253693;3885.320068987916;3885.9805700971597;3904.6876249900224;6009.218801555813;6063.302720187191;6089.147519347295;6112.144299798032;6120.693965301762;5115.462876397999;5127.5385215330425;5143.382794064699;5151.922721159186;5179.870503237412;6270.937290627081;6417.358264173592;6439.4848412127385;6524.478041756695;6528.053432252297;4240.766757828318;4266.338717498793;4270.444842170498;4298.61312481875;4317.417148684919;6735.93264067358;6846.7945961620735;6850.93149068508;6886.793396198122;6889.586624802528;4170.928009248947;4233.343831706091;4305.246581848227;4339.587739164775;4352.586504282088;4388.385626012361;4396.758178300224;4405.889852753707;4425.203463376559;4445.51099379068;5132.178851383761;5144.922826157611;5154.793808247703;5213.504717051874;5214.713190774544;6485.4487368573255;6492.740290388426;6506.739730410825;6512.674366281667;6527.5757075789925;1537.8000859888143;1552.8602425781507;1567.4905655661955;1570.9293081811345;1587.9047257164375;1002.4887307473241;1006.2955930848435;1027.409239687183;1030.9793804123876;1035.0736091198485;6184.196054512884;6204.565680402328;6229.0967809667345;6272.843178920472;6286;6690.297518760557;6718.932810671929;6762.729490820312;6777.593344399352;6784.2876497967;6202.72087756052;6230.750769969241;6246.063090536456;6256.311805701369;6268.27914789805;3574.91062723434;3598.5681718193982;3617.511635929116;3633.709303255733;3698.2973235085246;6964.825879353057;7030.859382812315;7056.823579410556;7059.399951004119;7145.606991615511;7003.824904377431;7010.92989070113;7081.681324340417;7086.362227399559;7089.503734738622;6855.143107111611;6994.230634630187;7062.929370706227;7082.079329687108;7091.6454177290925;6793.218779840184;6804.21751498584;6807.149106361705;6815.69329380189;6818.795436136924;6495.123158373559;6621.635810030494;6631.6684165792485;6697.263301036979;6698.631575263407;6917.446604271546;7045.189803172496;7048.154221493249;7128.073350464407;7156.9642151790995;4349.78251087438;4413.095315460387;4416.933745993877;4418.806922131071;4462.397576327284;6783.728650853911;6792.0830687856505;6858.657067146523;6867.656617169022;6867.690953906987;6365.363463653783;6525.477961762953;6531.673416329259;6550.017497375432;6619.702113404812;6546.639934803631;6570.244421891543;6594.967025164843;6617.7683781067435;6630.900536492053;6278.591891527036;6357.110004599267;6373.075903993988;6383.0744542042075;6440.32376600469;6489.935100648933;6523.24982627004;6535.771248006297;6554.63949482783;6635.8009259722285;6398.936010639834;6408;6442.09810626522;6455.289918109098;6465.3534646536855 18:16:39 INFO - 2015-11-12 18:16:39,911 DEBUG : BROWSER_OUTPUT: |5;yui.html;748.6780684305746;755.090116409726;761.1323091675491;774.4733581164808;777.7861088200744;13978.930105349471;14008.159510429381;14089.859101408983;14373.137611743303;14380.280985950687;12330.5067797288;13136.146150500212;13161.40773665185;13185.934070329658;13291.667708307297;693.1335830212234;874.7550685807984;883.6951251818112;893.0845882969975;893.6380765789866;707.9327463890947;825.1088824070019;875.129246399833;876.8071024374627;878.7056336127405;921.9953900230489;944.140831843023;944.8582712593131;945.7162851144664;949.9430034197935;721.07702141259;724.804302838236;912.270183852915;939.0327962198946;939.9436033837992;686.7115811359241;689.3657834792003;690.2890023276034;692.1521136607665;693.2512886083068;13611.183329000292;13860.514881979083;13865.09876858001;13896;13916.58250252494;11628.476718547601;11639.534418623245;11978.64064078079;12109;12336.568220112253;9168.174864262248;9224.953875230649;9379.484128373006;9508.952455237748;10026.89973100267;3334.733221342287;3343.36476069546;3347.0795531229105;3384.1032126486502;3397;47707.52292477065;47741.52258477406;47767.522324776655;47876;47919.76040119812;8997.370184087182;9043.231325337289;9146.085391460934;9161.862572061424;9708.029197080377;12087.395630218454;12201.45093470796;12213.267203967791;12213.328266945404;12232.266064036186;6054.926045753423;6072.878542429126;6134.693265336716;6183.598066125687;6211.9068213976825;3595.352836489457;3606.7294952878638;3644.890653280406;3668.5047518585184;3684.244729830378;2660.2817239345654;2703.7701795347616;2704.6619172603423;2705.932351691184;2710.756031957094;404.6661504258998;406.24438544307566;409.70091832962106;410.2779108768529;410.98356065757633;504.8409750928519;555.8999380111538;573.2833957553058;613.883362161188;639.044628280714;7830.960845195737;7879.960600196962;7927.960360198162;8054.154313797084;8061.959690201512;475.5577313098782;515.2142981952552;588.0649766870696;590.439082871274;622.6015350175891;3618.8371523281517;3981.9402708959387;4063.674906007512;4084.1423301106506;4122.958770412318;54897.725511372984;54998.45001550013;55023.72488137534;55032.724836375564;55188.72405638026;46546.767266164126;46865.76567117142;46898.76550617225;47174.292385614244;47182.292265616044;41038.38442423366;41622.791886040985;42330.15339693189;42692.57307426948;42749;8091.312238459797;8268.710595129141;8299.751007469786;8307.681596888837;8575.228229459379;34021.149471263416;34722.479162813084;34842;35242.64757352394;35303.470447943815;41990.37014444847;44651.88370290769;45037.32444013277;45298.32052519149;45362.77318613386;7523.924760752541;7670.156282808775;7724.304812566896;7769.611519424119;7809.297163255334;11141.665750027512;11292.604758833402;11439.428028598702;11569.421528923689;12116.939415302868;10359.378437293786;10495.842562361418;10839.132869370274;10949.069329107115;11330.093592512414;10427.478626068818;10526.631567895087;10730.302530335503;10809.837852432063;11341.092712583139;6993.335633114846;9900.356476828983;10349.689509314732;10806.243562950518;11215.66353009411;8173.713920012771;8772.473651580925;8886.351790722545;9458.668946586837;9486.635553669865;8317.168283171635;9083;9232.122948319899;9250.537473126182;9347.626094956398 18:16:39 INFO - 2015-11-12 18:16:39,911 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:16:39 INFO - 2015-11-12 18:16:39,911 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:16:39 INFO - 2015-11-12 18:16:39,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1100 18:16:39 INFO - 2015-11-12 18:16:39,912 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:16:39 INFO - 2015-11-12 18:16:39,912 DEBUG : BROWSER_OUTPUT: __startTimestamp1447380999897__endTimestamp 18:16:39 INFO - 2015-11-12 18:16:39,912 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,912 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:16:39 INFO - 2015-11-12 18:16:39,912 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:16:39 INFO - 2015-11-12 18:16:39,912 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,913 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5191.37 Median:5345.55 stddev:534.24 (10.0%) stddev-sans-first:510.95 18:16:39 INFO - 2015-11-12 18:16:39,913 DEBUG : BROWSER_OUTPUT: Values: 3135.3 3202.3 3213.3 3238.0 3263.0 5139.0 5216.3 5320.3 5333.1 5345.5 5223.7 5265.2 5267.4 5294.3 5351.3 4881.1 4883.0 4898.1 4913.4 5032.1 4946.4 5034.9 5088.5 5095.4 5154.9 4748.5 4778.7 4825.9 4847.3 4955.3 4773.4 4879.6 4889.1 4894.5 4955.9 4840.2 4868.8 4870.4 4878.0 4923.3 5100.6 5121.5 5174.9 5181.1 5215.4 5473.3 5503.3 5518.0 5519.9 5523.6 5563.2 5572.2 5584.5 5594.8 5601.2 5016.1 5060.5 5115.7 5128.9 5133.2 5662.7 5668.5 5752.0 5774.6 5786.2 5391.8 5398.5 5408.6 5433.2 5437.8 5291.2 5388.1 5450.8 5457.8 5580.7 5352.5 5405.9 5440.5 5454.8 5481.5 5445.5 5491.7 5505.6 5511.4 5535.0 4088.1 4204.3 4207.5 4218.6 4267.1 3909.9 3911.4 3963.6 3976.6 4004.2 5164.2 5199.4 5201.6 5209.7 5210.5 5409.8 5527.7 5542.5 5544.2 5564.6 5164.5 5179.1 5188.1 5215.0 5238.9 4731.4 4804.1 4806.0 4920.4 4932.5 5702.4 5793.5 5794.9 5810.4 5842.0 5636.5 5638.9 5659.1 5693.2 5747.8 5457.7 5586.4 5601.3 5817.4 5825.7 5448.0 5491.1 5509.4 5515.0 5612.1 5478.2 5565.2 5599.9 5653.6 5680.4 5322.9 5420.1 5432.5 5522.7 5552.4 5337.2 5433.6 5435.9 5440.5 5473.7 5409.7 5436.4 5441.6 5443.9 5477.6 5254.5 5386.5 5389.1 5524.6 5596.6 5151.3 5252.7 5270.3 5302.5 5328.3 18:16:39 INFO - 2015-11-12 18:16:39,913 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,914 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43691.37 Median:29212.28 stddev:72871.85 (249.5%) stddev-sans-first:73004.21 18:16:39 INFO - 2015-11-12 18:16:39,915 DEBUG : BROWSER_OUTPUT: Values: 528.0 531.6 543.8 546.4 561.2 29507.9 30695.5 37314.3 38349.8 38439.4 39775.2 40090.8 40281.0 40489.0 40715.8 8064.7 8797.8 8826.6 8860.2 8878.8 8106.4 10872.2 10991.6 11026.8 11103.8 10726.4 10894.7 10898.1 10909.1 11018.8 8182.4 8332.8 10060.4 10123.1 10829.9 10525.2 10645.6 10695.1 10699.5 10716.2 37398.8 37686.8 37731.6 37760.0 37938.1 2778.1 2835.7 2849.1 2898.9 3357.5 25978.0 26023.6 26352.6 26433.9 26688.7 2318.0 2338.8 2345.1 2358.0 2458.4 255563.0 256023.0 256616.0 257428.0 257467.0 47218.3 47763.0 53911.0 54634.5 54667.7 51487.7 51828.2 52010.0 52017.5 52275.7 15217.8 15233.9 15254.7 15299.2 15367.2 11635.9 11645.2 11659.7 11685.6 11690.7 17958.2 18054.1 18055.6 18063.6 18105.9 7844.1 8069.4 8091.6 8140.1 8150.3 889.1 940.6 951.6 957.8 1095.0 26699.5 27162.4 27392.6 27578.0 27694.7 1017.8 1048.1 1053.5 1060.5 1141.7 14109.6 14177.0 14337.5 14359.9 14400.4 313914.0 318844.0 319258.0 319718.0 319806.0 51792.7 52108.0 52165.2 52283.5 52312.0 1343.9 1357.9 1365.9 1376.0 1383.2 26694.9 27139.2 27496.5 27516.7 27531.2 40020.4 40951.6 50461.2 50763.5 51374.2 253600.0 256691.0 259131.0 259776.0 260087.0 26372.9 26720.2 29090.0 29334.6 29342.1 38405.2 39456.4 39953.6 40157.0 40530.6 30730.8 31885.8 32206.0 32244.5 32412.0 31183.2 32894.3 33578.8 33719.2 34015.3 31665.4 32322.8 32482.5 32524.0 32848.3 26536.2 29425.3 29451.6 29826.3 30365.2 22533.4 22826.5 23019.9 23063.3 23174.4 18:16:39 INFO - 2015-11-12 18:16:39,916 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,916 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28119.58 Median:450.07 stddev:88985.39 (19771.3%) stddev-sans-first:89210.56 18:16:39 INFO - 2015-11-12 18:16:39,916 DEBUG : BROWSER_OUTPUT: Values: 335.1 336.4 338.2 339.6 340.7 13711.1 14117.3 16672.7 16728.6 18699.7 13717.4 14736.3 17038.7 17159.8 17423.5 5308.1 5401.1 5421.5 5458.0 5469.8 3904.6 5209.4 5295.5 5351.5 5414.9 4038.7 5761.0 5868.6 5898.2 5931.2 5692.2 5880.4 5886.4 5906.0 5955.0 5122.6 5138.8 5140.5 5142.2 5156.0 21129.1 21200.5 21472.2 21530.8 21606.4 1923.5 2032.2 2067.1 2096.7 2117.7 12892.9 12939.2 13098.7 13380.3 13387.1 1643.9 1646.3 1647.4 1670.6 1702.0 56815.0 58994.0 62674.7 63218.1 64203.4 17070.3 17104.0 17109.0 17370.3 17461.7 24770.1 24876.1 24954.0 25041.1 25064.5 9676.4 9693.7 9707.4 9732.8 9790.7 7603.3 7885.8 7911.0 8216.7 8249.3 8091.9 8131.1 8153.7 8182.8 8236.2 2113.5 3170.5 3242.1 3270.8 3307.0 433.0 446.0 455.2 463.8 466.7 11595.5 11731.2 11904.9 11931.9 11981.3 398.7 444.8 454.1 457.4 469.7 5960.2 6194.8 6235.4 6319.1 6483.6 535911.0 543191.0 543646.0 545728.0 556735.0 68926.0 69814.7 70810.6 71264.6 72838.6 482.8 495.5 496.1 498.1 499.2 10607.3 10883.8 11065.6 11086.9 11172.4 30439.8 32387.8 32653.0 32689.7 33248.7 40420.8 40628.2 41140.0 41259.2 41335.0 6101.2 6124.0 6206.6 6211.9 6214.4 11040.6 11315.9 11444.3 11481.7 11825.0 9945.1 10063.6 10177.0 10183.0 10198.5 9663.8 9765.1 9792.9 9796.0 9871.3 8468.4 9991.8 10223.1 10361.4 10366.3 5530.4 5540.1 5880.3 5911.0 6012.1 9810.9 9921.2 10008.7 10050.3 10118.6 18:16:39 INFO - 2015-11-12 18:16:39,916 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,918 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5285.48 Median:6352.25 stddev:2733.99 (43.0%) stddev-sans-first:2727.03 18:16:39 INFO - 2015-11-12 18:16:39,918 DEBUG : BROWSER_OUTPUT: Values: 1522.2 1677.8 1763.7 1791.4 1793.3 6819.1 7274.6 7620.4 7639.9 7661.2 7421.5 7530.7 7544.7 7544.7 7562.2 2090.7 2097.1 2103.5 2104.8 2117.2 2141.6 2159.1 2171.7 2178.9 2189.8 1996.8 2039.3 2053.1 2077.8 2081.1 2079.4 2081.5 2084.3 2085.6 2088.8 2065.7 2124.4 2128.7 2129.8 2140.3 6665.3 6918.3 7431.9 7482.1 7482.9 4406.2 4456.2 4474.6 4492.7 4501.4 2806.0 2890.8 2936.9 2942.9 2958.9 863.1 889.5 906.6 906.8 919.8 9936.4 9972.1 10012.4 10037.5 10156.4 3991.5 4011.7 4026.1 4029.9 4060.4 8838.5 8883.2 8894.7 8898.6 9010.6 4606.2 4610.4 4618.0 4643.4 4669.1 4125.3 4192.6 4221.4 4224.9 4234.3 3424.3 3454.5 3455.0 3501.3 3505.8 1089.5 1099.0 1099.3 1106.0 1118.3 1049.7 1066.8 1069.6 1202.6 1335.6 6967.3 7075.2 7114.0 7120.4 7199.6 1020.8 1041.8 1110.6 1112.8 1127.9 5356.6 5652.9 5685.3 5718.0 5733.8 8254.3 8945.6 9054.9 9095.7 9115.4 8590.3 8855.9 8915.7 8920.6 8930.9 6935.4 7084.3 7095.6 7132.1 7135.9 7075.7 7118.7 7176.7 7182.4 7207.6 7518.1 8057.3 8081.2 8139.9 8172.4 7924.3 8154.9 8164.6 8296.4 8301.5 7227.3 7326.5 7350.6 7424.7 7425.4 7298.9 7373.4 7444.5 7489.8 7501.0 6870.5 6945.4 6989.2 7013.9 7014.5 6749.2 6787.6 6897.1 6909.1 6916.6 6968.2 7006.8 7012.8 7015.4 7090.7 6279.3 6306.6 6337.5 6341.0 6369.0 6096.8 6310.7 6325.8 6350.0 6354.5 18:16:39 INFO - 2015-11-12 18:16:39,918 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,918 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5418.06 Median:6230.33 stddev:1706.90 (27.4%) stddev-sans-first:1667.63 18:16:39 INFO - 2015-11-12 18:16:39,919 DEBUG : BROWSER_OUTPUT: Values: 284.7 290.1 290.7 297.5 308.6 6134.0 6169.6 6178.8 6342.6 6360.5 6206.6 6214.2 6217.4 6229.9 6263.1 4464.0 4736.8 4739.7 4746.7 4791.9 4581.7 4615.5 4636.5 4660.9 4711.4 4570.3 4594.9 4613.3 4629.6 4650.3 4417.6 4542.1 4543.1 4599.9 4669.1 3867.2 3882.7 3885.3 3886.0 3904.7 6009.2 6063.3 6089.1 6112.1 6120.7 5115.5 5127.5 5143.4 5151.9 5179.9 6270.9 6417.4 6439.5 6524.5 6528.1 4240.8 4266.3 4270.4 4298.6 4317.4 6735.9 6846.8 6850.9 6886.8 6889.6 4170.9 4233.3 4305.2 4339.6 4352.6 4388.4 4396.8 4405.9 4425.2 4445.5 5132.2 5144.9 5154.8 5213.5 5214.7 6485.4 6492.7 6506.7 6512.7 6527.6 1537.8 1552.9 1567.5 1570.9 1587.9 1002.5 1006.3 1027.4 1031.0 1035.1 6184.2 6204.6 6229.1 6272.8 6286.0 6690.3 6718.9 6762.7 6777.6 6784.3 6202.7 6230.8 6246.1 6256.3 6268.3 3574.9 3598.6 3617.5 3633.7 3698.3 6964.8 7030.9 7056.8 7059.4 7145.6 7003.8 7010.9 7081.7 7086.4 7089.5 6855.1 6994.2 7062.9 7082.1 7091.6 6793.2 6804.2 6807.1 6815.7 6818.8 6495.1 6621.6 6631.7 6697.3 6698.6 6917.4 7045.2 7048.2 7128.1 7157.0 4349.8 4413.1 4416.9 4418.8 4462.4 6783.7 6792.1 6858.7 6867.7 6867.7 6365.4 6525.5 6531.7 6550.0 6619.7 6546.6 6570.2 6595.0 6617.8 6630.9 6278.6 6357.1 6373.1 6383.1 6440.3 6489.9 6523.2 6535.8 6554.6 6635.8 6398.9 6408.0 6442.1 6455.3 6465.4 18:16:39 INFO - 2015-11-12 18:16:39,919 DEBUG : BROWSER_OUTPUT: 18:16:39 INFO - 2015-11-12 18:16:39,919 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12947.84 Median:47724.52 stddev:15300.27 (32.1%) stddev-sans-first:15315.77 18:16:39 INFO - 2015-11-12 18:16:39,921 DEBUG : BROWSER_OUTPUT: Values: 748.7 755.1 761.1 774.5 777.8 13978.9 14008.2 14089.9 14373.1 14380.3 12330.5 13136.1 13161.4 13185.9 13291.7 693.1 874.8 883.7 893.1 893.6 707.9 825.1 875.1 876.8 878.7 922.0 944.1 944.9 945.7 949.9 721.1 724.8 912.3 939.0 939.9 686.7 689.4 690.3 692.2 693.3 13611.2 13860.5 13865.1 13896.0 13916.6 11628.5 11639.5 11978.6 12109.0 12336.6 9168.2 9225.0 9379.5 9509.0 10026.9 3334.7 3343.4 3347.1 3384.1 3397.0 47707.5 47741.5 47767.5 47876.0 47919.8 8997.4 9043.2 9146.1 9161.9 9708.0 12087.4 12201.5 12213.3 12213.3 12232.3 6054.9 6072.9 6134.7 6183.6 6211.9 3595.4 3606.7 3644.9 3668.5 3684.2 2660.3 2703.8 2704.7 2705.9 2710.8 404.7 406.2 409.7 410.3 411.0 504.8 555.9 573.3 613.9 639.0 7831.0 7880.0 7928.0 8054.2 8062.0 475.6 515.2 588.1 590.4 622.6 3618.8 3981.9 4063.7 4084.1 4123.0 54897.7 54998.5 55023.7 55032.7 55188.7 46546.8 46865.8 46898.8 47174.3 47182.3 41038.4 41622.8 42330.2 42692.6 42749.0 8091.3 8268.7 8299.8 8307.7 8575.2 34021.1 34722.5 34842.0 35242.6 35303.5 41990.4 44651.9 45037.3 45298.3 45362.8 7523.9 7670.2 7724.3 7769.6 7809.3 11141.7 11292.6 11439.4 11569.4 12116.9 10359.4 10495.8 10839.1 10949.1 11330.1 10427.5 10526.6 10730.3 10809.8 11341.1 6993.3 9900.4 10349.7 10806.2 11215.7 8173.7 8772.5 8886.4 9458.7 9486.6 8317.2 9083.0 9232.1 9250.5 9347.6 18:16:39 INFO - 2015-11-12 18:16:39,921 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:16:39 INFO - 2015-11-12 18:16:39,921 DEBUG : BROWSER_OUTPUT: 18:16:40 INFO - 2015-11-12 18:16:40,581 INFO : Browser exited with error code: 0 18:16:40 INFO - 2015-11-12 18:16:40,608 INFO : Completed test dromaeo_css (00:18:34) 18:16:40 INFO - 2015-11-12 18:16:40,608 INFO : Starting test kraken 18:16:40 INFO - 2015-11-12 18:16:40,608 DEBUG : operating with platform_type : mac_ 18:16:40 INFO - 2015-11-12 18:16:40,608 INFO : Initialising browser for kraken test... 18:16:40 INFO - 2015-11-12 18:16:40,621 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmpgQv4DI/profile http://localhost:49268/getInfo.html 18:16:42 INFO - 2015-11-12 18:16:42,816 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:16:42 INFO - 2015-11-12 18:16:42,817 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:16:42 INFO - 2015-11-12 18:16:42,817 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:16:42 INFO - 2015-11-12 18:16:42,817 DEBUG : BROWSER_OUTPUT: __metrics 18:16:42 INFO - 2015-11-12 18:16:42,832 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:16:43 INFO - 2015-11-12 18:16:43,503 INFO : Browser initialized. 18:16:43 INFO - 2015-11-12 18:16:43,504 INFO : Running cycle 1/1 for kraken test... 18:16:43 INFO - 2015-11-12 18:16:43,504 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmpgQv4DI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:16:55 INFO - 2015-11-12 18:16:55,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 229249024 18:16:55 INFO - 2015-11-12 18:16:55,362 DEBUG : BROWSER_OUTPUT: 18:16:57 INFO - 2015-11-12 18:16:57,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 18:16:58 INFO - 2015-11-12 18:16:58,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 285814784 18:16:58 INFO - 2015-11-12 18:16:58,532 DEBUG : BROWSER_OUTPUT: 18:17:01 INFO - 2015-11-12 18:17:01,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 18:17:01 INFO - 2015-11-12 18:17:01,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 297566208 18:17:01 INFO - 2015-11-12 18:17:01,752 DEBUG : BROWSER_OUTPUT: 18:17:04 INFO - 2015-11-12 18:17:04,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 18:17:05 INFO - 2015-11-12 18:17:05,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 281403392 18:17:05 INFO - 2015-11-12 18:17:05,309 DEBUG : BROWSER_OUTPUT: 18:17:07 INFO - 2015-11-12 18:17:07,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 18:17:07 INFO - 2015-11-12 18:17:07,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 282173440 18:17:07 INFO - 2015-11-12 18:17:07,965 DEBUG : BROWSER_OUTPUT: 18:17:10 INFO - 2015-11-12 18:17:10,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:17:10 INFO - 2015-11-12 18:17:10,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 284532736 18:17:10 INFO - 2015-11-12 18:17:10,715 DEBUG : BROWSER_OUTPUT: 18:17:13 INFO - 2015-11-12 18:17:13,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 18:17:14 INFO - 2015-11-12 18:17:14,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 283324416 18:17:14 INFO - 2015-11-12 18:17:14,335 DEBUG : BROWSER_OUTPUT: 18:17:17 INFO - 2015-11-12 18:17:17,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 18:17:18 INFO - 2015-11-12 18:17:18,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 284377088 18:17:18 INFO - 2015-11-12 18:17:18,054 DEBUG : BROWSER_OUTPUT: 18:17:20 INFO - 2015-11-12 18:17:20,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 18:17:21 INFO - 2015-11-12 18:17:21,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 285507584 18:17:21 INFO - 2015-11-12 18:17:21,460 DEBUG : BROWSER_OUTPUT: 18:17:23 INFO - 2015-11-12 18:17:23,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:17:23 INFO - 2015-11-12 18:17:23,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 318857216 18:17:23 INFO - 2015-11-12 18:17:23,591 DEBUG : BROWSER_OUTPUT: 18:17:25 INFO - 2015-11-12 18:17:25,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:17:26 INFO - 2015-11-12 18:17:26,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 319852544 18:17:26 INFO - 2015-11-12 18:17:26,028 DEBUG : BROWSER_OUTPUT: 18:17:28 INFO - 2015-11-12 18:17:28,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:17:28 INFO - 2015-11-12 18:17:28,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 327688192 18:17:28 INFO - 2015-11-12 18:17:28,700 DEBUG : BROWSER_OUTPUT: 18:17:31 INFO - 2015-11-12 18:17:31,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:17:31 INFO - 2015-11-12 18:17:31,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 329977856 18:17:31 INFO - 2015-11-12 18:17:31,858 DEBUG : BROWSER_OUTPUT: 18:17:34 INFO - 2015-11-12 18:17:34,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:17:35 INFO - 2015-11-12 18:17:35,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 328527872 18:17:35 INFO - 2015-11-12 18:17:35,063 DEBUG : BROWSER_OUTPUT: 18:17:36 INFO - 2015-11-12 18:17:36,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 18:17:37 INFO - 2015-11-12 18:17:37,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 386875392 18:17:37 INFO - 2015-11-12 18:17:37,051 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,052 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:17:37 INFO - 2015-11-12 18:17:37,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:17:37 INFO - 2015-11-12 18:17:37,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:17:37 INFO - 2015-11-12 18:17:37,053 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:17:37 INFO - 2015-11-12 18:17:37,053 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;107;102;108;108;109;106;106;99;106 18:17:37 INFO - 2015-11-12 18:17:37,053 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;134;150;160;129;151;146;124;161;126 18:17:37 INFO - 2015-11-12 18:17:37,053 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;162;163;162;162;161;162;163;160 18:17:37 INFO - 2015-11-12 18:17:37,053 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;82;87;86;68;71;70;78;82;65 18:17:37 INFO - 2015-11-12 18:17:37,053 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;101;135;87;89;89;123;87;88;127 18:17:37 INFO - 2015-11-12 18:17:37,054 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;119;120;114;119;120;115;115;114;115;120 18:17:37 INFO - 2015-11-12 18:17:37,054 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;126;125;125;125;125;125;125;125;125 18:17:37 INFO - 2015-11-12 18:17:37,054 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;94;101;94;93;93;101;94;93;101 18:17:37 INFO - 2015-11-12 18:17:37,054 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;57;58;58;58;58;66;57;57 18:17:37 INFO - 2015-11-12 18:17:37,054 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;68;68;68;69;69;68;68 18:17:37 INFO - 2015-11-12 18:17:37,055 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;85;86;85;84;86;84;86;85 18:17:37 INFO - 2015-11-12 18:17:37,055 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;132;124;123;128;134;123;124;134;134 18:17:37 INFO - 2015-11-12 18:17:37,055 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;145;153;156;155;144;156;154;155;142 18:17:37 INFO - 2015-11-12 18:17:37,055 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;73;72;70;72;71;71;70;73;71 18:17:37 INFO - 2015-11-12 18:17:37,055 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:17:37 INFO - 2015-11-12 18:17:37,055 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:17:37 INFO - 2015-11-12 18:17:37,055 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,919 18:17:37 INFO - 2015-11-12 18:17:37,056 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:17:37 INFO - 2015-11-12 18:17:37,057 DEBUG : BROWSER_OUTPUT: __startTimestamp1447381057051__endTimestamp 18:17:37 INFO - 2015-11-12 18:17:37,057 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,057 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:17:37 INFO - 2015-11-12 18:17:37,057 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:17:37 INFO - 2015-11-12 18:17:37,058 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,058 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.90 Median:108.00 stddev:3.11 (2.9%) stddev-sans-first:3.20 18:17:37 INFO - 2015-11-12 18:17:37,058 DEBUG : BROWSER_OUTPUT: Values: 108.0 107.0 102.0 108.0 108.0 109.0 106.0 106.0 99.0 106.0 18:17:37 INFO - 2015-11-12 18:17:37,058 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,058 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.70 Median:150.50 stddev:14.24 (9.5%) stddev-sans-first:14.40 18:17:37 INFO - 2015-11-12 18:17:37,059 DEBUG : BROWSER_OUTPUT: Values: 156.0 134.0 150.0 160.0 129.0 151.0 146.0 124.0 161.0 126.0 18:17:37 INFO - 2015-11-12 18:17:37,059 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,059 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.12 18:17:37 INFO - 2015-11-12 18:17:37,059 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 162.0 163.0 162.0 162.0 161.0 162.0 163.0 160.0 18:17:37 INFO - 2015-11-12 18:17:37,059 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,059 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.30 Median:80.00 stddev:7.79 (9.7%) stddev-sans-first:8.22 18:17:37 INFO - 2015-11-12 18:17:37,059 DEBUG : BROWSER_OUTPUT: Values: 74.0 82.0 87.0 86.0 68.0 71.0 70.0 78.0 82.0 65.0 18:17:37 INFO - 2015-11-12 18:17:37,060 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,060 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:87.50 stddev:18.75 (21.4%) stddev-sans-first:19.79 18:17:37 INFO - 2015-11-12 18:17:37,060 DEBUG : BROWSER_OUTPUT: Values: 97.0 101.0 135.0 87.0 89.0 89.0 123.0 87.0 88.0 127.0 18:17:37 INFO - 2015-11-12 18:17:37,060 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,060 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:119.00 stddev:2.69 (2.3%) stddev-sans-first:2.76 18:17:37 INFO - 2015-11-12 18:17:37,060 DEBUG : BROWSER_OUTPUT: Values: 119.0 120.0 114.0 119.0 120.0 115.0 115.0 114.0 115.0 120.0 18:17:37 INFO - 2015-11-12 18:17:37,061 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,061 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.10 Median:125.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:17:37 INFO - 2015-11-12 18:17:37,061 DEBUG : BROWSER_OUTPUT: Values: 125.0 126.0 125.0 125.0 125.0 125.0 125.0 125.0 125.0 125.0 18:17:37 INFO - 2015-11-12 18:17:37,061 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,061 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:93.50 stddev:3.61 (3.9%) stddev-sans-first:3.77 18:17:37 INFO - 2015-11-12 18:17:37,061 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 101.0 94.0 93.0 93.0 101.0 94.0 93.0 101.0 18:17:37 INFO - 2015-11-12 18:17:37,062 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,062 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:2.68 (4.6%) stddev-sans-first:2.83 18:17:37 INFO - 2015-11-12 18:17:37,063 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 57.0 58.0 58.0 58.0 58.0 66.0 57.0 57.0 18:17:37 INFO - 2015-11-12 18:17:37,063 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,063 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 18:17:37 INFO - 2015-11-12 18:17:37,063 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 18:17:37 INFO - 2015-11-12 18:17:37,064 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,064 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 18:17:37 INFO - 2015-11-12 18:17:37,064 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 86.0 85.0 84.0 86.0 84.0 86.0 85.0 18:17:37 INFO - 2015-11-12 18:17:37,064 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,064 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:130.00 stddev:4.97 (3.8%) stddev-sans-first:5.05 18:17:37 INFO - 2015-11-12 18:17:37,064 DEBUG : BROWSER_OUTPUT: Values: 124.0 132.0 124.0 123.0 128.0 134.0 123.0 124.0 134.0 134.0 18:17:37 INFO - 2015-11-12 18:17:37,064 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,065 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:154.50 stddev:5.72 (3.7%) stddev-sans-first:5.71 18:17:37 INFO - 2015-11-12 18:17:37,065 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 153.0 156.0 155.0 144.0 156.0 154.0 155.0 142.0 18:17:37 INFO - 2015-11-12 18:17:37,065 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,065 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.07 (1.5%) stddev-sans-first:1.13 18:17:37 INFO - 2015-11-12 18:17:37,065 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 72.0 70.0 72.0 71.0 71.0 70.0 73.0 71.0 18:17:37 INFO - 2015-11-12 18:17:37,065 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:17:37 INFO - 2015-11-12 18:17:37,065 DEBUG : BROWSER_OUTPUT: 18:17:37 INFO - 2015-11-12 18:17:37,743 INFO : Browser exited with error code: 0 18:17:37 INFO - 2015-11-12 18:17:37,790 INFO : Completed test kraken (00:00:57) 18:17:37 INFO - 2015-11-12 18:17:37,790 INFO : Starting test v8_7 18:17:37 INFO - 2015-11-12 18:17:37,790 DEBUG : operating with platform_type : mac_ 18:17:37 INFO - 2015-11-12 18:17:37,791 INFO : Initialising browser for v8_7 test... 18:17:37 INFO - 2015-11-12 18:17:37,803 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmpnYf_ex/profile http://localhost:49268/getInfo.html 18:17:39 INFO - 2015-11-12 18:17:39,943 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:17:39 INFO - 2015-11-12 18:17:39,944 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:17:39 INFO - 2015-11-12 18:17:39,944 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:17:39 INFO - 2015-11-12 18:17:39,944 DEBUG : BROWSER_OUTPUT: __metrics 18:17:39 INFO - 2015-11-12 18:17:39,963 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:17:40 INFO - 2015-11-12 18:17:40,590 INFO : Browser initialized. 18:17:40 INFO - 2015-11-12 18:17:40,591 INFO : Running cycle 1/1 for v8_7 test... 18:17:40 INFO - 2015-11-12 18:17:40,591 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/T/tmpnYf_ex/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:17:52 INFO - 2015-11-12 18:17:52,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 227827712 18:17:52 INFO - 2015-11-12 18:17:52,469 DEBUG : BROWSER_OUTPUT: 18:18:13 INFO - 2015-11-12 18:18:13,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/v8_7/run.html (next: http://localhost:49268/tests/v8_7/run.html) 18:18:14 INFO - 2015-11-12 18:18:14,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 726339584 18:18:14 INFO - 2015-11-12 18:18:14,186 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,186 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:18:14 INFO - 2015-11-12 18:18:14,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:18:14 INFO - 2015-11-12 18:18:14,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:18:14 INFO - 2015-11-12 18:18:14,187 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:18:14 INFO - 2015-11-12 18:18:14,187 DEBUG : BROWSER_OUTPUT: |0;Richards;168.49199663016006 18:18:14 INFO - 2015-11-12 18:18:14,187 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.76688286913392 18:18:14 INFO - 2015-11-12 18:18:14,187 DEBUG : BROWSER_OUTPUT: |2;Encrypt;326.1578604044357 18:18:14 INFO - 2015-11-12 18:18:14,187 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5770.114942528736 18:18:14 INFO - 2015-11-12 18:18:14,187 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1901.1406844106464 18:18:14 INFO - 2015-11-12 18:18:14,188 DEBUG : BROWSER_OUTPUT: |5;Earley;916.5902841429881 18:18:14 INFO - 2015-11-12 18:18:14,188 DEBUG : BROWSER_OUTPUT: |6;Boyer;12612.5 18:18:14 INFO - 2015-11-12 18:18:14,188 DEBUG : BROWSER_OUTPUT: |7;RegExp;30323.529411764706 18:18:14 INFO - 2015-11-12 18:18:14,188 DEBUG : BROWSER_OUTPUT: |8;Splay;694.9270326615705 18:18:14 INFO - 2015-11-12 18:18:14,188 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5813.953488372093 18:18:14 INFO - 2015-11-12 18:18:14,188 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:18:14 INFO - 2015-11-12 18:18:14,189 DEBUG : BROWSER_OUTPUT: __startTimestamp1447381094185__endTimestamp 18:18:14 INFO - 2015-11-12 18:18:14,189 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,189 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:18:14 INFO - 2015-11-12 18:18:14,189 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:18:14 INFO - 2015-11-12 18:18:14,189 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,189 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.49 Median:168.49 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,189 DEBUG : BROWSER_OUTPUT: Values: 168.5 18:18:14 INFO - 2015-11-12 18:18:14,190 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,190 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.77 Median:190.77 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,191 DEBUG : BROWSER_OUTPUT: Values: 190.8 18:18:14 INFO - 2015-11-12 18:18:14,191 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,191 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:326.16 Median:326.16 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: Values: 326.2 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5770.11 Median:5770.11 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: Values: 5770.1 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1901.14 Median:1901.14 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: Values: 1901.1 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,192 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:916.59 Median:916.59 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,193 DEBUG : BROWSER_OUTPUT: Values: 916.6 18:18:14 INFO - 2015-11-12 18:18:14,193 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,193 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12612.50 Median:12612.50 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,193 DEBUG : BROWSER_OUTPUT: Values: 12612.5 18:18:14 INFO - 2015-11-12 18:18:14,193 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,193 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30323.53 Median:30323.53 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,193 DEBUG : BROWSER_OUTPUT: Values: 30323.5 18:18:14 INFO - 2015-11-12 18:18:14,193 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,194 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:694.93 Median:694.93 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,194 DEBUG : BROWSER_OUTPUT: Values: 694.9 18:18:14 INFO - 2015-11-12 18:18:14,194 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,194 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5813.95 Median:5813.95 stddev:0.00 (0.0%) 18:18:14 INFO - 2015-11-12 18:18:14,194 DEBUG : BROWSER_OUTPUT: Values: 5814.0 18:18:14 INFO - 2015-11-12 18:18:14,194 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:18:14 INFO - 2015-11-12 18:18:14,194 DEBUG : BROWSER_OUTPUT: 18:18:14 INFO - 2015-11-12 18:18:14,848 INFO : Browser exited with error code: 0 18:18:14 INFO - 2015-11-12 18:18:14,867 INFO : Completed test v8_7 (00:00:37) 18:18:15 INFO - 2015-11-12 18:18:15,285 INFO : Completed test suite (00:20:09) 18:18:15 INFO - 2015-11-12 18:18:15,285 DEBUG : Working with test: dromaeo_css 18:18:15 INFO - 2015-11-12 18:18:15,285 DEBUG : Generating results file: dromaeo_css 18:18:15 INFO - 2015-11-12 18:18:15,286 DEBUG : Working with test: kraken 18:18:15 INFO - 2015-11-12 18:18:15,286 DEBUG : Generating results file: kraken 18:18:15 INFO - 2015-11-12 18:18:15,286 INFO : javascript benchmark 18:18:15 INFO - 2015-11-12 18:18:15,286 DEBUG : Working with test: v8_7 18:18:15 INFO - 2015-11-12 18:18:15,287 DEBUG : Generating results file: v8_7 18:18:15 INFO - 2015-11-12 18:18:15,287 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:18:15 INFO - 2015-11-12 18:18:15,602 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 18:18:15 INFO - 2015-11-12 18:18:15,602 DEBUG : process_Request line: dromaeo_css 6684.75 graph.html#tests=[[72,64,55]] 18:18:15 INFO - 2015-11-12 18:18:15,602 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:18:15 INFO - 2015-11-12 18:18:15,641 DEBUG : process_Request line: kraken 1489.10 graph.html#tests=[[232,64,55]] 18:18:15 INFO - 2015-11-12 18:18:15,641 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:18:15 INFO - 2015-11-12 18:18:15,676 DEBUG : process_Request line: v8_7 18130.79 graph.html#tests=[[230,64,55]] 18:18:15 INFO - 2015-11-12 18:18:15,677 INFO : javascript benchmark 18:18:15 INFO - 2015-11-12 18:18:15,679 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [335.05514449253116, 336.42639299993505, 338.2473995360325, 339.63658884993055, 340.73252496790025, 13711.108777929428, 14117.294135293245, 16672.749908751364, 16728.581785455353, 18699.71950420745, 13717.382717777698, 14736.336864841081, 17038.744418833696, 17159.82840171598, 17423.477295681118, 5308.0710875596715, 5401.054815407308, 5421.457854214586, 5457.972710136443, 5469.808556700516, 3904.609539046101, 5209.400918894319, 5295.4704529547125, 5351.464853514656, 5414.945850541503, 4038.6567141792984, 5760.971195144019, 5868.559858010645, 5898.203742494773, 5931.199288096116, 5692.174634677948, 5880.441358070976, 5886.410669119336, 5906.025505791561, 5954.97022514889, 5122.615803814729, 5138.845834624967, 5140.511651393112, 5142.228665700175, 5155.9742201288755, 21129.095697805893, 21200.469988250417, 21472.24847130343, 21530.784692153036, 21606.351809445583, 1923.5287354598213, 2032.2229910052445, 2067.1008111471556, 2096.685497175436, 2117.7246957895377, 12892.935535322356, 12939.158954667917, 13098.738025239538, 13380.264085475295, 13387.129836560593, 1643.9178041097898, 1646.2756387189718, 1647.365764180787, 1670.6408122253774, 1701.9659606807918, 56815.0, 58994.0, 62674.68662656703, 63218.0517292241, 64203.357966420204, 17070.317187312616, 17104.0, 17109.0, 17370.3051877926, 17461.7380739289, 24770.133045343326, 24876.12933547317, 24954.0, 25041.12356067529, 25064.4987100257, 9676.419414834992, 9693.70918872435, 9707.417554946725, 9732.756681082888, 9790.706278811647, 7603.315701586884, 7885.802854928558, 7910.9604451977375, 8216.671333146727, 8249.29880960113, 8091.919080809116, 8131.105578386373, 8153.714619988272, 8182.7545173644885, 8236.217559331853, 2113.492761737172, 3170.5402716605963, 3242.0760083376126, 3270.7710460268027, 3306.9748378002896, 433.0386541877028, 446.03656102818405, 455.15568620209694, 463.81679236701314, 466.74562363511967, 11595.478203480863, 11731.237469564621, 11904.94047529774, 11931.880681193077, 11981.28112313264, 398.68703068091406, 444.782056792176, 454.112210628221, 457.40308896889877, 469.7064334790756, 5960.165576819249, 6194.81415557534, 6235.376462353728, 6319.146915166394, 6483.578567393104, 535911.0, 543191.0, 543646.0, 545728.0, 556735.0, 68926.0, 69814.65092674505, 70810.64594676993, 71264.64367678128, 72838.63580682168, 482.7658585585988, 495.4723219771004, 496.1292930906308, 498.11335822236475, 499.16140883315654, 10607.257491975797, 10883.836742448711, 11065.557377705123, 11086.944565277123, 11172.385518796544, 30439.847800760854, 32387.83806081049, 32653.0, 32689.673103268662, 33248.66751332456, 40420.79789601033, 40628.18743625052, 41140.0, 41259.1748165041, 41335.0, 6101.176341194059, 6123.969380153071, 6206.565540412128, 6211.9068213977735, 6214.4407003369915, 11040.558377664804, 11315.943420282845, 11444.313341199555, 11481.655550333504, 11824.994875435685, 9945.104940555384, 10063.647772327933, 10177.0, 10183.032611901857, 10198.490075496344, 9663.758406039906, 9765.121139097515, 9792.902070979198, 9795.951020244853, 9871.25965552572, 8468.44955077918, 9991.800163996824, 10223.131033862204, 10361.378317300987, 10366.326188797704, 5530.419305972815, 5540.085885828793, 5880.294364676266, 5911.024680927599, 6012.098185272244, 9810.901890980998, 9921.206303495848, 10008.749781255527, 10050.346727462691, 10118.645847395306], "dojo.html": [3135.3259049304397, 3202.2954949911027, 3213.309138535215, 3238.0447767908463, 3262.9510557341628, 5138.974305128479, 5216.347956505437, 5320.308359913211, 5333.0933741264025, 5345.545628621567, 5223.686578805275, 5265.236540701606, 5267.39424966129, 5294.311739473863, 5351.304330437048, 4881.096997055538, 4883.023395320933, 4898.06936682031, 4913.434954980169, 5032.0690672225755, 4946.431160416562, 5034.874128146789, 5088.465711100337, 5095.363079615048, 5154.896902061956, 4748.548887855648, 4778.665493415462, 4825.879353016203, 4847.272909063633, 4955.331030310916, 4773.427188737339, 4879.560839524424, 4889.1443997300685, 4894.461609222983, 4955.851324460272, 4840.15297322967, 4868.756562171912, 4870.366852309213, 4878.048780487807, 4923.335349727777, 5100.642954993152, 5121.513456221653, 5174.870628234325, 5181.0674078665825, 5215.426303106655, 5473.261109750172, 5503.3120859892515, 5518.034343989826, 5519.889602207973, 5523.585731070186, 5563.193336966157, 5572.247746554204, 5584.497395234448, 5594.776208951637, 5601.159826026129, 5016.147254966628, 5060.544550990355, 5115.693058416507, 5128.948710512885, 5133.204353325241, 5662.716864156776, 5668.51817595509, 5752.0, 5774.624649397776, 5786.1610066540115, 5391.81128660495, 5398.4871437213405, 5408.59435542328, 5433.157860531624, 5437.809676661377, 5291.153415453586, 5388.110961691277, 5450.809221677222, 5457.836264912059, 5580.748866301026, 5352.545033672103, 5405.891882162414, 5440.483154100354, 5454.7818087276855, 5481.479259470344, 5445.482679145475, 5491.697956612425, 5505.614606977473, 5511.448855114537, 5535.0313695104005, 4088.1210539733506, 4204.306289462204, 4207.495100587949, 4218.6414154797185, 4267.146570685875, 3909.9218015639526, 3911.4328422378594, 3963.6432721054666, 3976.562578116405, 4004.1791432756213, 5164.173732202905, 5199.376074871039, 5201.609879259071, 5209.739513024334, 5210.505002024802, 5409.810656626999, 5527.723613819293, 5542.528885044816, 5544.168374743821, 5564.582656300794, 5164.535191832678, 5179.067767801832, 5188.0661480933795, 5215.035218484517, 5238.895222095613, 4731.384919960383, 4804.0872234275375, 4806.014766972762, 4920.4095508538485, 4932.506749325111, 5702.372738998707, 5793.507551858139, 5794.913076303775, 5810.448007439287, 5841.970790146022, 5636.520895723909, 5638.9436105638415, 5659.094544872801, 5693.174489698888, 5747.770089196385, 5457.69982650958, 5586.441355864381, 5601.271834661468, 5817.418258174149, 5825.737841797214, 5447.972760136174, 5491.066518691912, 5509.3664228614225, 5515.034868898007, 5612.074007788832, 5478.150886612581, 5565.248691426606, 5599.944000559943, 5653.604247702786, 5680.40355762639, 5322.866928326823, 5420.078586640359, 5432.511074003359, 5522.723863806874, 5552.389237183826, 5337.199420087018, 5433.592480563894, 5435.945640543702, 5440.483154100354, 5473.698946557977, 5409.702466364388, 5436.400288693692, 5441.591880609049, 5443.863903402446, 5477.616566840283, 5254.525422630317, 5386.542143917811, 5389.083855744611, 5524.585656075891, 5596.552275818006, 5151.330327057459, 5252.711100889488, 5270.262163297218, 5302.522772950453, 5328.333958255218], "mootools.html": [1522.2236659303765, 1677.8489935905766, 1763.6825371433144, 1791.4177892185044, 1793.2826869252297, 6819.079424277721, 7274.636268186589, 7620.390368770499, 7639.8854017189715, 7661.19557446467, 7421.5176013559085, 7530.698772049125, 7544.69821207151, 7544.698212071525, 7562.243775622435, 2090.707300977864, 2097.1192099318246, 2103.453102193433, 2104.7684754676975, 2117.195465723031, 2141.571685662866, 2159.136345461812, 2171.7176767020346, 2178.9237376691817, 2189.8029177374033, 1996.7504061992252, 2039.2862498125685, 2053.0555944265657, 2077.8441616878717, 2081.105124796337, 2079.3761871438583, 2081.5316553775433, 2084.27050532314, 2085.593309304686, 2088.7702352741185, 2065.6882879371706, 2124.383928660702, 2128.6594144936735, 2129.829613630906, 2140.2723074154706, 6665.300143484913, 6918.308169183092, 7431.888521672179, 7482.1395539513105, 7482.925170748277, 4406.228909940747, 4456.22016147173, 4474.552544745532, 4492.730436173807, 4501.414816073922, 2806.0, 2890.8410037447934, 2936.8531573421456, 2942.867570959312, 2958.9260268493244, 863.1239292118505, 889.488544087146, 906.5731534798472, 906.7959709065474, 919.7700574856286, 9936.403815771004, 9972.052654997764, 10012.449315287657, 10037.548310326052, 10156.39061656303, 3991.4611527444004, 4011.679065674739, 4026.053877338823, 4029.9194016119513, 4060.4315395844606, 8838.469691818511, 8883.156100170474, 8894.73315800527, 8898.644054237888, 9010.59452324647, 4606.170889239969, 4610.423697037871, 4618.0, 4643.3963584733765, 4669.13620980113, 4125.339945608688, 4192.643625291885, 4221.387898754663, 4224.852130175429, 4234.322508398642, 3424.298018906118, 3454.464557993515, 3455.0, 3501.299740052, 3505.8071806050402, 1089.4824958144977, 1099.0, 1099.312929419113, 1105.9778804423865, 1118.2507719827736, 1049.6903413492885, 1066.7919755647729, 1069.6470164845582, 1202.5911190195375, 1335.5926442434957, 6967.338102880219, 7075.2217256101785, 7114.039604653409, 7120.430365570742, 7199.640017999079, 1020.7601213714771, 1041.7812259425605, 1110.616837191184, 1112.8386383974278, 1127.9492422840992, 5356.625036247503, 5652.85867853307, 5685.260916080883, 5717.971410143005, 5733.827985160452, 8254.298384637374, 8945.642174313085, 9054.909450905538, 9095.681651142178, 9115.407498512575, 8590.269827064645, 8855.867161992575, 8915.73252802404, 8920.553972301488, 8930.910690893008, 6935.445164386837, 7084.256153103953, 7095.645217739092, 7132.1441427029085, 7135.857282854314, 7075.6815943281645, 7118.679659415235, 7176.7488137914925, 7182.389496892613, 7207.5675459472595, 7518.097828260425, 8057.274845263954, 8081.15147909461, 8139.918600813916, 8172.42793004484, 7924.326432253323, 8154.918450815416, 8164.632591533514, 8296.419250652638, 8301.501909885184, 7227.313405226495, 7326.450516211199, 7350.558966462029, 7424.740134095281, 7425.440657461993, 7298.927010729824, 7373.3732632726815, 7444.516106453063, 7489.775306740807, 7500.962495187708, 6870.484713646397, 6945.374916257561, 6989.161300643956, 7013.859722805413, 7014.473914456335, 6749.156355455568, 6787.626680532618, 6897.137857767779, 6909.1018167637885, 6916.619585922823, 6968.163820341389, 7006.824829379307, 7012.824679383056, 7015.403690686348, 7090.680919358538, 6279.340669229665, 6306.558540902093, 6337.524685648687, 6341.048842673636, 6369.01280301554, 6096.817095487142, 6310.652914089769, 6325.778597749057, 6349.984002559569, 6354.52341074412], "ext.html": [527.9994410591928, 531.6145794299132, 543.7770514089224, 546.3580293155543, 561.2058936604705, 29507.852460737693, 30695.539566906486, 37314.25371492572, 38349.80825095878, 38439.423408648894, 39775.20449591014, 40090.79954600223, 40281.0, 40489.0, 40715.796421017854, 8064.677412903477, 8797.82404351911, 8826.558672066403, 8860.24687901529, 8878.778030549223, 8106.432549721522, 10872.238943273975, 10991.61529346473, 11026.779464410707, 11103.777924441507, 10726.356418614909, 10894.727631809228, 10898.073663738593, 10909.127269818395, 11018.834717479243, 8182.386321025947, 8332.791680207984, 10060.396376217413, 10123.139533139654, 10829.945850270698, 10525.21060920434, 10645.627403040857, 10695.144388448905, 10699.465026748709, 10716.249862509627, 37398.813005935066, 37686.81156594227, 37731.62268377309, 37760.0, 37938.05154871123, 2778.138776979143, 2835.6530647942063, 2849.1167738001286, 2898.9130326090253, 3357.529945807589, 25978.0, 26023.609645855326, 26352.60471092935, 26433.867830660725, 26688.73311266882, 2317.9884100579557, 2338.777816107467, 2345.0502546468706, 2357.976420235793, 2458.4468494588755, 255563.0, 256023.0, 256616.0, 257428.0, 257467.0, 47218.29172562414, 47763.0, 53910.99157109551, 54634.45365546294, 54667.72666136644, 51487.742561287705, 51828.22257666138, 52010.0, 52017.47982520126, 52275.73862130741, 15217.771733424008, 15233.923830380778, 15254.694906101815, 15299.15854627984, 15367.231638418034, 11635.941820291013, 11645.243059201124, 11659.650210493699, 11685.649430517098, 11690.70773230659, 17958.19188136537, 18054.09729513519, 18055.638887222183, 18063.63872722538, 18105.909470452563, 7844.137144914055, 8069.435139540175, 8091.554964476893, 8140.145284745135, 8150.2664760171865, 889.1020069729619, 940.6190492850407, 951.6098399656246, 957.7509847439577, 1095.0090168397612, 26699.512760906, 27162.418790604697, 27392.58911116335, 27578.0, 27694.723052769616, 1017.8422344536609, 1048.0881632979356, 1053.5364439646685, 1060.5015642647943, 1141.6746227325339, 14109.576712698636, 14177.0, 14337.498187563386, 14359.92820035893, 14400.423983040771, 313914.0, 318844.0, 319258.0, 319718.0, 319806.0, 51792.741036294574, 52108.0, 52165.217521737206, 52283.47716522862, 52312.0, 1343.8656134386483, 1357.8777909988148, 1365.904386692942, 1376.0436496634943, 1383.197745307719, 26694.866525667247, 27139.185824425298, 27496.450070998868, 27516.724832751417, 27531.17406477809, 40020.399694005195, 40951.59048409478, 50461.243081353074, 50763.49236507588, 51374.22938655998, 253600.0, 256691.0, 259131.0, 259776.0, 260087.0, 26372.8681356592, 26720.19839404821, 29090.0, 29334.559981599865, 29342.11973640794, 38405.23189536138, 39456.40815387714, 39953.60046399499, 40157.0, 40530.594694052685, 30730.846345769023, 31885.840570796998, 32206.0, 32244.516332255505, 32412.02763917086, 31183.220419488785, 32894.34211315808, 33578.83210583931, 33719.15702107467, 34015.319693606485, 31665.366692666477, 32322.83838580792, 32482.51276230811, 32524.0, 32848.34303313968, 26536.191827892886, 29425.264368390104, 29451.551462979416, 29826.254343641584, 30365.240868978453, 22533.43666408353, 22826.46726580191, 23019.88490057539, 23063.308100757004, 23174.42063948415], "prototype.html": [284.65840990811034, 290.0500859684533, 290.70638654958475, 297.48832008944606, 308.55567982105765, 6134.0, 6169.56813023088, 6178.752849886005, 6342.556021078526, 6360.4911607071435, 6206.596571222867, 6214.161088253096, 6217.409346112124, 6229.906551401721, 6263.0918516815145, 4463.977680111595, 4736.763161841903, 4739.720275525606, 4746.667733258673, 4791.928121078186, 4581.725096494204, 4615.515370886059, 4636.53634636537, 4660.906781864361, 4711.434627844664, 4570.314452832085, 4594.862154135381, 4613.308003799423, 4629.629629629639, 4650.325702773112, 4417.602415782563, 4542.091581683677, 4543.1140927519145, 4599.885002874938, 4669.136209801198, 3867.1878905429894, 3882.7282090253693, 3885.320068987916, 3885.9805700971597, 3904.6876249900224, 6009.218801555813, 6063.302720187191, 6089.147519347295, 6112.144299798032, 6120.693965301762, 5115.462876397999, 5127.5385215330425, 5143.382794064699, 5151.922721159186, 5179.870503237412, 6270.937290627081, 6417.358264173592, 6439.4848412127385, 6524.478041756695, 6528.053432252297, 4240.766757828318, 4266.338717498793, 4270.444842170498, 4298.61312481875, 4317.417148684919, 6735.93264067358, 6846.7945961620735, 6850.93149068508, 6886.793396198122, 6889.586624802528, 4170.928009248947, 4233.343831706091, 4305.246581848227, 4339.587739164775, 4352.586504282088, 4388.385626012361, 4396.758178300224, 4405.889852753707, 4425.203463376559, 4445.51099379068, 5132.178851383761, 5144.922826157611, 5154.793808247703, 5213.504717051874, 5214.713190774544, 6485.4487368573255, 6492.740290388426, 6506.739730410825, 6512.674366281667, 6527.5757075789925, 1537.8000859888143, 1552.8602425781507, 1567.4905655661955, 1570.9293081811345, 1587.9047257164375, 1002.4887307473241, 1006.2955930848435, 1027.409239687183, 1030.9793804123876, 1035.0736091198485, 6184.196054512884, 6204.565680402328, 6229.0967809667345, 6272.843178920472, 6286.0, 6690.297518760557, 6718.932810671929, 6762.729490820312, 6777.593344399352, 6784.2876497967, 6202.72087756052, 6230.750769969241, 6246.063090536456, 6256.311805701369, 6268.27914789805, 3574.91062723434, 3598.5681718193982, 3617.511635929116, 3633.709303255733, 3698.2973235085246, 6964.825879353057, 7030.859382812315, 7056.823579410556, 7059.399951004119, 7145.606991615511, 7003.824904377431, 7010.92989070113, 7081.681324340417, 7086.362227399559, 7089.503734738622, 6855.143107111611, 6994.230634630187, 7062.929370706227, 7082.079329687108, 7091.6454177290925, 6793.218779840184, 6804.21751498584, 6807.149106361705, 6815.69329380189, 6818.795436136924, 6495.123158373559, 6621.635810030494, 6631.6684165792485, 6697.263301036979, 6698.631575263407, 6917.446604271546, 7045.189803172496, 7048.154221493249, 7128.073350464407, 7156.9642151790995, 4349.78251087438, 4413.095315460387, 4416.933745993877, 4418.806922131071, 4462.397576327284, 6783.728650853911, 6792.0830687856505, 6858.657067146523, 6867.656617169022, 6867.690953906987, 6365.363463653783, 6525.477961762953, 6531.673416329259, 6550.017497375432, 6619.702113404812, 6546.639934803631, 6570.244421891543, 6594.967025164843, 6617.7683781067435, 6630.900536492053, 6278.591891527036, 6357.110004599267, 6373.075903993988, 6383.0744542042075, 6440.32376600469, 6489.935100648933, 6523.24982627004, 6535.771248006297, 6554.63949482783, 6635.8009259722285, 6398.936010639834, 6408.0, 6442.09810626522, 6455.289918109098, 6465.3534646536855], "yui.html": [748.6780684305746, 755.090116409726, 761.1323091675491, 774.4733581164808, 777.7861088200744, 13978.930105349471, 14008.159510429381, 14089.859101408983, 14373.137611743303, 14380.280985950687, 12330.5067797288, 13136.146150500212, 13161.40773665185, 13185.934070329658, 13291.667708307297, 693.1335830212234, 874.7550685807984, 883.6951251818112, 893.0845882969975, 893.6380765789866, 707.9327463890947, 825.1088824070019, 875.129246399833, 876.8071024374627, 878.7056336127405, 921.9953900230489, 944.140831843023, 944.8582712593131, 945.7162851144664, 949.9430034197935, 721.07702141259, 724.804302838236, 912.270183852915, 939.0327962198946, 939.9436033837992, 686.7115811359241, 689.3657834792003, 690.2890023276034, 692.1521136607665, 693.2512886083068, 13611.183329000292, 13860.514881979083, 13865.09876858001, 13896.0, 13916.58250252494, 11628.476718547601, 11639.534418623245, 11978.64064078079, 12109.0, 12336.568220112253, 9168.174864262248, 9224.953875230649, 9379.484128373006, 9508.952455237748, 10026.89973100267, 3334.733221342287, 3343.36476069546, 3347.0795531229105, 3384.1032126486502, 3397.0, 47707.52292477065, 47741.52258477406, 47767.522324776655, 47876.0, 47919.76040119812, 8997.370184087182, 9043.231325337289, 9146.085391460934, 9161.862572061424, 9708.029197080377, 12087.395630218454, 12201.45093470796, 12213.267203967791, 12213.328266945404, 12232.266064036186, 6054.926045753423, 6072.878542429126, 6134.693265336716, 6183.598066125687, 6211.9068213976825, 3595.352836489457, 3606.7294952878638, 3644.890653280406, 3668.5047518585184, 3684.244729830378, 2660.2817239345654, 2703.7701795347616, 2704.6619172603423, 2705.932351691184, 2710.756031957094, 404.6661504258998, 406.24438544307566, 409.70091832962106, 410.2779108768529, 410.98356065757633, 504.8409750928519, 555.8999380111538, 573.2833957553058, 613.883362161188, 639.044628280714, 7830.960845195737, 7879.960600196962, 7927.960360198162, 8054.154313797084, 8061.959690201512, 475.5577313098782, 515.2142981952552, 588.0649766870696, 590.439082871274, 622.6015350175891, 3618.8371523281517, 3981.9402708959387, 4063.674906007512, 4084.1423301106506, 4122.958770412318, 54897.725511372984, 54998.45001550013, 55023.72488137534, 55032.724836375564, 55188.72405638026, 46546.767266164126, 46865.76567117142, 46898.76550617225, 47174.292385614244, 47182.292265616044, 41038.38442423366, 41622.791886040985, 42330.15339693189, 42692.57307426948, 42749.0, 8091.312238459797, 8268.710595129141, 8299.751007469786, 8307.681596888837, 8575.228229459379, 34021.149471263416, 34722.479162813084, 34842.0, 35242.64757352394, 35303.470447943815, 41990.37014444847, 44651.88370290769, 45037.32444013277, 45298.32052519149, 45362.77318613386, 7523.924760752541, 7670.156282808775, 7724.304812566896, 7769.611519424119, 7809.297163255334, 11141.665750027512, 11292.604758833402, 11439.428028598702, 11569.421528923689, 12116.939415302868, 10359.378437293786, 10495.842562361418, 10839.132869370274, 10949.069329107115, 11330.093592512414, 10427.478626068818, 10526.631567895087, 10730.302530335503, 10809.837852432063, 11341.092712583139, 6993.335633114846, 9900.356476828983, 10349.689509314732, 10806.243562950518, 11215.66353009411, 8173.713920012771, 8772.473651580925, 8886.351790722545, 9458.668946586837, 9486.635553669865, 8317.168283171635, 9083.0, 9232.122948319899, 9250.537473126182, 9347.626094956398]}, "summary": {"lowerIsBetter": false, "suite": 6684.75172927494, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7989.101019853266, "unit": "ms", "value": 7989.101019853266}, "dojo.html": {"lowerIsBetter": false, "filtered": 5159.348436218816, "unit": "ms", "value": 5159.348436218816}, "mootools.html": {"lowerIsBetter": false, "filtered": 4330.682287355761, "unit": "ms", "value": 4330.682287355761}, "ext.html": {"lowerIsBetter": false, "filtered": 17617.836028164405, "unit": "ms", "value": 17617.836028164405}, "prototype.html": {"lowerIsBetter": false, "filtered": 4839.000171070223, "unit": "ms", "value": 4839.000171070223}, "yui.html": {"lowerIsBetter": false, "filtered": 5862.9598601528, "unit": "ms", "value": 5862.9598601528}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0043"}, "testrun": {"date": 1447379885, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112165437", "branch": "Fx-Team", "revision": "0c648a1efbe06b5ec866ba058d18256b80808b46"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 160.0, 162.0, 163.0, 162.0, 162.0, 161.0, 162.0, 163.0, 160.0], "ai-astar": [108.0, 107.0, 102.0, 108.0, 108.0, 109.0, 106.0, 106.0, 99.0, 106.0], "imaging-gaussian-blur": [119.0, 120.0, 114.0, 119.0, 120.0, 115.0, 115.0, 114.0, 115.0, 120.0], "audio-beat-detection": [156.0, 134.0, 150.0, 160.0, 129.0, 151.0, 146.0, 124.0, 161.0, 126.0], "json-stringify-tinderbox": [67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [145.0, 145.0, 153.0, 156.0, 155.0, 144.0, 156.0, 154.0, 155.0, 142.0], "json-parse-financial": [58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 58.0, 66.0, 57.0, 57.0], "stanford-crypto-sha256-iterative": [71.0, 73.0, 72.0, 70.0, 72.0, 71.0, 71.0, 70.0, 73.0, 71.0], "audio-fft": [74.0, 82.0, 87.0, 86.0, 68.0, 71.0, 70.0, 78.0, 82.0, 65.0], "imaging-darkroom": [125.0, 126.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0], "stanford-crypto-ccm": [124.0, 132.0, 124.0, 123.0, 128.0, 134.0, 123.0, 124.0, 134.0, 134.0], "audio-oscillator": [97.0, 101.0, 135.0, 87.0, 89.0, 89.0, 123.0, 87.0, 88.0, 127.0], "stanford-crypto-aes": [85.0, 85.0, 85.0, 86.0, 85.0, 84.0, 86.0, 84.0, 86.0, 85.0], "imaging-desaturate": [94.0, 94.0, 101.0, 94.0, 93.0, 93.0, 101.0, 94.0, 93.0, 101.0]}, "summary": {"lowerIsBetter": true, "suite": 1489.1000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.3, "unit": "ms", "value": 76.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 150.5, "unit": "ms", "value": 150.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.7, "unit": "ms", "value": 143.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 128.0, "unit": "ms", "value": 128.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 125.1, "unit": "ms", "value": 125.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.5, "unit": "ms", "value": 58.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.3, "unit": "ms", "value": 102.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 105.9, "unit": "ms", "value": 105.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.5, "unit": "ms", "value": 161.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.4, "unit": "ms", "value": 71.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.9, "unit": "ms", "value": 67.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 117.1, "unit": "ms", "value": 117.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.1, "unit": "ms", "value": 85.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.8, "unit": "ms", "value": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0043"}, "testrun": {"date": 1447379885, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112165437", "branch": "Fx-Team", "revision": "0c648a1efbe06b5ec866ba058d18256b80808b46"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.76688286913392], "Encrypt": [326.1578604044357], "NavierStokes": [5813.953488372093], "Decrypt": [5770.114942528736], "Splay": [694.9270326615705], "Richards": [168.49199663016006], "RegExp": [30323.529411764706], "Earley": [916.5902841429881], "Boyer": [12612.5], "RayTrace": [1901.1406844106464]}, "summary": {"lowerIsBetter": false, "suite": 18130.787091608152, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 346.59055600000005, "unit": "score", "value": 346.59055600000005}, "Encrypt": {"lowerIsBetter": false, "filtered": 816.1109459999999, "unit": "score", "value": 816.1109459999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.24799999999982, "unit": "score", "value": 255.24799999999982}, "Decrypt": {"lowerIsBetter": false, "filtered": 46.130970119521876, "unit": "score", "value": 46.130970119521876}, "Splay": {"lowerIsBetter": false, "filtered": 117.26554899999996, "unit": "score", "value": 117.26554899999996}, "RegExp": {"lowerIsBetter": false, "filtered": 30.042182347235716, "unit": "score", "value": 30.042182347235716}, "Richards": {"lowerIsBetter": false, "filtered": 209.51736999999997, "unit": "score", "value": 209.51736999999997}, "Earley": {"lowerIsBetter": false, "filtered": 727.111133, "unit": "score", "value": 727.111133}, "Boyer": {"lowerIsBetter": false, "filtered": 52.84146679881068, "unit": "score", "value": 52.84146679881068}, "RayTrace": {"lowerIsBetter": false, "filtered": 389.23421400000007, "unit": "score", "value": 389.23421400000007}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0043"}, "testrun": {"date": 1447379885, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112165437", "branch": "Fx-Team", "revision": "0c648a1efbe06b5ec866ba058d18256b80808b46"}}] 18:18:15 INFO - RETURN: dromaeo_css: 6684.75 18:18:15 INFO - RETURN: kraken: 1489.10 18:18:15 INFO - RETURN: v8_7: 18130.79 18:18:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "18130.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1489.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6684.75"}}} 18:18:15 INFO - Return code: 0 18:18:15 INFO - # TBPL SUCCESS # 18:18:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:18:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:18:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:18:15 INFO - 2015-11-12 18:18:15.795 screenresolution[1661:9955] starting screenresolution argv=screenresolution get 18:18:15 INFO - 2015-11-12 18:18:15.798 screenresolution[1661:9955] Display 0: 1600x1200x32@60 18:18:15 INFO - 2015-11-12 18:18:15.805 screenresolution[1662:9959] starting screenresolution argv=screenresolution list 18:18:15 INFO - Available Modes on Display 0 18:18:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:18:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:18:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:18:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:18:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:18:16 INFO - Intel HD Graphics 3000: 18:18:16 INFO - Chipset Model: Intel HD Graphics 3000 18:18:16 INFO - Type: GPU 18:18:16 INFO - Bus: Built-In 18:18:16 INFO - VRAM (Total): 512 MB 18:18:16 INFO - VRAM (Dynamic, Max): 10 18:18:16 INFO - Vendor: Intel (0x8086) 18:18:16 INFO - Device ID: 0x0116 18:18:16 INFO - Revision ID: 0x0009 18:18:16 INFO - Displays: 18:18:16 INFO - Display: 18:18:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:18:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:18:16 INFO - Display Serial Number: 1600x1200 60 18:18:16 INFO - Main Display: Yes 18:18:16 INFO - Mirror: Off 18:18:16 INFO - Online: Yes 18:18:16 INFO - Rotation: Supported 18:18:16 INFO - Return code: 0 18:18:16 INFO - Running post-action listener: _resource_record_post_action 18:18:16 INFO - Running post-run listener: _resource_record_post_run 18:18:17 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 40895488; Write bytes: 688984064; Read time: 5237; Write time: 48203 18:18:17 INFO - install - Wall time: 36s; CPU: 30.0%; Read bytes: 340939264; Write bytes: 338694144; Read time: 31894; Write time: 6171 18:18:17 INFO - run-tests - Wall time: 1211s; CPU: 30.0%; Read bytes: 38786048; Write bytes: 339771392; Read time: 4836; Write time: 41094 18:18:17 INFO - Running post-run listener: _upload_blobber_files 18:18:17 INFO - Blob upload gear active. 18:18:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:18:17 INFO - Copying logs to upload dir... 18:18:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1299.209094 ========= master_lag: 2.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2015-11-12 18:18:19.223799) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 18:18:19.228086) ========= 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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010012 build_url: 'https://queue.taskcluster.net/v1/task/p9nuBOU7Q-SwNQoMrhF49w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.42 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 18:18:19.657404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-11-12 18:18:19.657757) ========= 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.WLiaC2FvsY/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.ZTrbHi5ddU/Listeners TMPDIR=/var/folders/sd/xq4mgmnd085bnsl_k5_qzxk400000w/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.005436 ========= master_lag: 4.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-11-12 18:18:23.823254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 18:18:23.823562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 18:18:23.889759) ========= ========= Total master_lag: 6.77 =========