builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0076 starttime: 1447443713.37 results: success (0) buildid: 20151113104729 builduid: 9271d6fcc6c2464cb3ccd34a0f2afdab revision: 186e5680b95a38845fe8fa7fa59656a6de0b496e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.373578) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.376841) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.377223) ========= 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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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.006864 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.419785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.420161) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.440080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.440467) ========= 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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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.005772 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.490970) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.491335) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.492785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.493123) ========= 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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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-13 11:41:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-11-13 11:41:53 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.681827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.682246) ========= 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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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.023659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:53.737162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 11:41:53.738219) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 186e5680b95a38845fe8fa7fa59656a6de0b496e --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 186e5680b95a38845fe8fa7fa59656a6de0b496e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.De2uOnyp1O/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.DCW1DWPG9Z/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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-13 11:41:53,835 truncating revision to first 12 chars 2015-11-13 11:41:53,835 Setting DEBUG logging. 2015-11-13 11:41:53,836 attempt 1/10 2015-11-13 11:41:53,836 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/186e5680b95a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 11:41:55,096 unpacking tar archive at: fx-team-186e5680b95a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.559299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 11:41:55.318598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:55.318988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:55.335442) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:55.335906) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 11:41:55.336460) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2015-11-13 11:41:55.336846) ========= /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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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 11:41:55 INFO - MultiFileLogger online at 20151113 11:41:55 in /builds/slave/test 11:41:55 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 11:41:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:41:55 INFO - {'append_to_log': False, 11:41:55 INFO - 'base_work_dir': '/builds/slave/test', 11:41:55 INFO - 'blob_upload_branch': 'Fx-Team', 11:41:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:41:55 INFO - 'branch': 'Fx-Team', 11:41:55 INFO - 'buildbot_json_path': 'buildprops.json', 11:41:55 INFO - 'config_files': ('talos/mac_config.py',), 11:41:55 INFO - 'default_actions': ('clobber', 11:41:55 INFO - 'read-buildbot-config', 11:41:55 INFO - 'download-and-extract', 11:41:55 INFO - 'populate-webroot', 11:41:55 INFO - 'create-virtualenv', 11:41:55 INFO - 'install', 11:41:55 INFO - 'run-tests'), 11:41:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:41:55 INFO - 'download_minidump_stackwalk': True, 11:41:55 INFO - 'download_symbols': 'ondemand', 11:41:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:41:55 INFO - 'tooltool.py': '/tools/tooltool.py', 11:41:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:41:55 INFO - '/tools/misc-python/virtualenv.py')}, 11:41:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:41:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:41:55 INFO - 'installer_path': 'installer.exe', 11:41:55 INFO - 'log_level': 'info', 11:41:55 INFO - 'log_name': 'talos', 11:41:55 INFO - 'log_to_console': True, 11:41:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:41:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:41:55 INFO - 'opt_config_files': (), 11:41:55 INFO - 'pip_index': False, 11:41:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:55 INFO - 'cmd': ('bash', 11:41:55 INFO - '-c', 11:41:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:55 INFO - 'enabled': True, 11:41:55 INFO - 'halt_on_failure': False, 11:41:55 INFO - 'name': 'check_screen_resolution'},), 11:41:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:55 INFO - 'cmd': ('bash', 11:41:55 INFO - '-c', 11:41:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:55 INFO - 'enabled': True, 11:41:55 INFO - 'halt_on_failure': False, 11:41:55 INFO - 'name': 'check_screen_resolution'},), 11:41:55 INFO - 'run_cmd_checks_enabled': True, 11:41:55 INFO - 'sps_profile': False, 11:41:55 INFO - 'sps_profile_interval': 0, 11:41:55 INFO - 'suite': 'dromaeojs', 11:41:55 INFO - 'system_bits': '64', 11:41:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:41:55 INFO - 'title': 't-yosemite-r5-0076', 11:41:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:41:55 INFO - 'use_talos_json': True, 11:41:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:41:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:41:55 INFO - 'work_dir': 'build'} 11:41:55 INFO - ##### 11:41:55 INFO - ##### Running clobber step. 11:41:55 INFO - ##### 11:41:55 INFO - Running pre-action listener: _resource_record_pre_action 11:41:55 INFO - Running main action method: clobber 11:41:55 INFO - rmtree: /builds/slave/test/build 11:41:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:41:58 INFO - Running post-action listener: _resource_record_post_action 11:41:58 INFO - ##### 11:41:58 INFO - ##### Running read-buildbot-config step. 11:41:58 INFO - ##### 11:41:58 INFO - Running pre-action listener: _resource_record_pre_action 11:41:58 INFO - Running main action method: read_buildbot_config 11:41:58 INFO - Using buildbot properties: 11:41:58 INFO - { 11:41:58 INFO - "properties": { 11:41:58 INFO - "buildnumber": 1228, 11:41:58 INFO - "product": "firefox", 11:41:58 INFO - "script_repo_revision": "production", 11:41:58 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 11:41:58 INFO - "repository": "", 11:41:58 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 11:41:58 INFO - "buildid": "20151113104729", 11:41:58 INFO - "slavename": "t-yosemite-r5-0076", 11:41:58 INFO - "pgo_build": "False", 11:41:58 INFO - "basedir": "/builds/slave/test", 11:41:58 INFO - "project": "", 11:41:58 INFO - "platform": "yosemite", 11:41:58 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:41:58 INFO - "slavebuilddir": "test", 11:41:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:41:58 INFO - "branch": "fx-team", 11:41:58 INFO - "repo_path": "integration/fx-team", 11:41:58 INFO - "stage_platform": "macosx64", 11:41:58 INFO - "builduid": "9271d6fcc6c2464cb3ccd34a0f2afdab", 11:41:58 INFO - "revision": "186e5680b95a38845fe8fa7fa59656a6de0b496e" 11:41:58 INFO - }, 11:41:58 INFO - "sourcestamp": { 11:41:58 INFO - "repository": "", 11:41:58 INFO - "hasPatch": false, 11:41:58 INFO - "project": "", 11:41:58 INFO - "branch": "fx-team-macosx64-talos", 11:41:58 INFO - "changes": [ 11:41:58 INFO - { 11:41:58 INFO - "category": null, 11:41:58 INFO - "files": [ 11:41:58 INFO - { 11:41:58 INFO - "url": null, 11:41:58 INFO - "name": "https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:41:58 INFO - } 11:41:58 INFO - ], 11:41:58 INFO - "repository": "", 11:41:58 INFO - "rev": "186e5680b95a38845fe8fa7fa59656a6de0b496e", 11:41:58 INFO - "who": "ryanvm@gmail.com", 11:41:58 INFO - "when": 1447443182, 11:41:58 INFO - "number": 6659936, 11:41:58 INFO - "comments": "Bug 1224644 - Update pdf.js to version 1.2.109. r=bdahl", 11:41:58 INFO - "project": "", 11:41:58 INFO - "at": "Fri 13 Nov 2015 11:33:02", 11:41:58 INFO - "branch": "fx-team-macosx64-talos", 11:41:58 INFO - "revlink": "", 11:41:58 INFO - "properties": [ 11:41:58 INFO - [ 11:41:58 INFO - "buildid", 11:41:58 INFO - "20151113104729", 11:41:58 INFO - "Change" 11:41:58 INFO - ], 11:41:58 INFO - [ 11:41:58 INFO - "builduid", 11:41:58 INFO - "9271d6fcc6c2464cb3ccd34a0f2afdab", 11:41:58 INFO - "Change" 11:41:58 INFO - ], 11:41:58 INFO - [ 11:41:58 INFO - "pgo_build", 11:41:58 INFO - "False", 11:41:58 INFO - "Change" 11:41:58 INFO - ] 11:41:58 INFO - ], 11:41:58 INFO - "revision": "186e5680b95a38845fe8fa7fa59656a6de0b496e" 11:41:58 INFO - } 11:41:58 INFO - ], 11:41:58 INFO - "revision": "186e5680b95a38845fe8fa7fa59656a6de0b496e" 11:41:58 INFO - } 11:41:58 INFO - } 11:41:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:41:58 INFO - Running post-action listener: _resource_record_post_action 11:41:58 INFO - ##### 11:41:58 INFO - ##### Running download-and-extract step. 11:41:58 INFO - ##### 11:41:58 INFO - Running pre-action listener: _resource_record_pre_action 11:41:58 INFO - Running main action method: download_and_extract 11:41:58 INFO - mkdir: /builds/slave/test/build/tests 11:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:58 INFO - https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:41:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/test_packages.json 11:41:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/test_packages.json 11:41:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:41:59 INFO - Downloaded 1149 bytes. 11:41:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:41:59 INFO - Using the following test package requirements: 11:41:59 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:41:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:41:59 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:41:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:41:59 INFO - u'jsshell-mac.zip'], 11:41:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:41:59 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:41:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:41:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:41:59 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:41:59 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:41:59 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:41:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:41:59 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:41:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:41:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:41:59 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:41:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:59 INFO - https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/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 11:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/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 11:42:00 INFO - Downloaded 17460578 bytes. 11:42:00 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 11:42:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:42:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:42:06 INFO - Return code: 0 11:42:06 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 11:42:06 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')]} 11:42:06 INFO - https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:42:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:42:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:42:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/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 11:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/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 11:42:07 INFO - Downloaded 17460578 bytes. 11:42:07 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 11:42:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:42:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:42:13 INFO - Return code: 0 11:42: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')]} 11:42:13 INFO - https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:42:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:42:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:42:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/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 11:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/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 11:42:14 INFO - Downloaded 11131693 bytes. 11:42:14 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 11:42:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:42:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:42:14 INFO - Return code: 0 11:42:14 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')]} 11:42:14 INFO - https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:42:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:42:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:42:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/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 11:42:18 INFO - Downloaded 108694693 bytes. 11:42:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:42:18 INFO - mkdir: /builds/slave/test/properties 11:42:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:18 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:18 INFO - Contents: 11:42:18 INFO - build_url:https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:42:18 INFO - Running post-action listener: _resource_record_post_action 11:42:18 INFO - Running post-action listener: set_extra_try_arguments 11:42:18 INFO - ##### 11:42:18 INFO - ##### Running populate-webroot step. 11:42:18 INFO - ##### 11:42:18 INFO - Running pre-action listener: _resource_record_pre_action 11:42:18 INFO - Running main action method: populate_webroot 11:42:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:42:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:42:18 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:42:18 INFO - '../fennec_ids.txt'], 11:42:18 INFO - 'tests': ['tcheck2']}, 11:42:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:42:18 INFO - '--tppagecycles', 11:42:18 INFO - '7'], 11:42:18 INFO - 'tests': ['tsvgm']}}, 11:42:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:42:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:42:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:42:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:42:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'tests': ['damp', 'tps']}, 11:42:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['damp', 'tps']}, 11:42:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:42:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:18 INFO - 'other': {'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore']}, 11:42:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore']}, 11:42:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore']}, 11:42:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore']}, 11:42:18 INFO - 'other_l64': {'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore']}, 11:42:18 INFO - 'other_nol64': {'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore']}, 11:42:18 INFO - 'svgr': {'tests': ['tsvgx', 11:42:18 INFO - 'tsvgr_opacity', 11:42:18 INFO - 'tart', 11:42:18 INFO - 'tscrollx', 11:42:18 INFO - 'cart']}, 11:42:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['tsvgx', 11:42:18 INFO - 'tsvgr_opacity', 11:42:18 INFO - 'tart', 11:42:18 INFO - 'tscrollx', 11:42:18 INFO - 'cart']}, 11:42:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'tests': ['tp5o']}, 11:42:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['tp5o']}, 11:42:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--xperf_path', 11:42:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:18 INFO - 'tests': ['tp5n']}, 11:42:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--e10s', 11:42:18 INFO - '--xperf_path', 11:42:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:18 INFO - 'tests': ['tp5n']}}, 11:42:18 INFO - 'talos.zip': {'path': '', 11:42:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:42:18 INFO - Running post-action listener: _resource_record_post_action 11:42:18 INFO - ##### 11:42:18 INFO - ##### Running create-virtualenv step. 11:42:18 INFO - ##### 11:42:18 INFO - Running pre-action listener: _resource_record_pre_action 11:42:18 INFO - Running main action method: create_virtualenv 11:42:18 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:18 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 11:42:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:42:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:18 INFO - Using real prefix '/tools/python27' 11:42:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:25 INFO - Installing pip.................done. 11:42:25 INFO - Return code: 0 11:42:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:25 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 0x1022e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38b4d27f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022059f0>, '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 0x101f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021f98c8>, '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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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 11:42:25 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 11:42:25 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 11:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.De2uOnyp1O/Render', 11:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:25 INFO - 'HOME': '/Users/cltbld', 11:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:25 INFO - 'LOGNAME': 'cltbld', 11:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:25 INFO - 'MOZ_NO_REMOTE': '1', 11:42:25 INFO - 'NO_EM_RESTART': '1', 11:42:25 INFO - 'PAGER': '/bin/cat', 11:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:25 INFO - 'PWD': '/builds/slave/test', 11:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:25 INFO - 'SHELL': '/bin/bash', 11:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1DWPG9Z/Listeners', 11:42:25 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 11:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:25 INFO - 'USER': 'cltbld', 11:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:25 INFO - 'XPC_FLAGS': '0x0', 11:42:25 INFO - 'XPC_SERVICE_NAME': '0', 11:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:25 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 11:42:25 INFO - Cleaning up... 11:42:25 INFO - Return code: 0 11:42:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:25 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 0x1022e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38b4d27f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022059f0>, '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 0x101f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021f98c8>, '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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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 11:42:25 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 11:42:25 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 11:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.De2uOnyp1O/Render', 11:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:25 INFO - 'HOME': '/Users/cltbld', 11:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:25 INFO - 'LOGNAME': 'cltbld', 11:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:25 INFO - 'MOZ_NO_REMOTE': '1', 11:42:25 INFO - 'NO_EM_RESTART': '1', 11:42:25 INFO - 'PAGER': '/bin/cat', 11:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:25 INFO - 'PWD': '/builds/slave/test', 11:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:25 INFO - 'SHELL': '/bin/bash', 11:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1DWPG9Z/Listeners', 11:42:25 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 11:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:25 INFO - 'USER': 'cltbld', 11:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:25 INFO - 'XPC_FLAGS': '0x0', 11:42:25 INFO - 'XPC_SERVICE_NAME': '0', 11:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:26 INFO - Downloading/unpacking psutil>=0.7.1 11:42:26 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 11:42:26 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 11:42:26 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 11:42:26 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 11:42:26 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 11:42:26 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 11:42:27 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:42:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:27 INFO - Installing collected packages: psutil 11:42:27 INFO - Running setup.py install for psutil 11:42:27 INFO - building 'psutil._psutil_osx' extension 11:42:27 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 11:42:28 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 11:42:28 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 11:42:28 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 11:42:28 INFO - building 'psutil._psutil_posix' extension 11:42:28 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 11:42:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:42:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:42:28 INFO - ^ 11:42:28 INFO - 1 warning generated. 11:42:28 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 11:42:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:28 INFO - Successfully installed psutil 11:42:28 INFO - Cleaning up... 11:42:29 INFO - Return code: 0 11:42:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1022e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38b4d27f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022059f0>, '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 0x101f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021f98c8>, '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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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 11:42:29 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 11:42:29 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 11:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.De2uOnyp1O/Render', 11:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:29 INFO - 'HOME': '/Users/cltbld', 11:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:29 INFO - 'LOGNAME': 'cltbld', 11:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:29 INFO - 'MOZ_NO_REMOTE': '1', 11:42:29 INFO - 'NO_EM_RESTART': '1', 11:42:29 INFO - 'PAGER': '/bin/cat', 11:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:29 INFO - 'PWD': '/builds/slave/test', 11:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:29 INFO - 'SHELL': '/bin/bash', 11:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1DWPG9Z/Listeners', 11:42:29 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 11:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:29 INFO - 'USER': 'cltbld', 11:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:29 INFO - 'XPC_FLAGS': '0x0', 11:42:29 INFO - 'XPC_SERVICE_NAME': '0', 11:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:42:29 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 11:42:29 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 11:42:29 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 11:42:29 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 11:42:29 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 11:42:29 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 11:42:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:42:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:42:32 INFO - Installing collected packages: mozsystemmonitor 11:42:32 INFO - Running setup.py install for mozsystemmonitor 11:42:32 INFO - Successfully installed mozsystemmonitor 11:42:32 INFO - Cleaning up... 11:42:32 INFO - Return code: 0 11:42:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42:32 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')]} 11:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:32 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')]} 11:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:32 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 0x1022e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38b4d27f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022059f0>, '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 0x101f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021f98c8>, '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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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 11:42:32 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 11:42:32 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 11:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.De2uOnyp1O/Render', 11:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:32 INFO - 'HOME': '/Users/cltbld', 11:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:32 INFO - 'LOGNAME': 'cltbld', 11:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:32 INFO - 'MOZ_NO_REMOTE': '1', 11:42:32 INFO - 'NO_EM_RESTART': '1', 11:42:32 INFO - 'PAGER': '/bin/cat', 11:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:32 INFO - 'PWD': '/builds/slave/test', 11:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:32 INFO - 'SHELL': '/bin/bash', 11:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1DWPG9Z/Listeners', 11:42:32 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 11:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:32 INFO - 'USER': 'cltbld', 11:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:32 INFO - 'XPC_FLAGS': '0x0', 11:42:32 INFO - 'XPC_SERVICE_NAME': '0', 11:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:33 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:35 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:36 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 11:42:36 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 11:42:36 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 11:42:36 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 11:42:36 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 11:42:36 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 11:42:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42:36 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 11:42:36 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 11:42:36 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 11:42:36 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 11:42:36 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 11:42:36 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 11:42:37 INFO - Downloading docopt-0.6.1.tar.gz 11:42:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:37 INFO - Running setup.py install for blobuploader 11:42:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:37 INFO - Running setup.py install for requests 11:42:38 INFO - Running setup.py install for docopt 11:42:38 INFO - Successfully installed blobuploader requests docopt 11:42:38 INFO - Cleaning up... 11:42:38 INFO - Return code: 0 11:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:38 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 0x1022e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38b4d27f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022059f0>, '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 0x101f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021f98c8>, '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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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 11:42:38 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 11:42:38 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 11:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.De2uOnyp1O/Render', 11:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:38 INFO - 'HOME': '/Users/cltbld', 11:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:38 INFO - 'LOGNAME': 'cltbld', 11:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:38 INFO - 'MOZ_NO_REMOTE': '1', 11:42:38 INFO - 'NO_EM_RESTART': '1', 11:42:38 INFO - 'PAGER': '/bin/cat', 11:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:38 INFO - 'PWD': '/builds/slave/test', 11:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:38 INFO - 'SHELL': '/bin/bash', 11:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1DWPG9Z/Listeners', 11:42:38 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 11:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:38 INFO - 'USER': 'cltbld', 11:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:38 INFO - 'XPC_FLAGS': '0x0', 11:42:38 INFO - 'XPC_SERVICE_NAME': '0', 11:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:39 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-nvV6DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:39 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-LOg7v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:39 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-qjKw06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:39 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-9u6vFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:39 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-HYapwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:39 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-oIYXNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:40 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-LGZIk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:40 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-_R0Yxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:40 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-TzQ0Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:40 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-q_Jdmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:40 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-KIMq0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:40 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-WlGeXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:40 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-8Cp0zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:41 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-U3uoaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:41 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-Yof_14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:41 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-WVgx3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:41 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-_rE80J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:41 INFO - Running setup.py install for manifestparser 11:42:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:41 INFO - Running setup.py install for mozcrash 11:42:42 INFO - Running setup.py install for mozdebug 11:42:42 INFO - Running setup.py install for mozdevice 11:42:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:42:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:42 INFO - Running setup.py install for mozfile 11:42:42 INFO - Running setup.py install for mozhttpd 11:42:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:42 INFO - Running setup.py install for mozinfo 11:42:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:43 INFO - Running setup.py install for mozInstall 11:42:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:43 INFO - Running setup.py install for mozleak 11:42:43 INFO - Running setup.py install for mozlog 11:42:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:43 INFO - Running setup.py install for moznetwork 11:42:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:43 INFO - Running setup.py install for mozprocess 11:42:44 INFO - Running setup.py install for mozprofile 11:42:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:44 INFO - Running setup.py install for mozrunner 11:42:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:44 INFO - Running setup.py install for mozscreenshot 11:42:44 INFO - Running setup.py install for moztest 11:42:44 INFO - Running setup.py install for mozversion 11:42:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:45 INFO - Cleaning up... 11:42:45 INFO - Return code: 0 11:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:45 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')]} 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:45 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')]} 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:45 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 0x1022e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38b4d27f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022059f0>, '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 0x101f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021f98c8>, '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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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 11:42:45 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 11:42:45 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 11:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.De2uOnyp1O/Render', 11:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:45 INFO - 'HOME': '/Users/cltbld', 11:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:45 INFO - 'LOGNAME': 'cltbld', 11:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:45 INFO - 'MOZ_NO_REMOTE': '1', 11:42:45 INFO - 'NO_EM_RESTART': '1', 11:42:45 INFO - 'PAGER': '/bin/cat', 11:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:45 INFO - 'PWD': '/builds/slave/test', 11:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:45 INFO - 'SHELL': '/bin/bash', 11:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1DWPG9Z/Listeners', 11:42:45 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 11:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:45 INFO - 'USER': 'cltbld', 11:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:45 INFO - 'XPC_FLAGS': '0x0', 11:42:45 INFO - 'XPC_SERVICE_NAME': '0', 11:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:45 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-8LRKOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:45 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)) 11:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:45 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-f3EGV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:45 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)) 11:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:45 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-HIO6MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:46 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)) 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:46 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-RrYh2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:46 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)) 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:46 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-KmJ5uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:46 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)) 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:46 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-ZkbgkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:46 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)) 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:46 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-dAX0ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:46 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)) 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:46 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-nyyikA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:46 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)) 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:46 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-Umb4sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:46 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)) 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:46 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-9CDQQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:47 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)) 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:47 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-r3jnpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:47 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)) 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:47 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-kq9fP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:47 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)) 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:47 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-E3GzFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:47 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)) 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:47 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-hPoFwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:47 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)) 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:47 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-BjwjHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:47 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)) 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:47 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-aB9pdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:48 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)) 11:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:48 INFO - Running setup.py (path:/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/pip-pCN_4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:48 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)) 11:42:48 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)) 11:42:48 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)) 11:42:48 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)) 11:42:48 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)) 11:42:48 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)) 11:42:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:51 INFO - Downloading blessings-1.5.1.tar.gz 11:42:51 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 11:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:51 INFO - Installing collected packages: blessings 11:42:51 INFO - Running setup.py install for blessings 11:42:51 INFO - Successfully installed blessings 11:42:51 INFO - Cleaning up... 11:42:51 INFO - Return code: 0 11:42:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:52 INFO - Reading from file tmpfile_stdout 11:42:52 INFO - Current package versions: 11:42:52 INFO - blessings == 1.5.1 11:42:52 INFO - blobuploader == 1.2.4 11:42:52 INFO - docopt == 0.6.1 11:42:52 INFO - manifestparser == 1.1 11:42:52 INFO - mozInstall == 1.12 11:42:52 INFO - mozcrash == 0.16 11:42:52 INFO - mozdebug == 0.1 11:42:52 INFO - mozdevice == 0.47 11:42:52 INFO - mozfile == 1.2 11:42:52 INFO - mozhttpd == 0.7 11:42:52 INFO - mozinfo == 0.9 11:42:52 INFO - mozleak == 0.1 11:42:52 INFO - mozlog == 3.0 11:42:52 INFO - moznetwork == 0.27 11:42:52 INFO - mozprocess == 0.22 11:42:52 INFO - mozprofile == 0.27 11:42:52 INFO - mozrunner == 6.11 11:42:52 INFO - mozscreenshot == 0.1 11:42:52 INFO - mozsystemmonitor == 0.0 11:42:52 INFO - moztest == 0.7 11:42:52 INFO - mozversion == 1.4 11:42:52 INFO - psutil == 3.1.1 11:42:52 INFO - requests == 1.2.3 11:42:52 INFO - wsgiref == 0.1.2 11:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:52 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')]} 11:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:52 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')]} 11:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:52 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 0x1022e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38b4d27f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022059f0>, '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 0x101f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021f98c8>, '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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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 11:42:52 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 11:42:52 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 11:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.De2uOnyp1O/Render', 11:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:52 INFO - 'HOME': '/Users/cltbld', 11:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:52 INFO - 'LOGNAME': 'cltbld', 11:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:52 INFO - 'MOZ_NO_REMOTE': '1', 11:42:52 INFO - 'NO_EM_RESTART': '1', 11:42:52 INFO - 'PAGER': '/bin/cat', 11:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:52 INFO - 'PWD': '/builds/slave/test', 11:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:52 INFO - 'SHELL': '/bin/bash', 11:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1DWPG9Z/Listeners', 11:42:52 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 11:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:52 INFO - 'USER': 'cltbld', 11:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:52 INFO - 'XPC_FLAGS': '0x0', 11:42:52 INFO - 'XPC_SERVICE_NAME': '0', 11:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 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)) 11:42:52 INFO - Cleaning up... 11:42:52 INFO - Return code: 0 11:42:52 INFO - Running post-action listener: _resource_record_post_action 11:42:52 INFO - Running post-action listener: _start_resource_monitoring 11:42:52 INFO - Starting resource monitoring. 11:42:52 INFO - ##### 11:42:52 INFO - ##### Running install step. 11:42:52 INFO - ##### 11:42:52 INFO - Running pre-action listener: _resource_record_pre_action 11:42:52 INFO - Running main action method: install 11:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:52 INFO - Reading from file tmpfile_stdout 11:42:52 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:52 INFO - Reading from file tmpfile_stdout 11:42:52 INFO - Output received: 11:42:52 INFO - Usage: mozinstall [options] installer 11:42:52 INFO - Options: 11:42:52 INFO - -h, --help show this help message and exit 11:42:52 INFO - -d DEST, --destination=DEST 11:42:52 INFO - Directory to install application into. [default: 11:42:52 INFO - "/builds/slave/test"] 11:42:52 INFO - --app=APP Application being installed. [default: firefox] 11:42:52 INFO - mkdir: /builds/slave/test/build/application 11:42:52 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'] 11:42:52 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 11:43:37 INFO - Reading from file tmpfile_stdout 11:43:37 INFO - Output received: 11:43:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:43:37 INFO - Running post-action listener: _resource_record_post_action 11:43:37 INFO - ##### 11:43:37 INFO - ##### Running run-tests step. 11:43:37 INFO - ##### 11:43:37 INFO - Running pre-action listener: _resource_record_pre_action 11:43:37 INFO - Running main action method: run_tests 11:43:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:43:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:43:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:43:37 INFO - 2015-11-13 11:43:37.991 screenresolution[1949:67243] starting screenresolution argv=screenresolution get 11:43:37 INFO - 2015-11-13 11:43:37.995 screenresolution[1949:67243] Display 0: 1600x1200x32@60 11:43:38 INFO - 2015-11-13 11:43:38.002 screenresolution[1950:67245] starting screenresolution argv=screenresolution list 11:43:38 INFO - Available Modes on Display 0 11:43:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:43:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:43:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:43:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:43:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:43:38 INFO - Intel HD Graphics 3000: 11:43:38 INFO - Chipset Model: Intel HD Graphics 3000 11:43:38 INFO - Type: GPU 11:43:38 INFO - Bus: Built-In 11:43:38 INFO - VRAM (Total): 512 MB 11:43:38 INFO - VRAM (Dynamic, Max): 10 11:43:38 INFO - Vendor: Intel (0x8086) 11:43:38 INFO - Device ID: 0x0116 11:43:38 INFO - Revision ID: 0x0009 11:43:38 INFO - Displays: 11:43:38 INFO - Display: 11:43:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:43:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:43:38 INFO - Display Serial Number: 1600x1200 60 11:43:38 INFO - Main Display: Yes 11:43:38 INFO - Mirror: Off 11:43:38 INFO - Online: Yes 11:43:38 INFO - Rotation: Supported 11:43:38 INFO - Return code: 0 11:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:43:38 INFO - Python 2.7.3 11:43:38 INFO - Return code: 0 11:43:38 INFO - grabbing minidump binary from tooltool 11:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:38 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 0x1022059f0>, '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 0x101f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021f98c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:43:38 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 11:43:38 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 11:43:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:38 INFO - Return code: 0 11:43:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:43:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:43:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:43:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:43:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:43:38 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/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0076', '--webServer', 'localhost'] in /builds/slave/test/build 11:43:38 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/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0076 --webServer localhost 11:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.De2uOnyp1O/Render', 11:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:38 INFO - 'HOME': '/Users/cltbld', 11:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:38 INFO - 'LOGNAME': 'cltbld', 11:43:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:38 INFO - 'MOZ_NO_REMOTE': '1', 11:43:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:38 INFO - 'NO_EM_RESTART': '1', 11:43:38 INFO - 'PAGER': '/bin/cat', 11:43:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:38 INFO - 'PWD': '/builds/slave/test', 11:43:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:38 INFO - 'SHELL': '/bin/bash', 11:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1DWPG9Z/Listeners', 11:43:38 INFO - 'TMPDIR': '/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/', 11:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:38 INFO - 'USER': 'cltbld', 11:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:38 INFO - 'XPC_FLAGS': '0x0', 11:43:38 INFO - 'XPC_SERVICE_NAME': '0', 11:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:43:38 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/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0076', '--webServer', 'localhost'] with output_timeout 3600 11:43:38 INFO - mozversion INFO | application_buildid: 20151113104729 11:43:38 INFO - mozversion INFO | application_changeset: 186e5680b95a38845fe8fa7fa59656a6de0b496e 11:43:38 INFO - mozversion INFO | application_display_name: Nightly 11:43:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:38 INFO - mozversion INFO | application_name: Firefox 11:43:38 INFO - mozversion INFO | application_remotingname: firefox 11:43:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:43:38 INFO - mozversion INFO | application_vendor: Mozilla 11:43:38 INFO - mozversion INFO | application_version: 45.0a1 11:43:38 INFO - mozversion INFO | platform_buildid: 20151113104729 11:43:38 INFO - mozversion INFO | platform_changeset: 186e5680b95a38845fe8fa7fa59656a6de0b496e 11:43:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:43:38 INFO - mozversion INFO | platform_version: 45.0a1 11:43:38 INFO - 2015-11-13 11:43:38,711 DEBUG : using testdate: 1447443818 11:43:38 INFO - 2015-11-13 11:43:38,711 DEBUG : actual date: 1447443818 11:43:38 INFO - 2015-11-13 11:43:38,721 INFO : starting webserver on 'localhost:53238' 11:43:38 INFO - 2015-11-13 11:43:38,723 INFO : Starting test suite t-yosemite-r5-0076 11:43:38 INFO - 2015-11-13 11:43:38,723 INFO : Starting test dromaeo_css 11:43:38 INFO - 2015-11-13 11:43:38,723 DEBUG : operating with platform_type : mac_ 11:43:38 INFO - 2015-11-13 11:43:38,724 INFO : Initialising browser for dromaeo_css test... 11:43:38 INFO - 2015-11-13 11:43:38,741 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmpDucmEC/profile http://localhost:53238/getInfo.html 11:43:41 INFO - 2015-11-13 11:43:41,551 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:43:41 INFO - 2015-11-13 11:43:41,551 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:43:41 INFO - 2015-11-13 11:43:41,551 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:43:41 INFO - 2015-11-13 11:43:41,552 DEBUG : BROWSER_OUTPUT: __metrics 11:43:41 INFO - 2015-11-13 11:43:41,567 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:42 INFO - 2015-11-13 11:43:42,413 INFO : Browser initialized. 11:43:42 INFO - 2015-11-13 11:43:42,414 INFO : Running cycle 1/1 for dromaeo_css test... 11:43:42 INFO - 2015-11-13 11:43:42,414 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmpDucmEC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:43:54 INFO - 2015-11-13 11:43:54,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 229429248 11:43:54 INFO - 2015-11-13 11:43:54,682 DEBUG : BROWSER_OUTPUT: 11:44:46 INFO - 2015-11-13 11:44:46,516 DEBUG : BROWSER_OUTPUT: 1447443886514 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] 11:46:56 INFO - 2015-11-13 11:46:56,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53238/tests/dromaeo/cssquery-ext.html) 11:46:57 INFO - 2015-11-13 11:46:57,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 322756608 11:46:57 INFO - 2015-11-13 11:46:57,725 DEBUG : BROWSER_OUTPUT: 11:50:00 INFO - 2015-11-13 11:50:00,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/dromaeo/cssquery-ext.html (next: http://localhost:53238/tests/dromaeo/cssquery-jquery.html) 11:50:01 INFO - 2015-11-13 11:50:01,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 356798464 11:50:01 INFO - 2015-11-13 11:50:01,473 DEBUG : BROWSER_OUTPUT: 11:53:03 INFO - 2015-11-13 11:53:03,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53238/tests/dromaeo/cssquery-mootools.html) 11:53:04 INFO - 2015-11-13 11:53:04,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 320749568 11:53:04 INFO - 2015-11-13 11:53:04,568 DEBUG : BROWSER_OUTPUT: 11:56:06 INFO - 2015-11-13 11:56:06,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53238/tests/dromaeo/cssquery-prototype.html) 11:56:07 INFO - 2015-11-13 11:56:07,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 318980096 11:56:07 INFO - 2015-11-13 11:56:07,406 DEBUG : BROWSER_OUTPUT: 11:59:11 INFO - 2015-11-13 11:59:11,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53238/tests/dromaeo/cssquery-yui.html) 11:59:11 INFO - 2015-11-13 11:59:11,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 320061440 11:59:11 INFO - 2015-11-13 11:59:11,611 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/dromaeo/cssquery-yui.html (next: http://localhost:53238/tests/dromaeo/cssquery-dojo.html) 12:02:14 INFO - 2015-11-13 12:02:14,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 366133248 12:02:14 INFO - 2015-11-13 12:02:14,868 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,868 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:02:14 INFO - 2015-11-13 12:02:14,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:02:14 INFO - 2015-11-13 12:02:14,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:02:14 INFO - 2015-11-13 12:02:14,869 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:02:14 INFO - 2015-11-13 12:02:14,869 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2409.265174121893;2471.592187289097;2498.4753201827616;2523.369157710571;2536.860472674003;4005;4118.7322824016455;4127.380892866068;4147.751134931907;4227.852025179115;4067.7966101694947;4082.224377368298;4191.308434108376;4196.6013228743295;4207.20063187994;3777.112378591029;3810.8475660973527;3828.2152158807517;3893.9026524336837;3910.042039700277;3788.1287303920117;3860.9227815443674;3904.063024874024;3940.586238444965;3996.620321069494;3680.061584296014;3693.261347730465;3800.847966081381;3862.9227415451815;3880.165764360662;3732.962670373289;3830.2339532093415;3838.673712734421;3847.7498962567342;3860.305145073886;3818.618138186187;3836.1368692044066;3846.5961074087377;3884.6698030667426;3982.4623675803973;3934.4098385242155;4108.26051310764;4129.2773764591075;4147.294959856831;4172.374143878412;4288.69979101463;4371.519132895379;4381.189479946188;4417.337399390085;4440.977795111036;4467.128909862578;4488.640908727294;4492.438445194351;4566.680332376735;4589.862304130881;4009.3785463253244;4171.082361880412;4176.832926682899;4243.087736136746;4288.313869780851;4476.26141686618;4503.617192538605;4579.152856721451;4659.068186362741;4661.627069834405;4376.277914144131;4398.450193725785;4425;4445.755483448442;4481.126180394792;4232.217039847638;4492.73043617384;4534.161180181611;4556.430446194226;4569.543045695404;4328.61042506176;4358.3244597087505;4391.780410979438;4410.20616289071;4435.334699795057;4380.7152535085115;4424.402705634698;4427.402300689366;4496.505384407713;4542.364069030338;3353.9496907546404;3467.3065386922212;3493.039414161126;3543.025667941337;3551.6270791566512;3058.98470507646;3134.247780532701;3135.9686403135674;3148.937021259562;3168.5247212917784;4153.044799696087;4212.178625168124;4261.318189089793;4313.8490152845125;4317.848875289413;4221.451211342506;4520.751358675238;4521.638268938477;4558.658100642465;4591.540845915449;4076.612721791425;4143.150654115899;4161.126163505637;4163.521195062606;4283.957160428418;3917.3536366499206;3937.7046721496004;3966.781826999543;3973.6026397360033;3990.082281075369;4454.955450445454;4633.513481084505;4635.582797548237;4677.766111694334;4740.739259340631;4426.9778651106535;4475.6419486441655;4511.661625378044;4564.315352697122;4570.063137056829;4595.425571803525;4635.768211589474;4671.299305104261;4683.695559788603;4703.8824029398165;4219.746815191098;4393.033532622818;4417.271150260171;4482.75344856036;4501.977490112659;4092.795360232036;4275.144971005749;4313.525512193719;4416.315471101984;4512.887177820581;4344.93482597755;4370.213361594816;4372.0818628088455;4457.197704413107;4472.262076757299;4208.684348673801;4360.585744354281;4362.563743625612;4459.264221403562;4463.152001119777;4187.811548480387;4229.25987952101;4231.851885184127;4285.164392943346;4433.8891527710775;4366.585174408426;4393.604575588212;4429.025614364835;4480.507144214199;4504.301833215857;4061.3907913813164;4283.571642835816;4320.675949303752;4373.497047839539;4413.139437809725 12:02:14 INFO - 2015-11-13 12:02:14,873 DEBUG : BROWSER_OUTPUT: |1;ext.html;433.57942795488384;436.4348169120988;438.7126432186917;452.45253243575274;469.78624725749785;23221.883890580546;24088.759112408872;30602;31569.842150789213;31676.208094797643;33396.66603333966;33461.15196752374;33833.830830845814;33947.83026084866;34035.48946765794;6296.968515157418;6531.4448271896945;7110.786676399716;7325.267473252686;7448.106227252737;6438.871222575545;8575.656973721043;8735.257503112243;8794.60424280909;8808.383413161082;8649.567521623925;8660.783480412978;8666.913330866673;8686.391952563323;8806.64773409063;6604.768833090867;6656.7670131545165;6755.121834161577;8602.827943441158;8608.698695545658;8580.270676992463;8777.29781617469;8826.117388261187;8880.511571863544;8908.287337013087;30850.382992340026;31472.685273147203;31501;31709.682903170902;31939;2141.0579345088267;2174.053318905828;2208.856424332413;2236.439222324559;2289.8626082435107;21682.89158554213;22406;22448.55102897949;22502.212422565295;22986.310410687707;1745.9214335354939;1764.6382491589193;1784.5895444047812;1796.62270923105;1813.3200049981258;209597;209771;209945;210071;210571;40847.59152408497;42945.78527107407;42959.57040429618;47314.5268547317;48291.758541207775;49523.752381238584;50304.748476258115;50334.74832625814;50520.74739626352;50892;11715.824262636068;11744.119191060705;11791.941040294916;11831.17181797266;11908.821367679491;8669.479831210148;8734.91265087341;8817.559122044;8839.779005524913;8880.777980550538;15882.37940739765;15908.204589770698;16043.598910027342;16101.355945762272;16124;6195.19462469876;6438.744444833213;6449.290578036413;6482.189726284215;6538.444232240217;704.4822055788991;709.5565271705184;773.9032620922385;800.3597122302135;834.9332053435711;22691.546169076857;22771;22864.771352286265;22950.540989180456;23027.309180724606;816.2123550773532;840.2689659995842;860.1269711243093;862.719616124762;877.9517126558101;11718.23831450953;11751.47118379675;11860.822087668692;11921.880781192078;11994.460249288803;265329;268607;269906;270365;270557;43651.781741091094;43885.78057109694;43896.56103438989;43945;44194.33708494375;1053.8840727519967;1060.0459586372326;1061.2040969273046;1078.8759292681127;1081.7241603391085;21873.062848686754;22187.889060554593;22218;22644.886775566018;22677.773222267566;38500.22999539937;38913.41629875611;39037;39156;39231;224333;233621;237029;237070;237174;21287.57424851525;21510.354689359345;25304.367390815376;32774.67225327716;33936.490952636224;34232.486512701835;35237.29525409529;35536.46695299521;36084.27831443304;37078.44382334213;28449.715502844705;29587;29855.402891941605;29879.701202988563;30023;28847.711522884503;29757;30051.398972020874;30284.24289392783;30882.382352353277;27475.587866182424;27790.305242368293;27839;28920;29042.419151617272;25628.743712562635;31276;32503;32804.507932380555;33443.33113337768;25919.481610368064;26443.338916527242;26856.865715671298;26934.191974240803;27224.863875680494 12:02:14 INFO - 2015-11-13 12:02:14,875 DEBUG : BROWSER_OUTPUT: |2;jquery.html;255.88868842053708;257.63673220758733;262.20028911818946;265.22686369233685;270.5387314628559;9982.650607228748;10334.379937203774;13799.586012419632;14217.075890067139;14237.430502779876;9416.905830941689;11571;13545;13774.104683195585;13786.103903246281;4207.368894665801;4351.673624478177;4362.825486980517;4378.802953867068;4383.75889326087;2967.43618712445;3131.780775345727;4301.075268817203;4301.26878430666;4321.697481176319;3133.5456358827955;4579.427571553556;4751.9762401187945;4812.0857037163005;4816.325714399987;4646.721196728207;4718.740469274188;4746.169420351442;4769.475357710649;4791.736454495001;3992.161646054303;4047.5952404759582;4092.058826469899;4096.836126554934;4099.118689481776;9805.705828825146;10069.54687039085;10137.797244055078;16390.754138687927;16656.83343166577;1362.50949658123;1430.5851303122083;1441.149721664223;1467.3103641288578;1513.5913303408129;7287.344139027513;7518.586477743722;7551.433642476836;7637.923620763777;7683.270089341504;1197.5150064224003;1243.975120497585;1253.5048655780915;1260.7982722764314;1272.662744372742;41593.58406415927;43332.350014749805;45056.774716126536;45668.54331456676;47155.28447155291;4990.30135780991;5025.522575355335;5103.081445339874;5170.095233334151;5171.5862730981435;5789.9710501447225;5814.622049566765;5857.26784151981;5902.61632993854;5911.113333000085;4073.1853629274265;4101.2412703649325;4120.052387950788;4178.749275043507;4205.74765514064;4322.762248076386;4327.913441731148;4354.346847972829;4407.0524837160165;4420.115976804587;2283.874386908703;2290.931272061841;2297.437127903674;2324.3491822289784;2346.16711067572;809.7854068671807;814.0313027497259;817.1093508076225;849.2569002123142;876.1238761238761;322.40677154036683;337.1268414805665;360.7114308553147;361.138684238094;365.84085922623746;8517.531535765593;8953.19334865916;8992.190702836646;9113.635454581876;9124.49815260167;305.76303364892385;347.60373174580997;359.76435434790255;368.1385557794773;373.35968813485005;4645.326427667969;4738.704395817669;4812.06164797868;4817.9036419272115;4833.081714474239;414580;422233;429764;431000;439752;56218.71890640602;56279;56410;56506.15240771392;57562.42437575654;378.70839453620556;384.1184481614701;385.2603002235714;386.4087945443532;388.19449641992975;7910.2089791020435;8185.181481852005;8190.467619604707;8193.79515512117;8321.500709957421;25842.61236081498;26746.59880101839;26949;27872;28079.298017549725;36177.45733813942;36385.45421818622;36653;36663.450048248764;36987.44518832274;4789.257665061921;4844.588210002189;4854.1747902857305;4903.754812259444;10302.33034852732;7909.52542847431;14195.716085678436;14538.85461145375;14758.409663613334;14771.261436928326;7237.63811809418;7328.81677958034;7379.963100184465;7471;7473.701051958078;7029.121359830021;7133.072700548895;7200.387967022862;7294.781156565312;7511.136219334628;6323.525735569759;7185.461090418344;7542.736004239825;7592.39260859141;7653.311201991624;9278.443293402417;9287.62849486013;9379;10162.441065741159;11508.88491115078;11221.60724374643;11249.381284029458;11652.766944661229;11666.241694289844;11695.76608467843 12:02:14 INFO - 2015-11-13 12:02:14,877 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1206.197878410857;1318.2354234543964;1363.6386357615233;1372.698006438584;1406.1422532255328;4924.9261261081065;5125.7180855053;5960.254968128978;6070.969645151768;6087;6126.908096378558;6141.72362243699;6152.230971128609;6234.438900498954;6276.717547710353;1633.6895989761967;1695.4066076873119;1695.9406420775276;1727.1019070083548;1735.9218835152449;1690.6027083635336;1723.4743403262;1741.3556983915905;1748.3356324596637;1755.701530739771;1691.264300029491;1695.7965044194652;1699.490152954109;1708.7949446066489;1713.8885972411815;1663.8668906487574;1679.7396403557468;1699.9660006799857;1710.7091794394983;1712.6574685062974;1696.2366934879353;1701.5405840423016;1718.218210714122;1721.8019927708224;1734.6183839555279;5344.064788662007;6084.787032453887;6103.1455596216565;6124.387561243884;6143.4470897618985;3263.184203949013;3311.205310725433;3561.6082230954576;3654.3056819204267;3673.742838001341;2162.4593851537115;2193.144673577306;2218.1681869299014;2245.9101635934708;2248.235599896027;559.644625662703;665.6638397609177;674.1068084787627;684.3806355248458;690.2097098821821;8210.589470526449;8249.133840946733;8270.338372930151;8282.13037631052;8344.83310333796;3226.6934641209045;3231.1437469070715;3308.0902751743465;3312.2381852174135;3337.215754297738;7137.536060156073;7145.785626431215;7228.891566626505;7241.74653887122;7267.454940879349;3674.5590529136675;3681.5214022176947;3742.8689995850013;3749.6812770914776;3763.0028042568742;3330.333933213367;3380.2732412531423;3382.678645528671;3386.610539787907;3388.1698983748647;2868.1108856254627;2885.797994140432;2893.4647090288363;2920.576516405152;2953.822770633769;923.2475532441173;929.2798081486902;940.5955439161089;945.4988855906381;954.6420092465326;990.6829814459304;1018.5925629748012;1041.9270651054505;1048.7063622185801;1052.2897044494935;5825.155352473867;5833.50415214703;5840.182374467578;5885.970570147208;5913.172155898178;338.20353068523275;341.79150718061965;343.5636741338486;344.92411669432687;346.32293865492903;4506.369108324837;4538.092381523643;4592.7014744041535;4594.264917613166;4621.976890115528;6882.070920425778;6887.655617219119;6976.790696279119;7078.292170782881;7127.786166415016;6867.725290988405;6911.619860907698;6941.236463988957;6974.163100427981;7024.086868707035;5146.742662866842;5304.734763261821;5537.501624853782;5560.471755183251;5564.387917329091;5163.251328557413;5627.099664053731;5694.572907032072;5762.596618236683;5806.709664516842;5870.412958704095;6005.249343832021;6040.546958978182;6573.605583664996;6623.138991931018;6609.4712423005085;6793.6942837573415;6830.726770929107;6896.034555162181;6942.826429339105;5392.406835248041;5475.069238229431;5478.424765399575;5485.945140548703;5525.972370138124;5899.852503687443;5951.672658003678;5954.10688396744;5973.193618861398;6027.638341699512;5220.190870415092;5532.668039917457;5580.441955804387;5624.465675760796;5645.379008309164;5344.599155063308;5444.210589464426;5495.587830912617;5510.504054634942;5568.1091025435735;5483.369412517452;5510.752016159202;5528.9723551381985;5541.251930989426;5556.083246264483;4899.020195960893;4904.2643603459765;4914.631402644887;4920.704757714549;4927.482614325444;4976.751162441936;4983.725895075806;5008.073506401327;5015.247712843103;5023.673461225008 12:02:14 INFO - 2015-11-13 12:02:14,880 DEBUG : BROWSER_OUTPUT: |4;prototype.html;236.75850632355;244.44023186901995;245.22508871964584;247.59518187763013;253.75132370277117;4880.341153944217;4904.901901961963;4967.180415231492;4979.576735977437;5004.199328107504;4776.345338930303;4837.346958160647;4890.951090489094;4898.363212782342;4905.117078925792;3739.046543131498;3741.850325986957;3755.9624403756025;3782.546094468654;3784.451254568079;3750.4936833527536;3754.6057663945303;3756.211195648917;3758.7368884178118;3803.562590302123;3525.1010992196952;3612.277544491112;3641;3645.526081609387;3720.8883733488037;3691.7231207659534;3692.556893172823;3697.6856967157823;3726.9440958385644;3732.533433320821;3178.2213357727273;3202.5356323332985;3219.4848824188016;3236.3527294541186;3263.78785378952;4618.630509559261;4651.348811166439;4677.906441871178;4686.906261874743;4745.6440766942615;4201.894952626179;4204.831806727727;4208.810603522848;4230.280852255124;4250.256205164115;5113.948860511385;5124.256982737519;5163.7159956202395;5168.664036837594;5179.896402071938;3450.6549345065546;3502.2645244498685;3516.525269088666;3516.982415087908;3518.6481351864863;5088.7964481420695;5312.309399778004;5350.3312085989255;5359;5364.785408583613;3405.625381208065;3447.5690538682666;3485.1635607454027;3496.1084923344383;3499.055255081114;3524.9072787435975;3532.3288575170636;3558.412861877813;3571.1786289153642;3577.481265216529;4097.487814023247;4120.278951183531;4159.188958153191;4173.10278290169;4175.248455278019;4885.117780509517;4948.05986862495;5052.8484145475695;5108.591312694975;5120.897582048338;1147.8048731715628;1230.7415442757122;1286.5368467351745;1289.9290539020255;1304.7325298313822;833.7790485521342;853.0360692417529;856.3320609924269;862.3661608717588;870.3950754225752;4886.60907127429;4886.780094895738;4938.925916111261;4940.357753492023;4942.1104201244125;5309.097453432925;5318.468153184728;5332.573394128461;5348.304720386403;5363.5440987516495;4896.632752543574;4931.18635425158;4940.086084074458;4957.975210123926;4995.300657907896;2777.6111344411797;2859.699731528201;2871.813332133405;2884.5096333623333;2909.6944820793933;5454.863628409242;5473.698946557977;5492.862678433071;5494.972525137348;5495.093309603951;5438.755256013489;5441.809536666197;5447.019536483392;5447.630280827852;5474.534664553478;5453.945460545423;5463.562914966793;5471.6169868108855;5488.7530061147345;5523.28197334344;5178.404483484447;5286.867828304323;5326.920096198638;5390.757415916371;5454.972725136349;5308.734563271743;5325.360956685223;5327.440618734977;5329.946700532945;5334.839954801362;5585.218069470358;5585.245991791056;5593;5600.927656767022;5627.662340259598;3491.2319289756215;3503.5095086687375;3509.3683137035578;3527.7354198434705;3534.6465353464446;5172.508611681884;5199.29809475716;5369.919451208313;5400.243965844864;5430.049741295336;5086.821961231339;5113.7698803553185;5157.535821776059;5189.221616757516;5212.322398088224;5202.323697919246;5232.9738351308;5277.498637629419;5284.9735751320995;5288.206768984683;5116.616253780907;5116.846494605168;5132.948670513397;5138.537531622172;5167.974160129175;5065.062963351792;5258.684478931276;5269.998700246941;5274.498922602346;5285.127953887565;5078.466760990191;5089.592832573459;5095.26118712792;5108.080545501845;5120.564751996122 12:02:14 INFO - 2015-11-13 12:02:14,881 DEBUG : BROWSER_OUTPUT: |5;yui.html;534.0600543044242;562.4768964862676;588.6968211371142;597.1252115650568;599.7211296747012;10551.314164579297;10836.295640783344;10886.945565272183;10887.401192934396;10921.508532116053;10100.69697909062;10862.185336099785;11065.834012489819;11158.776824463506;11176.608818691348;536.3911959925493;684.3156843156843;693.6358411833802;693.8300116471446;702.0136707925373;525.256761682221;531.6411422289958;686.4371215603207;690.9412699920513;693.5214701855704;690.6995456976232;700.1458220970408;701.4388489208638;707.900893874858;712.4798896805336;537.3068741323688;556.9084594195382;703.4653663215967;712.7540998355558;719.7480881691419;398.2493000693684;511.40166005773335;512.1089304609989;512.6949465068278;526.2185654303356;10317.43254121023;10759.677209683721;10774.19193560486;10811.675649730521;10866.130709543297;7405.925940740632;7665.156832748449;7701.922980770177;7959.482633628795;8306.54314012729;6761.576502322813;7093.503454758169;7102.609356485391;7155.463340249502;7181.6409179540815;2154.138344662132;2266.3767463947383;2305.250793492122;2438.1344622659053;2459.7786199241973;37325.626743732755;37368.626313737055;37378.43932341017;37579.81210093959;38060.80969595162;5316.680999140064;5442.12925931849;5551.195076713854;5573;5722.856928576819;9434.811303773886;9516.333856630108;9575.664851730295;9603.663871764455;9629.085236902483;4729.243321068612;4798.424189097331;4926.8768280793265;4928.334674818853;4956.281339205795;2763.322985868435;2846.644169478815;2899.492588796952;2950.8377039263046;2999.9550006749478;2100.9684854727193;2125.851190416656;2126.2983215538834;2137.593857167133;2143.839212059102;319.30391745993956;321.15696297219796;327.1412542077048;330.7106282003247;332.9983350083234;383.593391005535;433.68124428544996;439.4265483543942;454.372965307873;471.8961828397747;6187.412195841388;6550.967245163743;6776.830579235559;6879.277675844064;7009.509334346547;340.6474299100419;388.09573693294556;455.3920516110963;470.89640279138536;498.93014977903124;2846.288427893027;2988.5965394671875;3065.831379274117;3068.1255842084897;3073.0934374359617;45622.543774562495;46162.538374616495;46412.767936160104;46667.29999050017;47139;39600;40614.39078413826;40895.59104408977;41065;41333.379999300036;36191.27617447636;36811;36909.07727306785;37410.43884341683;37830;6203.348648391854;6491.935080649133;6586.70359833799;6615.569987950767;6684.665766711742;26784.99999999922;26941.191764247105;27198.592021119304;27941.58087628728;28112.29719256953;35003;35960.82019589885;36296.81851590725;36549.26901462009;36702.61433006846;6018.097285407224;6101;6149.723262453111;6258.906116408349;6268.4671802897265;8628.39601227908;8641.524716140673;8658.48049117055;8936.374453788172;9026.548672566476;8276.131006244499;8354.122817104117;8358;8441.409101362846;8464.661413543636;8338.749837504885;8371.33029357662;8406.243438090602;8450.323974082181;9020.548972551478;8185;8291.668333266844;8323.292520135614;8326.50040997542;8351.457155284887;6661.866762664623;6915.135608048994;7140.214576396696;7203.963980180275;7292.34368906801;6563.573367731273;6925.501546269098;7221.458390620619;7295.4528410368375;7308.451866110169 12:02:14 INFO - 2015-11-13 12:02:14,882 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:02:14 INFO - 2015-11-13 12:02:14,882 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:02:14 INFO - 2015-11-13 12:02:14,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 12:02:14 INFO - 2015-11-13 12:02:14,882 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:02:14 INFO - 2015-11-13 12:02:14,882 DEBUG : BROWSER_OUTPUT: __startTimestamp1447444934866__endTimestamp 12:02:14 INFO - 2015-11-13 12:02:14,882 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,883 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:02:14 INFO - 2015-11-13 12:02:14,883 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:02:14 INFO - 2015-11-13 12:02:14,883 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,883 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4158.81 Median:4283.96 stddev:452.65 (10.6%) stddev-sans-first:432.73 12:02:14 INFO - 2015-11-13 12:02:14,885 DEBUG : BROWSER_OUTPUT: Values: 2409.3 2471.6 2498.5 2523.4 2536.9 4005.0 4118.7 4127.4 4147.8 4227.9 4067.8 4082.2 4191.3 4196.6 4207.2 3777.1 3810.8 3828.2 3893.9 3910.0 3788.1 3860.9 3904.1 3940.6 3996.6 3680.1 3693.3 3800.8 3862.9 3880.2 3733.0 3830.2 3838.7 3847.7 3860.3 3818.6 3836.1 3846.6 3884.7 3982.5 3934.4 4108.3 4129.3 4147.3 4172.4 4288.7 4371.5 4381.2 4417.3 4441.0 4467.1 4488.6 4492.4 4566.7 4589.9 4009.4 4171.1 4176.8 4243.1 4288.3 4476.3 4503.6 4579.2 4659.1 4661.6 4376.3 4398.5 4425.0 4445.8 4481.1 4232.2 4492.7 4534.2 4556.4 4569.5 4328.6 4358.3 4391.8 4410.2 4435.3 4380.7 4424.4 4427.4 4496.5 4542.4 3353.9 3467.3 3493.0 3543.0 3551.6 3059.0 3134.2 3136.0 3148.9 3168.5 4153.0 4212.2 4261.3 4313.8 4317.8 4221.5 4520.8 4521.6 4558.7 4591.5 4076.6 4143.2 4161.1 4163.5 4284.0 3917.4 3937.7 3966.8 3973.6 3990.1 4455.0 4633.5 4635.6 4677.8 4740.7 4427.0 4475.6 4511.7 4564.3 4570.1 4595.4 4635.8 4671.3 4683.7 4703.9 4219.7 4393.0 4417.3 4482.8 4502.0 4092.8 4275.1 4313.5 4416.3 4512.9 4344.9 4370.2 4372.1 4457.2 4472.3 4208.7 4360.6 4362.6 4459.3 4463.2 4187.8 4229.3 4231.9 4285.2 4433.9 4366.6 4393.6 4429.0 4480.5 4504.3 4061.4 4283.6 4320.7 4373.5 4413.1 12:02:14 INFO - 2015-11-13 12:02:14,885 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,885 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37827.31 Median:31535.42 stddev:62386.74 (197.8%) stddev-sans-first:62498.57 12:02:14 INFO - 2015-11-13 12:02:14,887 DEBUG : BROWSER_OUTPUT: Values: 433.6 436.4 438.7 452.5 469.8 23221.9 24088.8 30602.0 31569.8 31676.2 33396.7 33461.2 33833.8 33947.8 34035.5 6297.0 6531.4 7110.8 7325.3 7448.1 6438.9 8575.7 8735.3 8794.6 8808.4 8649.6 8660.8 8666.9 8686.4 8806.6 6604.8 6656.8 6755.1 8602.8 8608.7 8580.3 8777.3 8826.1 8880.5 8908.3 30850.4 31472.7 31501.0 31709.7 31939.0 2141.1 2174.1 2208.9 2236.4 2289.9 21682.9 22406.0 22448.6 22502.2 22986.3 1745.9 1764.6 1784.6 1796.6 1813.3 209597.0 209771.0 209945.0 210071.0 210571.0 40847.6 42945.8 42959.6 47314.5 48291.8 49523.8 50304.7 50334.7 50520.7 50892.0 11715.8 11744.1 11791.9 11831.2 11908.8 8669.5 8734.9 8817.6 8839.8 8880.8 15882.4 15908.2 16043.6 16101.4 16124.0 6195.2 6438.7 6449.3 6482.2 6538.4 704.5 709.6 773.9 800.4 834.9 22691.5 22771.0 22864.8 22950.5 23027.3 816.2 840.3 860.1 862.7 878.0 11718.2 11751.5 11860.8 11921.9 11994.5 265329.0 268607.0 269906.0 270365.0 270557.0 43651.8 43885.8 43896.6 43945.0 44194.3 1053.9 1060.0 1061.2 1078.9 1081.7 21873.1 22187.9 22218.0 22644.9 22677.8 38500.2 38913.4 39037.0 39156.0 39231.0 224333.0 233621.0 237029.0 237070.0 237174.0 21287.6 21510.4 25304.4 32774.7 33936.5 34232.5 35237.3 35536.5 36084.3 37078.4 28449.7 29587.0 29855.4 29879.7 30023.0 28847.7 29757.0 30051.4 30284.2 30882.4 27475.6 27790.3 27839.0 28920.0 29042.4 25628.7 31276.0 32503.0 32804.5 33443.3 25919.5 26443.3 26856.9 26934.2 27224.9 12:02:14 INFO - 2015-11-13 12:02:14,887 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,887 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21380.48 Median:4322.23 stddev:69942.87 (1618.2%) stddev-sans-first:70121.09 12:02:14 INFO - 2015-11-13 12:02:14,889 DEBUG : BROWSER_OUTPUT: Values: 255.9 257.6 262.2 265.2 270.5 9982.7 10334.4 13799.6 14217.1 14237.4 9416.9 11571.0 13545.0 13774.1 13786.1 4207.4 4351.7 4362.8 4378.8 4383.8 2967.4 3131.8 4301.1 4301.3 4321.7 3133.5 4579.4 4752.0 4812.1 4816.3 4646.7 4718.7 4746.2 4769.5 4791.7 3992.2 4047.6 4092.1 4096.8 4099.1 9805.7 10069.5 10137.8 16390.8 16656.8 1362.5 1430.6 1441.1 1467.3 1513.6 7287.3 7518.6 7551.4 7637.9 7683.3 1197.5 1244.0 1253.5 1260.8 1272.7 41593.6 43332.4 45056.8 45668.5 47155.3 4990.3 5025.5 5103.1 5170.1 5171.6 5790.0 5814.6 5857.3 5902.6 5911.1 4073.2 4101.2 4120.1 4178.7 4205.7 4322.8 4327.9 4354.3 4407.1 4420.1 2283.9 2290.9 2297.4 2324.3 2346.2 809.8 814.0 817.1 849.3 876.1 322.4 337.1 360.7 361.1 365.8 8517.5 8953.2 8992.2 9113.6 9124.5 305.8 347.6 359.8 368.1 373.4 4645.3 4738.7 4812.1 4817.9 4833.1 414580.0 422233.0 429764.0 431000.0 439752.0 56218.7 56279.0 56410.0 56506.2 57562.4 378.7 384.1 385.3 386.4 388.2 7910.2 8185.2 8190.5 8193.8 8321.5 25842.6 26746.6 26949.0 27872.0 28079.3 36177.5 36385.5 36653.0 36663.5 36987.4 4789.3 4844.6 4854.2 4903.8 10302.3 7909.5 14195.7 14538.9 14758.4 14771.3 7237.6 7328.8 7380.0 7471.0 7473.7 7029.1 7133.1 7200.4 7294.8 7511.1 6323.5 7185.5 7542.7 7592.4 7653.3 9278.4 9287.6 9379.0 10162.4 11508.9 11221.6 11249.4 11652.8 11666.2 11695.8 12:02:14 INFO - 2015-11-13 12:02:14,889 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,889 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4205.15 Median:5344.33 stddev:2206.06 (41.3%) stddev-sans-first:2200.74 12:02:14 INFO - 2015-11-13 12:02:14,889 DEBUG : BROWSER_OUTPUT: Values: 1206.2 1318.2 1363.6 1372.7 1406.1 4924.9 5125.7 5960.3 6071.0 6087.0 6126.9 6141.7 6152.2 6234.4 6276.7 1633.7 1695.4 1695.9 1727.1 1735.9 1690.6 1723.5 1741.4 1748.3 1755.7 1691.3 1695.8 1699.5 1708.8 1713.9 1663.9 1679.7 1700.0 1710.7 1712.7 1696.2 1701.5 1718.2 1721.8 1734.6 5344.1 6084.8 6103.1 6124.4 6143.4 3263.2 3311.2 3561.6 3654.3 3673.7 2162.5 2193.1 2218.2 2245.9 2248.2 559.6 665.7 674.1 684.4 690.2 8210.6 8249.1 8270.3 8282.1 8344.8 3226.7 3231.1 3308.1 3312.2 3337.2 7137.5 7145.8 7228.9 7241.7 7267.5 3674.6 3681.5 3742.9 3749.7 3763.0 3330.3 3380.3 3382.7 3386.6 3388.2 2868.1 2885.8 2893.5 2920.6 2953.8 923.2 929.3 940.6 945.5 954.6 990.7 1018.6 1041.9 1048.7 1052.3 5825.2 5833.5 5840.2 5886.0 5913.2 338.2 341.8 343.6 344.9 346.3 4506.4 4538.1 4592.7 4594.3 4622.0 6882.1 6887.7 6976.8 7078.3 7127.8 6867.7 6911.6 6941.2 6974.2 7024.1 5146.7 5304.7 5537.5 5560.5 5564.4 5163.3 5627.1 5694.6 5762.6 5806.7 5870.4 6005.2 6040.5 6573.6 6623.1 6609.5 6793.7 6830.7 6896.0 6942.8 5392.4 5475.1 5478.4 5485.9 5526.0 5899.9 5951.7 5954.1 5973.2 6027.6 5220.2 5532.7 5580.4 5624.5 5645.4 5344.6 5444.2 5495.6 5510.5 5568.1 5483.4 5510.8 5529.0 5541.3 5556.1 4899.0 4904.3 4914.6 4920.7 4927.5 4976.8 4983.7 5008.1 5015.2 5023.7 12:02:14 INFO - 2015-11-13 12:02:14,890 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,890 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4297.11 Median:4945.09 stddev:1322.19 (26.7%) stddev-sans-first:1290.30 12:02:14 INFO - 2015-11-13 12:02:14,891 DEBUG : BROWSER_OUTPUT: Values: 236.8 244.4 245.2 247.6 253.8 4880.3 4904.9 4967.2 4979.6 5004.2 4776.3 4837.3 4891.0 4898.4 4905.1 3739.0 3741.9 3756.0 3782.5 3784.5 3750.5 3754.6 3756.2 3758.7 3803.6 3525.1 3612.3 3641.0 3645.5 3720.9 3691.7 3692.6 3697.7 3726.9 3732.5 3178.2 3202.5 3219.5 3236.4 3263.8 4618.6 4651.3 4677.9 4686.9 4745.6 4201.9 4204.8 4208.8 4230.3 4250.3 5113.9 5124.3 5163.7 5168.7 5179.9 3450.7 3502.3 3516.5 3517.0 3518.6 5088.8 5312.3 5350.3 5359.0 5364.8 3405.6 3447.6 3485.2 3496.1 3499.1 3524.9 3532.3 3558.4 3571.2 3577.5 4097.5 4120.3 4159.2 4173.1 4175.2 4885.1 4948.1 5052.8 5108.6 5120.9 1147.8 1230.7 1286.5 1289.9 1304.7 833.8 853.0 856.3 862.4 870.4 4886.6 4886.8 4938.9 4940.4 4942.1 5309.1 5318.5 5332.6 5348.3 5363.5 4896.6 4931.2 4940.1 4958.0 4995.3 2777.6 2859.7 2871.8 2884.5 2909.7 5454.9 5473.7 5492.9 5495.0 5495.1 5438.8 5441.8 5447.0 5447.6 5474.5 5453.9 5463.6 5471.6 5488.8 5523.3 5178.4 5286.9 5326.9 5390.8 5455.0 5308.7 5325.4 5327.4 5329.9 5334.8 5585.2 5585.2 5593.0 5600.9 5627.7 3491.2 3503.5 3509.4 3527.7 3534.6 5172.5 5199.3 5369.9 5400.2 5430.0 5086.8 5113.8 5157.5 5189.2 5212.3 5202.3 5233.0 5277.5 5285.0 5288.2 5116.6 5116.8 5132.9 5138.5 5168.0 5065.1 5258.7 5270.0 5274.5 5285.1 5078.5 5089.6 5095.3 5108.1 5120.6 12:02:14 INFO - 2015-11-13 12:02:14,891 DEBUG : BROWSER_OUTPUT: 12:02:14 INFO - 2015-11-13 12:02:14,892 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10418.32 Median:528.93 stddev:12825.15 (2424.7%) stddev-sans-first:12839.65 12:02:14 INFO - 2015-11-13 12:02:14,893 DEBUG : BROWSER_OUTPUT: Values: 534.1 562.5 588.7 597.1 599.7 10551.3 10836.3 10886.9 10887.4 10921.5 10100.7 10862.2 11065.8 11158.8 11176.6 536.4 684.3 693.6 693.8 702.0 525.3 531.6 686.4 690.9 693.5 690.7 700.1 701.4 707.9 712.5 537.3 556.9 703.5 712.8 719.7 398.2 511.4 512.1 512.7 526.2 10317.4 10759.7 10774.2 10811.7 10866.1 7405.9 7665.2 7701.9 7959.5 8306.5 6761.6 7093.5 7102.6 7155.5 7181.6 2154.1 2266.4 2305.3 2438.1 2459.8 37325.6 37368.6 37378.4 37579.8 38060.8 5316.7 5442.1 5551.2 5573.0 5722.9 9434.8 9516.3 9575.7 9603.7 9629.1 4729.2 4798.4 4926.9 4928.3 4956.3 2763.3 2846.6 2899.5 2950.8 3000.0 2101.0 2125.9 2126.3 2137.6 2143.8 319.3 321.2 327.1 330.7 333.0 383.6 433.7 439.4 454.4 471.9 6187.4 6551.0 6776.8 6879.3 7009.5 340.6 388.1 455.4 470.9 498.9 2846.3 2988.6 3065.8 3068.1 3073.1 45622.5 46162.5 46412.8 46667.3 47139.0 39600.0 40614.4 40895.6 41065.0 41333.4 36191.3 36811.0 36909.1 37410.4 37830.0 6203.3 6491.9 6586.7 6615.6 6684.7 26785.0 26941.2 27198.6 27941.6 28112.3 35003.0 35960.8 36296.8 36549.3 36702.6 6018.1 6101.0 6149.7 6258.9 6268.5 8628.4 8641.5 8658.5 8936.4 9026.5 8276.1 8354.1 8358.0 8441.4 8464.7 8338.7 8371.3 8406.2 8450.3 9020.5 8185.0 8291.7 8323.3 8326.5 8351.5 6661.9 6915.1 7140.2 7204.0 7292.3 6563.6 6925.5 7221.5 7295.5 7308.5 12:02:14 INFO - 2015-11-13 12:02:14,893 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:02:14 INFO - 2015-11-13 12:02:14,893 DEBUG : BROWSER_OUTPUT: 12:02:15 INFO - 2015-11-13 12:02:15,608 INFO : Browser exited with error code: 0 12:02:15 INFO - 2015-11-13 12:02:15,643 INFO : Completed test dromaeo_css (00:18:36) 12:02:15 INFO - 2015-11-13 12:02:15,643 INFO : Starting test kraken 12:02:15 INFO - 2015-11-13 12:02:15,644 DEBUG : operating with platform_type : mac_ 12:02:15 INFO - 2015-11-13 12:02:15,644 INFO : Initialising browser for kraken test... 12:02:15 INFO - 2015-11-13 12:02:15,661 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmp6soqs0/profile http://localhost:53238/getInfo.html 12:02:18 INFO - 2015-11-13 12:02:18,362 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:02:18 INFO - 2015-11-13 12:02:18,362 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:02:18 INFO - 2015-11-13 12:02:18,362 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:02:18 INFO - 2015-11-13 12:02:18,362 DEBUG : BROWSER_OUTPUT: __metrics 12:02:18 INFO - 2015-11-13 12:02:18,378 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:02:19 INFO - 2015-11-13 12:02:19,223 INFO : Browser initialized. 12:02:19 INFO - 2015-11-13 12:02:19,224 INFO : Running cycle 1/1 for kraken test... 12:02:19 INFO - 2015-11-13 12:02:19,224 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmp6soqs0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:02:31 INFO - 2015-11-13 12:02:31,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 229646336 12:02:31 INFO - 2015-11-13 12:02:31,429 DEBUG : BROWSER_OUTPUT: 12:02:34 INFO - 2015-11-13 12:02:34,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53238/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:35 INFO - 2015-11-13 12:02:35,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 286220288 12:02:35 INFO - 2015-11-13 12:02:35,081 DEBUG : BROWSER_OUTPUT: 12:02:38 INFO - 2015-11-13 12:02:38,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53238/tests/kraken/driver.html?testName=audio-dft) 12:02:38 INFO - 2015-11-13 12:02:38,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 299171840 12:02:38 INFO - 2015-11-13 12:02:38,881 DEBUG : BROWSER_OUTPUT: 12:02:42 INFO - 2015-11-13 12:02:42,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53238/tests/kraken/driver.html?testName=audio-fft) 12:02:43 INFO - 2015-11-13 12:02:43,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 283852800 12:02:43 INFO - 2015-11-13 12:02:43,038 DEBUG : BROWSER_OUTPUT: 12:02:45 INFO - 2015-11-13 12:02:45,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53238/tests/kraken/driver.html?testName=audio-oscillator) 12:02:46 INFO - 2015-11-13 12:02:46,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 284676096 12:02:46 INFO - 2015-11-13 12:02:46,013 DEBUG : BROWSER_OUTPUT: 12:02:48 INFO - 2015-11-13 12:02:48,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:49 INFO - 2015-11-13 12:02:49,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 286121984 12:02:49 INFO - 2015-11-13 12:02:49,198 DEBUG : BROWSER_OUTPUT: 12:02:52 INFO - 2015-11-13 12:02:52,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53238/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:53 INFO - 2015-11-13 12:02:53,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 283004928 12:02:53 INFO - 2015-11-13 12:02:53,479 DEBUG : BROWSER_OUTPUT: 12:02:57 INFO - 2015-11-13 12:02:57,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53238/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:57 INFO - 2015-11-13 12:02:57,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 282017792 12:02:57 INFO - 2015-11-13 12:02:57,983 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2015-11-13 12:03:01,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53238/tests/kraken/driver.html?testName=json-parse-financial) 12:03:01 INFO - 2015-11-13 12:03:01,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 284045312 12:03:01 INFO - 2015-11-13 12:03:01,959 DEBUG : BROWSER_OUTPUT: 12:03:03 INFO - 2015-11-13 12:03:03,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:03:04 INFO - 2015-11-13 12:03:04,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 318996480 12:03:04 INFO - 2015-11-13 12:03:04,340 DEBUG : BROWSER_OUTPUT: 12:03:06 INFO - 2015-11-13 12:03:06,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53238/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:03:07 INFO - 2015-11-13 12:03:07,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 321253376 12:03:07 INFO - 2015-11-13 12:03:07,113 DEBUG : BROWSER_OUTPUT: 12:03:09 INFO - 2015-11-13 12:03:09,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:03:10 INFO - 2015-11-13 12:03:10,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 320503808 12:03:10 INFO - 2015-11-13 12:03:10,225 DEBUG : BROWSER_OUTPUT: 12:03:13 INFO - 2015-11-13 12:03:13,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:03:13 INFO - 2015-11-13 12:03:13,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 322256896 12:03:13 INFO - 2015-11-13 12:03:13,978 DEBUG : BROWSER_OUTPUT: 12:03:17 INFO - 2015-11-13 12:03:17,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:03:17 INFO - 2015-11-13 12:03:17,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 323854336 12:03:17 INFO - 2015-11-13 12:03:17,785 DEBUG : BROWSER_OUTPUT: 12:03:19 INFO - 2015-11-13 12:03:19,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53238/tests/kraken/driver.html?testName=ai-astar) 12:03:20 INFO - 2015-11-13 12:03:20,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 386994176 12:03:20 INFO - 2015-11-13 12:03:20,109 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,109 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:03:20 INFO - 2015-11-13 12:03:20,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:03:20 INFO - 2015-11-13 12:03:20,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:03:20 INFO - 2015-11-13 12:03:20,110 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:03:20 INFO - 2015-11-13 12:03:20,110 DEBUG : BROWSER_OUTPUT: |0;ai-astar;131;139;134;141;142;139;128;139;139;128 12:03:20 INFO - 2015-11-13 12:03:20,110 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;195;166;194;206;164;192;188;163;206;162 12:03:20 INFO - 2015-11-13 12:03:20,110 DEBUG : BROWSER_OUTPUT: |2;audio-dft;204;206;205;204;208;204;198;206;206;207 12:03:20 INFO - 2015-11-13 12:03:20,111 DEBUG : BROWSER_OUTPUT: |3;audio-fft;90;105;108;156;85;87;89;90;141;86 12:03:20 INFO - 2015-11-13 12:03:20,111 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;117;123;173;115;115;116;161;114;114;167 12:03:20 INFO - 2015-11-13 12:03:20,111 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;152;148;156;156;148;148;148;148;141;148 12:03:20 INFO - 2015-11-13 12:03:20,111 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;163;163;163;162;160;155;162;162;162;163 12:03:20 INFO - 2015-11-13 12:03:20,111 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;115;120;120;120;131;119;120;129;120;121 12:03:20 INFO - 2015-11-13 12:03:20,112 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;72;76;76;76;76;75;76;76;77 12:03:20 INFO - 2015-11-13 12:03:20,112 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;81;82;82;88;87;88;88;88;89;88 12:03:20 INFO - 2015-11-13 12:03:20,112 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;105;113;110;112;109;111;112;111;122;113 12:03:20 INFO - 2015-11-13 12:03:20,113 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;161;161;172;162;159;162;166;168;180;170 12:03:20 INFO - 2015-11-13 12:03:20,113 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;183;185;200;206;206;188;206;191;198;200 12:03:20 INFO - 2015-11-13 12:03:20,113 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;89;88;91;93;93;92;93;93;93;92 12:03:20 INFO - 2015-11-13 12:03:20,113 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:03:20 INFO - 2015-11-13 12:03:20,113 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:03:20 INFO - 2015-11-13 12:03:20,113 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1016 12:03:20 INFO - 2015-11-13 12:03:20,114 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:03:20 INFO - 2015-11-13 12:03:20,114 DEBUG : BROWSER_OUTPUT: __startTimestamp1447445000103__endTimestamp 12:03:20 INFO - 2015-11-13 12:03:20,114 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,114 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:03:20 INFO - 2015-11-13 12:03:20,115 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:03:20 INFO - 2015-11-13 12:03:20,115 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,115 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:136.00 Median:139.00 stddev:5.31 (3.8%) stddev-sans-first:5.32 12:03:20 INFO - 2015-11-13 12:03:20,115 DEBUG : BROWSER_OUTPUT: Values: 131.0 139.0 134.0 141.0 142.0 139.0 128.0 139.0 139.0 128.0 12:03:20 INFO - 2015-11-13 12:03:20,115 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,116 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:183.60 Median:193.00 stddev:18.00 (9.3%) stddev-sans-first:18.61 12:03:20 INFO - 2015-11-13 12:03:20,116 DEBUG : BROWSER_OUTPUT: Values: 195.0 166.0 194.0 206.0 164.0 192.0 188.0 163.0 206.0 162.0 12:03:20 INFO - 2015-11-13 12:03:20,116 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,116 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:204.80 Median:206.00 stddev:2.74 (1.3%) stddev-sans-first:2.89 12:03:20 INFO - 2015-11-13 12:03:20,116 DEBUG : BROWSER_OUTPUT: Values: 204.0 206.0 205.0 204.0 208.0 204.0 198.0 206.0 206.0 207.0 12:03:20 INFO - 2015-11-13 12:03:20,117 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,117 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:103.70 Median:86.50 stddev:25.12 (29.0%) stddev-sans-first:26.15 12:03:20 INFO - 2015-11-13 12:03:20,117 DEBUG : BROWSER_OUTPUT: Values: 90.0 105.0 108.0 156.0 85.0 87.0 89.0 90.0 141.0 86.0 12:03:20 INFO - 2015-11-13 12:03:20,117 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,117 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:131.50 Median:120.00 stddev:24.79 (20.7%) stddev-sans-first:25.74 12:03:20 INFO - 2015-11-13 12:03:20,118 DEBUG : BROWSER_OUTPUT: Values: 117.0 123.0 173.0 115.0 115.0 116.0 161.0 114.0 114.0 167.0 12:03:20 INFO - 2015-11-13 12:03:20,118 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,118 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:149.30 Median:148.00 stddev:4.42 (3.0%) stddev-sans-first:4.58 12:03:20 INFO - 2015-11-13 12:03:20,118 DEBUG : BROWSER_OUTPUT: Values: 152.0 148.0 156.0 156.0 148.0 148.0 148.0 148.0 141.0 148.0 12:03:20 INFO - 2015-11-13 12:03:20,118 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,119 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:161.50 Median:162.50 stddev:2.46 (1.5%) stddev-sans-first:2.55 12:03:20 INFO - 2015-11-13 12:03:20,119 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 163.0 162.0 160.0 155.0 162.0 162.0 162.0 163.0 12:03:20 INFO - 2015-11-13 12:03:20,119 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,119 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:121.50 Median:120.00 stddev:4.79 (4.0%) stddev-sans-first:4.47 12:03:20 INFO - 2015-11-13 12:03:20,119 DEBUG : BROWSER_OUTPUT: Values: 115.0 120.0 120.0 120.0 131.0 119.0 120.0 129.0 120.0 121.0 12:03:20 INFO - 2015-11-13 12:03:20,120 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,120 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.00 Median:76.00 stddev:2.21 (2.9%) stddev-sans-first:1.42 12:03:20 INFO - 2015-11-13 12:03:20,120 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 76.0 76.0 76.0 76.0 75.0 76.0 76.0 77.0 12:03:20 INFO - 2015-11-13 12:03:20,120 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,120 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:86.10 Median:88.00 stddev:3.11 (3.5%) stddev-sans-first:2.69 12:03:20 INFO - 2015-11-13 12:03:20,121 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 88.0 87.0 88.0 88.0 88.0 89.0 88.0 12:03:20 INFO - 2015-11-13 12:03:20,121 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,121 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:111.80 Median:112.00 stddev:4.29 (3.8%) stddev-sans-first:3.78 12:03:20 INFO - 2015-11-13 12:03:20,121 DEBUG : BROWSER_OUTPUT: Values: 105.0 113.0 110.0 112.0 109.0 111.0 112.0 111.0 122.0 113.0 12:03:20 INFO - 2015-11-13 12:03:20,121 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,121 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:166.10 Median:167.00 stddev:6.52 (3.9%) stddev-sans-first:6.65 12:03:20 INFO - 2015-11-13 12:03:20,122 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 172.0 162.0 159.0 162.0 166.0 168.0 180.0 170.0 12:03:20 INFO - 2015-11-13 12:03:20,122 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,124 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.30 Median:200.00 stddev:8.91 (4.5%) stddev-sans-first:8.04 12:03:20 INFO - 2015-11-13 12:03:20,124 DEBUG : BROWSER_OUTPUT: Values: 183.0 185.0 200.0 206.0 206.0 188.0 206.0 191.0 198.0 200.0 12:03:20 INFO - 2015-11-13 12:03:20,124 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,124 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:91.70 Median:93.00 stddev:1.83 (2.0%) stddev-sans-first:1.66 12:03:20 INFO - 2015-11-13 12:03:20,124 DEBUG : BROWSER_OUTPUT: Values: 89.0 88.0 91.0 93.0 93.0 92.0 93.0 93.0 93.0 92.0 12:03:20 INFO - 2015-11-13 12:03:20,124 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:03:20 INFO - 2015-11-13 12:03:20,124 DEBUG : BROWSER_OUTPUT: 12:03:20 INFO - 2015-11-13 12:03:20,770 INFO : Browser exited with error code: 0 12:03:20 INFO - 2015-11-13 12:03:20,832 INFO : Completed test kraken (00:01:05) 12:03:20 INFO - 2015-11-13 12:03:20,832 INFO : Starting test v8_7 12:03:20 INFO - 2015-11-13 12:03:20,832 DEBUG : operating with platform_type : mac_ 12:03:20 INFO - 2015-11-13 12:03:20,832 INFO : Initialising browser for v8_7 test... 12:03:20 INFO - 2015-11-13 12:03:20,848 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmpIarkey/profile http://localhost:53238/getInfo.html 12:03:23 INFO - 2015-11-13 12:03:23,481 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:03:23 INFO - 2015-11-13 12:03:23,481 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:03:23 INFO - 2015-11-13 12:03:23,481 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:03:23 INFO - 2015-11-13 12:03:23,481 DEBUG : BROWSER_OUTPUT: __metrics 12:03:23 INFO - 2015-11-13 12:03:23,502 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:03:24 INFO - 2015-11-13 12:03:24,294 INFO : Browser initialized. 12:03:24 INFO - 2015-11-13 12:03:24,294 INFO : Running cycle 1/1 for v8_7 test... 12:03:24 INFO - 2015-11-13 12:03:24,295 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/T/tmpIarkey/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:03:36 INFO - 2015-11-13 12:03:36,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 229752832 12:03:36 INFO - 2015-11-13 12:03:36,527 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53238/tests/v8_7/run.html (next: http://localhost:53238/tests/v8_7/run.html) 12:03:59 INFO - 2015-11-13 12:03:59,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 311029760 12:03:59 INFO - 2015-11-13 12:03:59,372 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,373 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:03:59 INFO - 2015-11-13 12:03:59,373 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:03:59 INFO - 2015-11-13 12:03:59,373 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:03:59 INFO - 2015-11-13 12:03:59,373 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:03:59 INFO - 2015-11-13 12:03:59,373 DEBUG : BROWSER_OUTPUT: |0;Richards;216.91973969631238 12:03:59 INFO - 2015-11-13 12:03:59,373 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;251.13008538422903 12:03:59 INFO - 2015-11-13 12:03:59,373 DEBUG : BROWSER_OUTPUT: |2;Encrypt;401.4452027298274 12:03:59 INFO - 2015-11-13 12:03:59,373 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7389.705882352941 12:03:59 INFO - 2015-11-13 12:03:59,374 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2420.289855072464 12:03:59 INFO - 2015-11-13 12:03:59,374 DEBUG : BROWSER_OUTPUT: |5;Earley;1022.4948875255624 12:03:59 INFO - 2015-11-13 12:03:59,374 DEBUG : BROWSER_OUTPUT: |6;Boyer;16142.857142857143 12:03:59 INFO - 2015-11-13 12:03:59,374 DEBUG : BROWSER_OUTPUT: |7;RegExp;38018.51851851852 12:03:59 INFO - 2015-11-13 12:03:59,374 DEBUG : BROWSER_OUTPUT: |8;Splay;788.6435331230284 12:03:59 INFO - 2015-11-13 12:03:59,374 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7223.021582733813 12:03:59 INFO - 2015-11-13 12:03:59,375 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:03:59 INFO - 2015-11-13 12:03:59,375 DEBUG : BROWSER_OUTPUT: __startTimestamp1447445039368__endTimestamp 12:03:59 INFO - 2015-11-13 12:03:59,375 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,375 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:03:59 INFO - 2015-11-13 12:03:59,375 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:03:59 INFO - 2015-11-13 12:03:59,375 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,375 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:216.92 Median:216.92 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,376 DEBUG : BROWSER_OUTPUT: Values: 216.9 12:03:59 INFO - 2015-11-13 12:03:59,376 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,376 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:251.13 Median:251.13 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,376 DEBUG : BROWSER_OUTPUT: Values: 251.1 12:03:59 INFO - 2015-11-13 12:03:59,376 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,376 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:401.45 Median:401.45 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,376 DEBUG : BROWSER_OUTPUT: Values: 401.4 12:03:59 INFO - 2015-11-13 12:03:59,377 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,377 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7389.71 Median:7389.71 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,377 DEBUG : BROWSER_OUTPUT: Values: 7389.7 12:03:59 INFO - 2015-11-13 12:03:59,377 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,377 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2420.29 Median:2420.29 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,377 DEBUG : BROWSER_OUTPUT: Values: 2420.3 12:03:59 INFO - 2015-11-13 12:03:59,377 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,378 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1022.49 Median:1022.49 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,378 DEBUG : BROWSER_OUTPUT: Values: 1022.5 12:03:59 INFO - 2015-11-13 12:03:59,378 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,378 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16142.86 Median:16142.86 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,378 DEBUG : BROWSER_OUTPUT: Values: 16142.9 12:03:59 INFO - 2015-11-13 12:03:59,378 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,378 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:38018.52 Median:38018.52 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,379 DEBUG : BROWSER_OUTPUT: Values: 38018.5 12:03:59 INFO - 2015-11-13 12:03:59,379 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,379 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,379 DEBUG : BROWSER_OUTPUT: Values: 788.6 12:03:59 INFO - 2015-11-13 12:03:59,379 DEBUG : BROWSER_OUTPUT: 12:03:59 INFO - 2015-11-13 12:03:59,379 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7223.02 Median:7223.02 stddev:0.00 (0.0%) 12:03:59 INFO - 2015-11-13 12:03:59,379 DEBUG : BROWSER_OUTPUT: Values: 7223.0 12:03:59 INFO - 2015-11-13 12:03:59,380 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:03:59 INFO - 2015-11-13 12:03:59,380 DEBUG : BROWSER_OUTPUT: 12:04:00 INFO - 2015-11-13 12:04:00,090 INFO : Browser exited with error code: 0 12:04:00 INFO - 2015-11-13 12:04:00,115 INFO : Completed test v8_7 (00:00:39) 12:04:00 INFO - 2015-11-13 12:04:00,398 INFO : Completed test suite (00:20:21) 12:04:00 INFO - 2015-11-13 12:04:00,398 DEBUG : Working with test: dromaeo_css 12:04:00 INFO - 2015-11-13 12:04:00,398 DEBUG : Generating results file: dromaeo_css 12:04:00 INFO - 2015-11-13 12:04:00,399 DEBUG : Working with test: kraken 12:04:00 INFO - 2015-11-13 12:04:00,399 DEBUG : Generating results file: kraken 12:04:00 INFO - 2015-11-13 12:04:00,399 INFO : javascript benchmark 12:04:00 INFO - 2015-11-13 12:04:00,399 DEBUG : Working with test: v8_7 12:04:00 INFO - 2015-11-13 12:04:00,399 DEBUG : Generating results file: v8_7 12:04:00 INFO - 2015-11-13 12:04:00,400 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:04:00 INFO - 2015-11-13 12:04:00,453 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 12:04:00 INFO - 2015-11-13 12:04:00,453 DEBUG : process_Request line: dromaeo_css 5219.78 graph.html#tests=[[72,64,55]] 12:04:00 INFO - 2015-11-13 12:04:00,453 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:04:00 INFO - 2015-11-13 12:04:00,482 DEBUG : process_Request line: kraken 1918.90 graph.html#tests=[[232,64,55]] 12:04:00 INFO - 2015-11-13 12:04:00,482 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:04:00 INFO - 2015-11-13 12:04:00,521 DEBUG : process_Request line: v8_7 14640.53 graph.html#tests=[[230,64,55]] 12:04:00 INFO - 2015-11-13 12:04:00,522 INFO : javascript benchmark 12:04:00 INFO - 2015-11-13 12:04:00,525 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [255.88868842053708, 257.63673220758733, 262.20028911818946, 265.22686369233685, 270.5387314628559, 9982.650607228748, 10334.379937203774, 13799.586012419632, 14217.075890067139, 14237.430502779876, 9416.905830941689, 11571.0, 13545.0, 13774.104683195585, 13786.103903246281, 4207.368894665801, 4351.673624478177, 4362.825486980517, 4378.802953867068, 4383.75889326087, 2967.43618712445, 3131.780775345727, 4301.075268817203, 4301.26878430666, 4321.697481176319, 3133.5456358827955, 4579.427571553556, 4751.9762401187945, 4812.0857037163005, 4816.325714399987, 4646.721196728207, 4718.740469274188, 4746.169420351442, 4769.475357710649, 4791.736454495001, 3992.161646054303, 4047.5952404759582, 4092.058826469899, 4096.836126554934, 4099.118689481776, 9805.705828825146, 10069.54687039085, 10137.797244055078, 16390.754138687927, 16656.83343166577, 1362.50949658123, 1430.5851303122083, 1441.149721664223, 1467.3103641288578, 1513.5913303408129, 7287.344139027513, 7518.586477743722, 7551.433642476836, 7637.923620763777, 7683.270089341504, 1197.5150064224003, 1243.975120497585, 1253.5048655780915, 1260.7982722764314, 1272.662744372742, 41593.58406415927, 43332.350014749805, 45056.774716126536, 45668.54331456676, 47155.28447155291, 4990.30135780991, 5025.522575355335, 5103.081445339874, 5170.095233334151, 5171.5862730981435, 5789.9710501447225, 5814.622049566765, 5857.26784151981, 5902.61632993854, 5911.113333000085, 4073.1853629274265, 4101.2412703649325, 4120.052387950788, 4178.749275043507, 4205.74765514064, 4322.762248076386, 4327.913441731148, 4354.346847972829, 4407.0524837160165, 4420.115976804587, 2283.874386908703, 2290.931272061841, 2297.437127903674, 2324.3491822289784, 2346.16711067572, 809.7854068671807, 814.0313027497259, 817.1093508076225, 849.2569002123142, 876.1238761238761, 322.40677154036683, 337.1268414805665, 360.7114308553147, 361.138684238094, 365.84085922623746, 8517.531535765593, 8953.19334865916, 8992.190702836646, 9113.635454581876, 9124.49815260167, 305.76303364892385, 347.60373174580997, 359.76435434790255, 368.1385557794773, 373.35968813485005, 4645.326427667969, 4738.704395817669, 4812.06164797868, 4817.9036419272115, 4833.081714474239, 414580.0, 422233.0, 429764.0, 431000.0, 439752.0, 56218.71890640602, 56279.0, 56410.0, 56506.15240771392, 57562.42437575654, 378.70839453620556, 384.1184481614701, 385.2603002235714, 386.4087945443532, 388.19449641992975, 7910.2089791020435, 8185.181481852005, 8190.467619604707, 8193.79515512117, 8321.500709957421, 25842.61236081498, 26746.59880101839, 26949.0, 27872.0, 28079.298017549725, 36177.45733813942, 36385.45421818622, 36653.0, 36663.450048248764, 36987.44518832274, 4789.257665061921, 4844.588210002189, 4854.1747902857305, 4903.754812259444, 10302.33034852732, 7909.52542847431, 14195.716085678436, 14538.85461145375, 14758.409663613334, 14771.261436928326, 7237.63811809418, 7328.81677958034, 7379.963100184465, 7471.0, 7473.701051958078, 7029.121359830021, 7133.072700548895, 7200.387967022862, 7294.781156565312, 7511.136219334628, 6323.525735569759, 7185.461090418344, 7542.736004239825, 7592.39260859141, 7653.311201991624, 9278.443293402417, 9287.62849486013, 9379.0, 10162.441065741159, 11508.88491115078, 11221.60724374643, 11249.381284029458, 11652.766944661229, 11666.241694289844, 11695.76608467843], "dojo.html": [2409.265174121893, 2471.592187289097, 2498.4753201827616, 2523.369157710571, 2536.860472674003, 4005.0, 4118.7322824016455, 4127.380892866068, 4147.751134931907, 4227.852025179115, 4067.7966101694947, 4082.224377368298, 4191.308434108376, 4196.6013228743295, 4207.20063187994, 3777.112378591029, 3810.8475660973527, 3828.2152158807517, 3893.9026524336837, 3910.042039700277, 3788.1287303920117, 3860.9227815443674, 3904.063024874024, 3940.586238444965, 3996.620321069494, 3680.061584296014, 3693.261347730465, 3800.847966081381, 3862.9227415451815, 3880.165764360662, 3732.962670373289, 3830.2339532093415, 3838.673712734421, 3847.7498962567342, 3860.305145073886, 3818.618138186187, 3836.1368692044066, 3846.5961074087377, 3884.6698030667426, 3982.4623675803973, 3934.4098385242155, 4108.26051310764, 4129.2773764591075, 4147.294959856831, 4172.374143878412, 4288.69979101463, 4371.519132895379, 4381.189479946188, 4417.337399390085, 4440.977795111036, 4467.128909862578, 4488.640908727294, 4492.438445194351, 4566.680332376735, 4589.862304130881, 4009.3785463253244, 4171.082361880412, 4176.832926682899, 4243.087736136746, 4288.313869780851, 4476.26141686618, 4503.617192538605, 4579.152856721451, 4659.068186362741, 4661.627069834405, 4376.277914144131, 4398.450193725785, 4425.0, 4445.755483448442, 4481.126180394792, 4232.217039847638, 4492.73043617384, 4534.161180181611, 4556.430446194226, 4569.543045695404, 4328.61042506176, 4358.3244597087505, 4391.780410979438, 4410.20616289071, 4435.334699795057, 4380.7152535085115, 4424.402705634698, 4427.402300689366, 4496.505384407713, 4542.364069030338, 3353.9496907546404, 3467.3065386922212, 3493.039414161126, 3543.025667941337, 3551.6270791566512, 3058.98470507646, 3134.247780532701, 3135.9686403135674, 3148.937021259562, 3168.5247212917784, 4153.044799696087, 4212.178625168124, 4261.318189089793, 4313.8490152845125, 4317.848875289413, 4221.451211342506, 4520.751358675238, 4521.638268938477, 4558.658100642465, 4591.540845915449, 4076.612721791425, 4143.150654115899, 4161.126163505637, 4163.521195062606, 4283.957160428418, 3917.3536366499206, 3937.7046721496004, 3966.781826999543, 3973.6026397360033, 3990.082281075369, 4454.955450445454, 4633.513481084505, 4635.582797548237, 4677.766111694334, 4740.739259340631, 4426.9778651106535, 4475.6419486441655, 4511.661625378044, 4564.315352697122, 4570.063137056829, 4595.425571803525, 4635.768211589474, 4671.299305104261, 4683.695559788603, 4703.8824029398165, 4219.746815191098, 4393.033532622818, 4417.271150260171, 4482.75344856036, 4501.977490112659, 4092.795360232036, 4275.144971005749, 4313.525512193719, 4416.315471101984, 4512.887177820581, 4344.93482597755, 4370.213361594816, 4372.0818628088455, 4457.197704413107, 4472.262076757299, 4208.684348673801, 4360.585744354281, 4362.563743625612, 4459.264221403562, 4463.152001119777, 4187.811548480387, 4229.25987952101, 4231.851885184127, 4285.164392943346, 4433.8891527710775, 4366.585174408426, 4393.604575588212, 4429.025614364835, 4480.507144214199, 4504.301833215857, 4061.3907913813164, 4283.571642835816, 4320.675949303752, 4373.497047839539, 4413.139437809725], "mootools.html": [1206.197878410857, 1318.2354234543964, 1363.6386357615233, 1372.698006438584, 1406.1422532255328, 4924.9261261081065, 5125.7180855053, 5960.254968128978, 6070.969645151768, 6087.0, 6126.908096378558, 6141.72362243699, 6152.230971128609, 6234.438900498954, 6276.717547710353, 1633.6895989761967, 1695.4066076873119, 1695.9406420775276, 1727.1019070083548, 1735.9218835152449, 1690.6027083635336, 1723.4743403262, 1741.3556983915905, 1748.3356324596637, 1755.701530739771, 1691.264300029491, 1695.7965044194652, 1699.490152954109, 1708.7949446066489, 1713.8885972411815, 1663.8668906487574, 1679.7396403557468, 1699.9660006799857, 1710.7091794394983, 1712.6574685062974, 1696.2366934879353, 1701.5405840423016, 1718.218210714122, 1721.8019927708224, 1734.6183839555279, 5344.064788662007, 6084.787032453887, 6103.1455596216565, 6124.387561243884, 6143.4470897618985, 3263.184203949013, 3311.205310725433, 3561.6082230954576, 3654.3056819204267, 3673.742838001341, 2162.4593851537115, 2193.144673577306, 2218.1681869299014, 2245.9101635934708, 2248.235599896027, 559.644625662703, 665.6638397609177, 674.1068084787627, 684.3806355248458, 690.2097098821821, 8210.589470526449, 8249.133840946733, 8270.338372930151, 8282.13037631052, 8344.83310333796, 3226.6934641209045, 3231.1437469070715, 3308.0902751743465, 3312.2381852174135, 3337.215754297738, 7137.536060156073, 7145.785626431215, 7228.891566626505, 7241.74653887122, 7267.454940879349, 3674.5590529136675, 3681.5214022176947, 3742.8689995850013, 3749.6812770914776, 3763.0028042568742, 3330.333933213367, 3380.2732412531423, 3382.678645528671, 3386.610539787907, 3388.1698983748647, 2868.1108856254627, 2885.797994140432, 2893.4647090288363, 2920.576516405152, 2953.822770633769, 923.2475532441173, 929.2798081486902, 940.5955439161089, 945.4988855906381, 954.6420092465326, 990.6829814459304, 1018.5925629748012, 1041.9270651054505, 1048.7063622185801, 1052.2897044494935, 5825.155352473867, 5833.50415214703, 5840.182374467578, 5885.970570147208, 5913.172155898178, 338.20353068523275, 341.79150718061965, 343.5636741338486, 344.92411669432687, 346.32293865492903, 4506.369108324837, 4538.092381523643, 4592.7014744041535, 4594.264917613166, 4621.976890115528, 6882.070920425778, 6887.655617219119, 6976.790696279119, 7078.292170782881, 7127.786166415016, 6867.725290988405, 6911.619860907698, 6941.236463988957, 6974.163100427981, 7024.086868707035, 5146.742662866842, 5304.734763261821, 5537.501624853782, 5560.471755183251, 5564.387917329091, 5163.251328557413, 5627.099664053731, 5694.572907032072, 5762.596618236683, 5806.709664516842, 5870.412958704095, 6005.249343832021, 6040.546958978182, 6573.605583664996, 6623.138991931018, 6609.4712423005085, 6793.6942837573415, 6830.726770929107, 6896.034555162181, 6942.826429339105, 5392.406835248041, 5475.069238229431, 5478.424765399575, 5485.945140548703, 5525.972370138124, 5899.852503687443, 5951.672658003678, 5954.10688396744, 5973.193618861398, 6027.638341699512, 5220.190870415092, 5532.668039917457, 5580.441955804387, 5624.465675760796, 5645.379008309164, 5344.599155063308, 5444.210589464426, 5495.587830912617, 5510.504054634942, 5568.1091025435735, 5483.369412517452, 5510.752016159202, 5528.9723551381985, 5541.251930989426, 5556.083246264483, 4899.020195960893, 4904.2643603459765, 4914.631402644887, 4920.704757714549, 4927.482614325444, 4976.751162441936, 4983.725895075806, 5008.073506401327, 5015.247712843103, 5023.673461225008], "ext.html": [433.57942795488384, 436.4348169120988, 438.7126432186917, 452.45253243575274, 469.78624725749785, 23221.883890580546, 24088.759112408872, 30602.0, 31569.842150789213, 31676.208094797643, 33396.66603333966, 33461.15196752374, 33833.830830845814, 33947.83026084866, 34035.48946765794, 6296.968515157418, 6531.4448271896945, 7110.786676399716, 7325.267473252686, 7448.106227252737, 6438.871222575545, 8575.656973721043, 8735.257503112243, 8794.60424280909, 8808.383413161082, 8649.567521623925, 8660.783480412978, 8666.913330866673, 8686.391952563323, 8806.64773409063, 6604.768833090867, 6656.7670131545165, 6755.121834161577, 8602.827943441158, 8608.698695545658, 8580.270676992463, 8777.29781617469, 8826.117388261187, 8880.511571863544, 8908.287337013087, 30850.382992340026, 31472.685273147203, 31501.0, 31709.682903170902, 31939.0, 2141.0579345088267, 2174.053318905828, 2208.856424332413, 2236.439222324559, 2289.8626082435107, 21682.89158554213, 22406.0, 22448.55102897949, 22502.212422565295, 22986.310410687707, 1745.9214335354939, 1764.6382491589193, 1784.5895444047812, 1796.62270923105, 1813.3200049981258, 209597.0, 209771.0, 209945.0, 210071.0, 210571.0, 40847.59152408497, 42945.78527107407, 42959.57040429618, 47314.5268547317, 48291.758541207775, 49523.752381238584, 50304.748476258115, 50334.74832625814, 50520.74739626352, 50892.0, 11715.824262636068, 11744.119191060705, 11791.941040294916, 11831.17181797266, 11908.821367679491, 8669.479831210148, 8734.91265087341, 8817.559122044, 8839.779005524913, 8880.777980550538, 15882.37940739765, 15908.204589770698, 16043.598910027342, 16101.355945762272, 16124.0, 6195.19462469876, 6438.744444833213, 6449.290578036413, 6482.189726284215, 6538.444232240217, 704.4822055788991, 709.5565271705184, 773.9032620922385, 800.3597122302135, 834.9332053435711, 22691.546169076857, 22771.0, 22864.771352286265, 22950.540989180456, 23027.309180724606, 816.2123550773532, 840.2689659995842, 860.1269711243093, 862.719616124762, 877.9517126558101, 11718.23831450953, 11751.47118379675, 11860.822087668692, 11921.880781192078, 11994.460249288803, 265329.0, 268607.0, 269906.0, 270365.0, 270557.0, 43651.781741091094, 43885.78057109694, 43896.56103438989, 43945.0, 44194.33708494375, 1053.8840727519967, 1060.0459586372326, 1061.2040969273046, 1078.8759292681127, 1081.7241603391085, 21873.062848686754, 22187.889060554593, 22218.0, 22644.886775566018, 22677.773222267566, 38500.22999539937, 38913.41629875611, 39037.0, 39156.0, 39231.0, 224333.0, 233621.0, 237029.0, 237070.0, 237174.0, 21287.57424851525, 21510.354689359345, 25304.367390815376, 32774.67225327716, 33936.490952636224, 34232.486512701835, 35237.29525409529, 35536.46695299521, 36084.27831443304, 37078.44382334213, 28449.715502844705, 29587.0, 29855.402891941605, 29879.701202988563, 30023.0, 28847.711522884503, 29757.0, 30051.398972020874, 30284.24289392783, 30882.382352353277, 27475.587866182424, 27790.305242368293, 27839.0, 28920.0, 29042.419151617272, 25628.743712562635, 31276.0, 32503.0, 32804.507932380555, 33443.33113337768, 25919.481610368064, 26443.338916527242, 26856.865715671298, 26934.191974240803, 27224.863875680494], "prototype.html": [236.75850632355, 244.44023186901995, 245.22508871964584, 247.59518187763013, 253.75132370277117, 4880.341153944217, 4904.901901961963, 4967.180415231492, 4979.576735977437, 5004.199328107504, 4776.345338930303, 4837.346958160647, 4890.951090489094, 4898.363212782342, 4905.117078925792, 3739.046543131498, 3741.850325986957, 3755.9624403756025, 3782.546094468654, 3784.451254568079, 3750.4936833527536, 3754.6057663945303, 3756.211195648917, 3758.7368884178118, 3803.562590302123, 3525.1010992196952, 3612.277544491112, 3641.0, 3645.526081609387, 3720.8883733488037, 3691.7231207659534, 3692.556893172823, 3697.6856967157823, 3726.9440958385644, 3732.533433320821, 3178.2213357727273, 3202.5356323332985, 3219.4848824188016, 3236.3527294541186, 3263.78785378952, 4618.630509559261, 4651.348811166439, 4677.906441871178, 4686.906261874743, 4745.6440766942615, 4201.894952626179, 4204.831806727727, 4208.810603522848, 4230.280852255124, 4250.256205164115, 5113.948860511385, 5124.256982737519, 5163.7159956202395, 5168.664036837594, 5179.896402071938, 3450.6549345065546, 3502.2645244498685, 3516.525269088666, 3516.982415087908, 3518.6481351864863, 5088.7964481420695, 5312.309399778004, 5350.3312085989255, 5359.0, 5364.785408583613, 3405.625381208065, 3447.5690538682666, 3485.1635607454027, 3496.1084923344383, 3499.055255081114, 3524.9072787435975, 3532.3288575170636, 3558.412861877813, 3571.1786289153642, 3577.481265216529, 4097.487814023247, 4120.278951183531, 4159.188958153191, 4173.10278290169, 4175.248455278019, 4885.117780509517, 4948.05986862495, 5052.8484145475695, 5108.591312694975, 5120.897582048338, 1147.8048731715628, 1230.7415442757122, 1286.5368467351745, 1289.9290539020255, 1304.7325298313822, 833.7790485521342, 853.0360692417529, 856.3320609924269, 862.3661608717588, 870.3950754225752, 4886.60907127429, 4886.780094895738, 4938.925916111261, 4940.357753492023, 4942.1104201244125, 5309.097453432925, 5318.468153184728, 5332.573394128461, 5348.304720386403, 5363.5440987516495, 4896.632752543574, 4931.18635425158, 4940.086084074458, 4957.975210123926, 4995.300657907896, 2777.6111344411797, 2859.699731528201, 2871.813332133405, 2884.5096333623333, 2909.6944820793933, 5454.863628409242, 5473.698946557977, 5492.862678433071, 5494.972525137348, 5495.093309603951, 5438.755256013489, 5441.809536666197, 5447.019536483392, 5447.630280827852, 5474.534664553478, 5453.945460545423, 5463.562914966793, 5471.6169868108855, 5488.7530061147345, 5523.28197334344, 5178.404483484447, 5286.867828304323, 5326.920096198638, 5390.757415916371, 5454.972725136349, 5308.734563271743, 5325.360956685223, 5327.440618734977, 5329.946700532945, 5334.839954801362, 5585.218069470358, 5585.245991791056, 5593.0, 5600.927656767022, 5627.662340259598, 3491.2319289756215, 3503.5095086687375, 3509.3683137035578, 3527.7354198434705, 3534.6465353464446, 5172.508611681884, 5199.29809475716, 5369.919451208313, 5400.243965844864, 5430.049741295336, 5086.821961231339, 5113.7698803553185, 5157.535821776059, 5189.221616757516, 5212.322398088224, 5202.323697919246, 5232.9738351308, 5277.498637629419, 5284.9735751320995, 5288.206768984683, 5116.616253780907, 5116.846494605168, 5132.948670513397, 5138.537531622172, 5167.974160129175, 5065.062963351792, 5258.684478931276, 5269.998700246941, 5274.498922602346, 5285.127953887565, 5078.466760990191, 5089.592832573459, 5095.26118712792, 5108.080545501845, 5120.564751996122], "yui.html": [534.0600543044242, 562.4768964862676, 588.6968211371142, 597.1252115650568, 599.7211296747012, 10551.314164579297, 10836.295640783344, 10886.945565272183, 10887.401192934396, 10921.508532116053, 10100.69697909062, 10862.185336099785, 11065.834012489819, 11158.776824463506, 11176.608818691348, 536.3911959925493, 684.3156843156843, 693.6358411833802, 693.8300116471446, 702.0136707925373, 525.256761682221, 531.6411422289958, 686.4371215603207, 690.9412699920513, 693.5214701855704, 690.6995456976232, 700.1458220970408, 701.4388489208638, 707.900893874858, 712.4798896805336, 537.3068741323688, 556.9084594195382, 703.4653663215967, 712.7540998355558, 719.7480881691419, 398.2493000693684, 511.40166005773335, 512.1089304609989, 512.6949465068278, 526.2185654303356, 10317.43254121023, 10759.677209683721, 10774.19193560486, 10811.675649730521, 10866.130709543297, 7405.925940740632, 7665.156832748449, 7701.922980770177, 7959.482633628795, 8306.54314012729, 6761.576502322813, 7093.503454758169, 7102.609356485391, 7155.463340249502, 7181.6409179540815, 2154.138344662132, 2266.3767463947383, 2305.250793492122, 2438.1344622659053, 2459.7786199241973, 37325.626743732755, 37368.626313737055, 37378.43932341017, 37579.81210093959, 38060.80969595162, 5316.680999140064, 5442.12925931849, 5551.195076713854, 5573.0, 5722.856928576819, 9434.811303773886, 9516.333856630108, 9575.664851730295, 9603.663871764455, 9629.085236902483, 4729.243321068612, 4798.424189097331, 4926.8768280793265, 4928.334674818853, 4956.281339205795, 2763.322985868435, 2846.644169478815, 2899.492588796952, 2950.8377039263046, 2999.9550006749478, 2100.9684854727193, 2125.851190416656, 2126.2983215538834, 2137.593857167133, 2143.839212059102, 319.30391745993956, 321.15696297219796, 327.1412542077048, 330.7106282003247, 332.9983350083234, 383.593391005535, 433.68124428544996, 439.4265483543942, 454.372965307873, 471.8961828397747, 6187.412195841388, 6550.967245163743, 6776.830579235559, 6879.277675844064, 7009.509334346547, 340.6474299100419, 388.09573693294556, 455.3920516110963, 470.89640279138536, 498.93014977903124, 2846.288427893027, 2988.5965394671875, 3065.831379274117, 3068.1255842084897, 3073.0934374359617, 45622.543774562495, 46162.538374616495, 46412.767936160104, 46667.29999050017, 47139.0, 39600.0, 40614.39078413826, 40895.59104408977, 41065.0, 41333.379999300036, 36191.27617447636, 36811.0, 36909.07727306785, 37410.43884341683, 37830.0, 6203.348648391854, 6491.935080649133, 6586.70359833799, 6615.569987950767, 6684.665766711742, 26784.99999999922, 26941.191764247105, 27198.592021119304, 27941.58087628728, 28112.29719256953, 35003.0, 35960.82019589885, 36296.81851590725, 36549.26901462009, 36702.61433006846, 6018.097285407224, 6101.0, 6149.723262453111, 6258.906116408349, 6268.4671802897265, 8628.39601227908, 8641.524716140673, 8658.48049117055, 8936.374453788172, 9026.548672566476, 8276.131006244499, 8354.122817104117, 8358.0, 8441.409101362846, 8464.661413543636, 8338.749837504885, 8371.33029357662, 8406.243438090602, 8450.323974082181, 9020.548972551478, 8185.0, 8291.668333266844, 8323.292520135614, 8326.50040997542, 8351.457155284887, 6661.866762664623, 6915.135608048994, 7140.214576396696, 7203.963980180275, 7292.34368906801, 6563.573367731273, 6925.501546269098, 7221.458390620619, 7295.4528410368375, 7308.451866110169]}, "summary": {"lowerIsBetter": false, "suite": 5219.779634664923, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5550.305016151953, "unit": "ms", "value": 5550.305016151953}, "dojo.html": {"lowerIsBetter": false, "filtered": 4130.411619432862, "unit": "ms", "value": 4130.411619432862}, "mootools.html": {"lowerIsBetter": false, "filtered": 3378.973387621309, "unit": "ms", "value": 3378.973387621309}, "ext.html": {"lowerIsBetter": false, "filtered": 14908.544500389133, "unit": "ms", "value": 14908.544500389133}, "prototype.html": {"lowerIsBetter": false, "filtered": 3855.6582649455786, "unit": "ms", "value": 3855.6582649455786}, "yui.html": {"lowerIsBetter": false, "filtered": 4541.864701815061, "unit": "ms", "value": 4541.864701815061}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0076"}, "testrun": {"date": 1447443818, "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": "20151113104729", "branch": "Fx-Team", "revision": "186e5680b95a38845fe8fa7fa59656a6de0b496e"}}, {"talos_counters": {}, "results": {"audio-dft": [204.0, 206.0, 205.0, 204.0, 208.0, 204.0, 198.0, 206.0, 206.0, 207.0], "ai-astar": [131.0, 139.0, 134.0, 141.0, 142.0, 139.0, 128.0, 139.0, 139.0, 128.0], "imaging-gaussian-blur": [152.0, 148.0, 156.0, 156.0, 148.0, 148.0, 148.0, 148.0, 141.0, 148.0], "audio-beat-detection": [195.0, 166.0, 194.0, 206.0, 164.0, 192.0, 188.0, 163.0, 206.0, 162.0], "json-stringify-tinderbox": [81.0, 82.0, 82.0, 88.0, 87.0, 88.0, 88.0, 88.0, 89.0, 88.0], "stanford-crypto-pbkdf2": [183.0, 185.0, 200.0, 206.0, 206.0, 188.0, 206.0, 191.0, 198.0, 200.0], "json-parse-financial": [70.0, 72.0, 76.0, 76.0, 76.0, 76.0, 75.0, 76.0, 76.0, 77.0], "stanford-crypto-sha256-iterative": [89.0, 88.0, 91.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0], "audio-fft": [90.0, 105.0, 108.0, 156.0, 85.0, 87.0, 89.0, 90.0, 141.0, 86.0], "imaging-darkroom": [163.0, 163.0, 163.0, 162.0, 160.0, 155.0, 162.0, 162.0, 162.0, 163.0], "stanford-crypto-ccm": [161.0, 161.0, 172.0, 162.0, 159.0, 162.0, 166.0, 168.0, 180.0, 170.0], "audio-oscillator": [117.0, 123.0, 173.0, 115.0, 115.0, 116.0, 161.0, 114.0, 114.0, 167.0], "stanford-crypto-aes": [105.0, 113.0, 110.0, 112.0, 109.0, 111.0, 112.0, 111.0, 122.0, 113.0], "imaging-desaturate": [115.0, 120.0, 120.0, 120.0, 131.0, 119.0, 120.0, 129.0, 120.0, 121.0]}, "summary": {"lowerIsBetter": true, "suite": 1918.8999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 103.7, "unit": "ms", "value": 103.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 196.3, "unit": "ms", "value": 196.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 183.6, "unit": "ms", "value": 183.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 166.1, "unit": "ms", "value": 166.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 161.5, "unit": "ms", "value": 161.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 75.0, "unit": "ms", "value": 75.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 131.5, "unit": "ms", "value": 131.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 136.0, "unit": "ms", "value": 136.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 204.8, "unit": "ms", "value": 204.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 91.7, "unit": "ms", "value": 91.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 86.1, "unit": "ms", "value": 86.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 149.3, "unit": "ms", "value": 149.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 111.8, "unit": "ms", "value": 111.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 121.5, "unit": "ms", "value": 121.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0076"}, "testrun": {"date": 1447443818, "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": "20151113104729", "branch": "Fx-Team", "revision": "186e5680b95a38845fe8fa7fa59656a6de0b496e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [251.13008538422903], "Encrypt": [401.4452027298274], "NavierStokes": [7223.021582733813], "Decrypt": [7389.705882352941], "Splay": [788.6435331230284], "Richards": [216.91973969631238], "RegExp": [38018.51851851852], "Earley": [1022.4948875255624], "Boyer": [16142.857142857143], "RayTrace": [2420.289855072464]}, "summary": {"lowerIsBetter": false, "suite": 14640.526824515495, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 263.2818760000001, "unit": "score", "value": 263.2818760000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 663.0568709999999, "unit": "score", "value": 663.0568709999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 205.4541832669321, "unit": "score", "value": 205.4541832669321}, "Decrypt": {"lowerIsBetter": false, "filtered": 36.02051343283583, "unit": "score", "value": 36.02051343283583}, "Splay": {"lowerIsBetter": false, "filtered": 103.33058799999999, "unit": "score", "value": 103.33058799999999}, "RegExp": {"lowerIsBetter": false, "filtered": 23.961612274719904, "unit": "score", "value": 23.961612274719904}, "Richards": {"lowerIsBetter": false, "filtered": 162.74222, "unit": "score", "value": 162.74222}, "Earley": {"lowerIsBetter": false, "filtered": 651.8008139999998, "unit": "score", "value": 651.8008139999998}, "Boyer": {"lowerIsBetter": false, "filtered": 41.285318584070836, "unit": "score", "value": 41.285318584070836}, "RayTrace": {"lowerIsBetter": false, "filtered": 305.7439580838322, "unit": "score", "value": 305.7439580838322}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0076"}, "testrun": {"date": 1447443818, "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": "20151113104729", "branch": "Fx-Team", "revision": "186e5680b95a38845fe8fa7fa59656a6de0b496e"}}] 12:04:00 INFO - RETURN: dromaeo_css: 5219.78 12:04:00 INFO - RETURN: kraken: 1918.90 12:04:00 INFO - RETURN: v8_7: 14640.53 12:04:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "14640.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1918.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5219.78"}}} 12:04:00 INFO - Return code: 0 12:04:00 INFO - # TBPL SUCCESS # 12:04:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:04:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:04:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:04:00 INFO - 2015-11-13 12:04:00.675 screenresolution[1976:69393] starting screenresolution argv=screenresolution get 12:04:00 INFO - 2015-11-13 12:04:00.678 screenresolution[1976:69393] Display 0: 1600x1200x32@60 12:04:00 INFO - 2015-11-13 12:04:00.685 screenresolution[1977:69396] starting screenresolution argv=screenresolution list 12:04:00 INFO - Available Modes on Display 0 12:04:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:04:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:04:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:04:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:04:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:04:00 INFO - Intel HD Graphics 3000: 12:04:00 INFO - Chipset Model: Intel HD Graphics 3000 12:04:00 INFO - Type: GPU 12:04:00 INFO - Bus: Built-In 12:04:00 INFO - VRAM (Total): 512 MB 12:04:00 INFO - VRAM (Dynamic, Max): 10 12:04:00 INFO - Vendor: Intel (0x8086) 12:04:00 INFO - Device ID: 0x0116 12:04:00 INFO - Revision ID: 0x0009 12:04:00 INFO - Displays: 12:04:00 INFO - Display: 12:04:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:04:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:04:00 INFO - Display Serial Number: 1600x1200 60 12:04:00 INFO - Main Display: Yes 12:04:00 INFO - Mirror: Off 12:04:00 INFO - Online: Yes 12:04:00 INFO - Rotation: Supported 12:04:00 INFO - Return code: 0 12:04:00 INFO - Running post-action listener: _resource_record_post_action 12:04:00 INFO - Running post-run listener: _resource_record_post_run 12:04:02 INFO - Total resource usage - Wall time: 1268s; CPU: 30.0%; Read bytes: 45056; Write bytes: 686089216; Read time: 61; Write time: 49503 12:04:02 INFO - install - Wall time: 46s; CPU: 30.0%; Read bytes: 338567680; Write bytes: 334538752; Read time: 39583; Write time: 3548 12:04:02 INFO - run-tests - Wall time: 1223s; CPU: 30.0%; Read bytes: 36864; Write bytes: 340347904; Read time: 44; Write time: 45313 12:04:02 INFO - Running post-run listener: _upload_blobber_files 12:04:02 INFO - Blob upload gear active. 12:04:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:04:02 INFO - Copying logs to upload dir... 12:04:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1326.767463 ========= master_lag: 19.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2015-11-13 12:04:21.427120) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-13 12:04:21.431935) ========= 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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012166 build_url: 'https://queue.taskcluster.net/v1/task/hcHMJbW3R8OmbwcEHcN1uQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.99 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-13 12:04:22.435826) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:04:22.436238) ========= 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.De2uOnyp1O/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.DCW1DWPG9Z/Listeners TMPDIR=/var/folders/dr/ktlprtp52g3_lm39fsfxwnhh00000w/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.005907 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:04:22.531620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 12:04:22.532011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 12:04:22.548134) ========= ========= Total master_lag: 20.56 =========