builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0056 starttime: 1448302626.09 results: success (0) buildid: 20151123083130 builduid: 42649fd7ec914a07860f14dd62326a45 revision: 29f87d064607ef5683b5aec9eb7d0b732b101c08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.088574) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.089057) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.089348) ========= 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.LQDMyeLMvL/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.OcC8tJdbZB/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006124 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.112521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.112869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.131091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.131436) ========= 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.LQDMyeLMvL/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.OcC8tJdbZB/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005510 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.179451) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.179776) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.180138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.180415) ========= 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.LQDMyeLMvL/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.OcC8tJdbZB/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-23 10:17:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.22M=0.001s 2015-11-23 10:17:06 (8.22 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:06.294925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 10:17:06.295238) ========= 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.LQDMyeLMvL/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.OcC8tJdbZB/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019127 ========= master_lag: 1.43 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 10:17:07.740966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 10:17:07.741322) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29f87d064607ef5683b5aec9eb7d0b732b101c08 --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 29f87d064607ef5683b5aec9eb7d0b732b101c08 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LQDMyeLMvL/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.OcC8tJdbZB/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-23 10:17:07,776 truncating revision to first 12 chars 2015-11-23 10:17:07,776 Setting DEBUG logging. 2015-11-23 10:17:07,776 attempt 1/10 2015-11-23 10:17:07,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29f87d064607?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 10:17:08,988 unpacking tar archive at: fx-team-29f87d064607/testing/mozharness/ program finished with exit code 0 elapsedTime=1.451990 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 10:17:09.210533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:09.210894) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:09.221664) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:09.221992) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 10:17:09.222447) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-23 10:17:09.222856) ========= /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.LQDMyeLMvL/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.OcC8tJdbZB/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:17:09 INFO - MultiFileLogger online at 20151123 10:17:09 in /builds/slave/test 10:17:09 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 10:17:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:09 INFO - {'append_to_log': False, 10:17:09 INFO - 'base_work_dir': '/builds/slave/test', 10:17:09 INFO - 'blob_upload_branch': 'Fx-Team', 10:17:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:09 INFO - 'branch': 'Fx-Team', 10:17:09 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:09 INFO - 'config_files': ('talos/mac_config.py',), 10:17:09 INFO - 'default_actions': ('clobber', 10:17:09 INFO - 'read-buildbot-config', 10:17:09 INFO - 'download-and-extract', 10:17:09 INFO - 'populate-webroot', 10:17:09 INFO - 'create-virtualenv', 10:17:09 INFO - 'install', 10:17:09 INFO - 'run-tests'), 10:17:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:09 INFO - 'download_minidump_stackwalk': True, 10:17:09 INFO - 'download_symbols': 'ondemand', 10:17:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:09 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:09 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:09 INFO - 'installer_path': 'installer.exe', 10:17:09 INFO - 'log_level': 'info', 10:17:09 INFO - 'log_name': 'talos', 10:17:09 INFO - 'log_to_console': True, 10:17:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:17:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:17:09 INFO - 'opt_config_files': (), 10:17:09 INFO - 'pip_index': False, 10:17:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:17:09 INFO - 'cmd': ('bash', 10:17:09 INFO - '-c', 10:17:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:17:09 INFO - 'enabled': True, 10:17:09 INFO - 'halt_on_failure': False, 10:17:09 INFO - 'name': 'check_screen_resolution'},), 10:17:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:17:09 INFO - 'cmd': ('bash', 10:17:09 INFO - '-c', 10:17:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:17:09 INFO - 'enabled': True, 10:17:09 INFO - 'halt_on_failure': False, 10:17:09 INFO - 'name': 'check_screen_resolution'},), 10:17:09 INFO - 'run_cmd_checks_enabled': True, 10:17:09 INFO - 'sps_profile': False, 10:17:09 INFO - 'sps_profile_interval': 0, 10:17:09 INFO - 'suite': 'dromaeojs', 10:17:09 INFO - 'system_bits': '64', 10:17:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:09 INFO - 'title': 't-yosemite-r7-0056', 10:17:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:09 INFO - 'use_talos_json': True, 10:17:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:09 INFO - 'work_dir': 'build'} 10:17:09 INFO - ##### 10:17:09 INFO - ##### Running clobber step. 10:17:09 INFO - ##### 10:17:09 INFO - Running pre-action listener: _resource_record_pre_action 10:17:09 INFO - Running main action method: clobber 10:17:09 INFO - rmtree: /builds/slave/test/build 10:17:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:09 INFO - Running post-action listener: _resource_record_post_action 10:17:09 INFO - ##### 10:17:09 INFO - ##### Running read-buildbot-config step. 10:17:09 INFO - ##### 10:17:09 INFO - Running pre-action listener: _resource_record_pre_action 10:17:09 INFO - Running main action method: read_buildbot_config 10:17:09 INFO - Using buildbot properties: 10:17:09 INFO - { 10:17:09 INFO - "properties": { 10:17:09 INFO - "buildnumber": 14, 10:17:09 INFO - "product": "firefox", 10:17:09 INFO - "script_repo_revision": "production", 10:17:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:17:09 INFO - "repository": "", 10:17:09 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:17:09 INFO - "buildid": "20151123083130", 10:17:09 INFO - "slavename": "t-yosemite-r7-0056", 10:17:09 INFO - "pgo_build": "False", 10:17:09 INFO - "basedir": "/builds/slave/test", 10:17:09 INFO - "project": "", 10:17:09 INFO - "platform": "yosemite_r7", 10:17:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:17:09 INFO - "slavebuilddir": "test", 10:17:09 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:17:09 INFO - "branch": "fx-team", 10:17:09 INFO - "repo_path": "integration/fx-team", 10:17:09 INFO - "stage_platform": "macosx64", 10:17:09 INFO - "builduid": "42649fd7ec914a07860f14dd62326a45", 10:17:09 INFO - "revision": "29f87d064607ef5683b5aec9eb7d0b732b101c08" 10:17:09 INFO - }, 10:17:09 INFO - "sourcestamp": { 10:17:09 INFO - "repository": "", 10:17:09 INFO - "hasPatch": false, 10:17:09 INFO - "project": "", 10:17:09 INFO - "branch": "fx-team-macosx64-talos", 10:17:09 INFO - "changes": [ 10:17:09 INFO - { 10:17:09 INFO - "category": null, 10:17:09 INFO - "files": [ 10:17:09 INFO - { 10:17:09 INFO - "url": null, 10:17:09 INFO - "name": "https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 10:17:09 INFO - } 10:17:09 INFO - ], 10:17:09 INFO - "repository": "", 10:17:09 INFO - "rev": "29f87d064607ef5683b5aec9eb7d0b732b101c08", 10:17:09 INFO - "who": "mbanner@mozilla.com", 10:17:09 INFO - "when": 1448299085, 10:17:09 INFO - "number": 6695837, 10:17:09 INFO - "comments": "Bug 1227109. Tidy loop conversation window styles, remove temporarily work arounds that are no longer required and fix layout of standalone UI when in narrow views. r=mikedeboer", 10:17:09 INFO - "project": "", 10:17:09 INFO - "at": "Mon 23 Nov 2015 09:18:05", 10:17:09 INFO - "branch": "fx-team-macosx64-talos", 10:17:09 INFO - "revlink": "", 10:17:09 INFO - "properties": [ 10:17:09 INFO - [ 10:17:09 INFO - "buildid", 10:17:09 INFO - "20151123083130", 10:17:09 INFO - "Change" 10:17:09 INFO - ], 10:17:09 INFO - [ 10:17:09 INFO - "builduid", 10:17:09 INFO - "42649fd7ec914a07860f14dd62326a45", 10:17:09 INFO - "Change" 10:17:09 INFO - ], 10:17:09 INFO - [ 10:17:09 INFO - "pgo_build", 10:17:09 INFO - "False", 10:17:09 INFO - "Change" 10:17:09 INFO - ] 10:17:09 INFO - ], 10:17:09 INFO - "revision": "29f87d064607ef5683b5aec9eb7d0b732b101c08" 10:17:09 INFO - } 10:17:09 INFO - ], 10:17:09 INFO - "revision": "29f87d064607ef5683b5aec9eb7d0b732b101c08" 10:17:09 INFO - } 10:17:09 INFO - } 10:17:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 10:17:09 INFO - Running post-action listener: _resource_record_post_action 10:17:09 INFO - ##### 10:17:09 INFO - ##### Running download-and-extract step. 10:17:09 INFO - ##### 10:17:09 INFO - Running pre-action listener: _resource_record_pre_action 10:17:09 INFO - Running main action method: download_and_extract 10:17:09 INFO - mkdir: /builds/slave/test/build/tests 10:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:09 INFO - https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/test_packages.json 10:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/test_packages.json 10:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:17:11 INFO - Downloaded 1149 bytes. 10:17:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:17:11 INFO - Using the following test package requirements: 10:17:11 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:17:11 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:17:11 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 10:17:11 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:17:11 INFO - u'jsshell-mac.zip'], 10:17:11 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:17:11 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 10:17:11 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:17:11 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:17:11 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 10:17:11 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:17:11 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 10:17:11 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:17:11 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 10:17:11 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:17:11 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:17:11 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 10:17:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:17:11 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')]} 10:17:11 INFO - https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/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 10:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/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 10:17:12 INFO - Downloaded 17526912 bytes. 10:17:12 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 10:17:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:17:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:17:15 INFO - Return code: 0 10:17:15 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 10:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:15 INFO - https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/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 10:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/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 10:17:16 INFO - Downloaded 17526912 bytes. 10:17:16 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 10:17:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:17:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:17:19 INFO - Return code: 0 10:17:19 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')]} 10:17:19 INFO - https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/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 10:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/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 10:17:20 INFO - Downloaded 11130997 bytes. 10:17:20 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 10:17:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:17:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 10:17:21 INFO - Return code: 0 10:17:21 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')]} 10:17:21 INFO - https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 10:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gAt8FJ61SYKGS02LU5x8fA/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 10:17:23 INFO - Downloaded 109885519 bytes. 10:17:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:17:23 INFO - mkdir: /builds/slave/test/properties 10:17:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:17:23 INFO - Writing to file /builds/slave/test/properties/build_url 10:17:23 INFO - Contents: 10:17:23 INFO - build_url:https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:17:23 INFO - Running post-action listener: _resource_record_post_action 10:17:23 INFO - Running post-action listener: set_extra_try_arguments 10:17:23 INFO - ##### 10:17:23 INFO - ##### Running populate-webroot step. 10:17:23 INFO - ##### 10:17:23 INFO - Running pre-action listener: _resource_record_pre_action 10:17:23 INFO - Running main action method: populate_webroot 10:17:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:23 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:17:23 INFO - '../fennec_ids.txt'], 10:17:23 INFO - 'tests': ['tcheck2']}, 10:17:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:23 INFO - '--tppagecycles', 10:17:23 INFO - '7'], 10:17:23 INFO - 'tests': ['tsvgm']}}, 10:17:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:17:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:17:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:17:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:17:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:24 INFO - 'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:24 INFO - 'tests': ['damp', 'tps']}, 10:17:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:24 INFO - 'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['damp', 'tps']}, 10:17:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:17:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:24 INFO - 'other': {'tests': ['a11yr', 10:17:24 INFO - 'ts_paint', 10:17:24 INFO - 'tpaint', 10:17:24 INFO - 'sessionrestore', 10:17:24 INFO - 'sessionrestore_no_auto_restore']}, 10:17:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['a11yr', 10:17:24 INFO - 'ts_paint', 10:17:24 INFO - 'tpaint', 10:17:24 INFO - 'sessionrestore', 10:17:24 INFO - 'sessionrestore_no_auto_restore']}, 10:17:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['a11yr', 10:17:24 INFO - 'ts_paint', 10:17:24 INFO - 'tpaint', 10:17:24 INFO - 'sessionrestore', 10:17:24 INFO - 'sessionrestore_no_auto_restore']}, 10:17:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['a11yr', 10:17:24 INFO - 'ts_paint', 10:17:24 INFO - 'tpaint', 10:17:24 INFO - 'sessionrestore', 10:17:24 INFO - 'sessionrestore_no_auto_restore']}, 10:17:24 INFO - 'other_l64': {'tests': ['a11yr', 10:17:24 INFO - 'ts_paint', 10:17:24 INFO - 'tpaint', 10:17:24 INFO - 'sessionrestore', 10:17:24 INFO - 'sessionrestore_no_auto_restore']}, 10:17:24 INFO - 'other_nol64': {'tests': ['a11yr', 10:17:24 INFO - 'ts_paint', 10:17:24 INFO - 'tpaint', 10:17:24 INFO - 'sessionrestore', 10:17:24 INFO - 'sessionrestore_no_auto_restore']}, 10:17:24 INFO - 'svgr': {'tests': ['tsvgx', 10:17:24 INFO - 'tsvgr_opacity', 10:17:24 INFO - 'tart', 10:17:24 INFO - 'tscrollx', 10:17:24 INFO - 'cart']}, 10:17:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['tsvgx', 10:17:24 INFO - 'tsvgr_opacity', 10:17:24 INFO - 'tart', 10:17:24 INFO - 'tscrollx', 10:17:24 INFO - 'cart']}, 10:17:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:24 INFO - 'tests': ['tp5o']}, 10:17:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:24 INFO - 'talos_options': ['--e10s'], 10:17:24 INFO - 'tests': ['tp5o']}, 10:17:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:24 INFO - 'talos_options': ['--xperf_path', 10:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:24 INFO - 'tests': ['tp5n']}, 10:17:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:24 INFO - 'talos_options': ['--e10s', 10:17:24 INFO - '--xperf_path', 10:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:24 INFO - 'tests': ['tp5n']}}, 10:17:24 INFO - 'talos.zip': {'path': '', 10:17:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:24 INFO - Running post-action listener: _resource_record_post_action 10:17:24 INFO - ##### 10:17:24 INFO - ##### Running create-virtualenv step. 10:17:24 INFO - ##### 10:17:24 INFO - Running pre-action listener: _resource_record_pre_action 10:17:24 INFO - Running main action method: create_virtualenv 10:17:24 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17:24 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 10:17:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:24 INFO - Using real prefix '/tools/python27' 10:17:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:24 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:27 INFO - Installing pip.................done. 10:17:27 INFO - Return code: 0 10:17:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:27 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 0x10b326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc5358d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b24a9f0>, '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 0x10afa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/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.OcC8tJdbZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:27 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 10:17:27 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 10:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/Render', 10:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:27 INFO - 'HOME': '/Users/cltbld', 10:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:27 INFO - 'LOGNAME': 'cltbld', 10:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:27 INFO - 'MOZ_NO_REMOTE': '1', 10:17:27 INFO - 'NO_EM_RESTART': '1', 10:17:27 INFO - 'PAGER': '/bin/cat', 10:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:27 INFO - 'PWD': '/builds/slave/test', 10:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:27 INFO - 'SHELL': '/bin/bash', 10:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OcC8tJdbZB/Listeners', 10:17:27 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 10:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:27 INFO - 'USER': 'cltbld', 10:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:27 INFO - 'XPC_FLAGS': '0x0', 10:17:27 INFO - 'XPC_SERVICE_NAME': '0', 10:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:27 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 10:17:27 INFO - Cleaning up... 10:17:27 INFO - Return code: 0 10:17:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:27 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 0x10b326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc5358d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b24a9f0>, '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 0x10afa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/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.OcC8tJdbZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:27 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 10:17:27 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 10:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/Render', 10:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:27 INFO - 'HOME': '/Users/cltbld', 10:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:27 INFO - 'LOGNAME': 'cltbld', 10:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:27 INFO - 'MOZ_NO_REMOTE': '1', 10:17:27 INFO - 'NO_EM_RESTART': '1', 10:17:27 INFO - 'PAGER': '/bin/cat', 10:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:27 INFO - 'PWD': '/builds/slave/test', 10:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:27 INFO - 'SHELL': '/bin/bash', 10:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OcC8tJdbZB/Listeners', 10:17:27 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 10:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:27 INFO - 'USER': 'cltbld', 10:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:27 INFO - 'XPC_FLAGS': '0x0', 10:17:27 INFO - 'XPC_SERVICE_NAME': '0', 10:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:28 INFO - Downloading/unpacking psutil>=0.7.1 10:17:28 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 10:17:28 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 10:17:28 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 10:17:28 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 10:17:28 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 10:17:28 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 10:17:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:17:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:30 INFO - Installing collected packages: psutil 10:17:30 INFO - Running setup.py install for psutil 10:17:30 INFO - building 'psutil._psutil_osx' extension 10:17:30 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 10:17:31 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 10:17:31 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 10:17:31 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 10:17:31 INFO - building 'psutil._psutil_posix' extension 10:17:31 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 10:17:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:17:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:17:31 INFO - ^ 10:17:31 INFO - 1 warning generated. 10:17:31 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 10:17:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:31 INFO - Successfully installed psutil 10:17:31 INFO - Cleaning up... 10:17:31 INFO - Return code: 0 10:17:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:17:31 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')]} 10:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:31 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')]} 10:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:31 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 0x10b326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc5358d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b24a9f0>, '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 0x10afa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/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.OcC8tJdbZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:31 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 10:17:31 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 10:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/Render', 10:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:31 INFO - 'HOME': '/Users/cltbld', 10:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:31 INFO - 'LOGNAME': 'cltbld', 10:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:31 INFO - 'MOZ_NO_REMOTE': '1', 10:17:31 INFO - 'NO_EM_RESTART': '1', 10:17:31 INFO - 'PAGER': '/bin/cat', 10:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:31 INFO - 'PWD': '/builds/slave/test', 10:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:31 INFO - 'SHELL': '/bin/bash', 10:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OcC8tJdbZB/Listeners', 10:17:31 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 10:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:31 INFO - 'USER': 'cltbld', 10:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:31 INFO - 'XPC_FLAGS': '0x0', 10:17:31 INFO - 'XPC_SERVICE_NAME': '0', 10:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:17:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:17:34 INFO - Installing collected packages: mozsystemmonitor 10:17:34 INFO - Running setup.py install for mozsystemmonitor 10:17:34 INFO - Successfully installed mozsystemmonitor 10:17:34 INFO - Cleaning up... 10:17:34 INFO - Return code: 0 10:17:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:34 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 0x10b326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc5358d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b24a9f0>, '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 0x10afa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/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.OcC8tJdbZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:34 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 10:17:34 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 10:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/Render', 10:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:34 INFO - 'HOME': '/Users/cltbld', 10:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:34 INFO - 'LOGNAME': 'cltbld', 10:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:34 INFO - 'MOZ_NO_REMOTE': '1', 10:17:34 INFO - 'NO_EM_RESTART': '1', 10:17:34 INFO - 'PAGER': '/bin/cat', 10:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:34 INFO - 'PWD': '/builds/slave/test', 10:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:34 INFO - 'SHELL': '/bin/bash', 10:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OcC8tJdbZB/Listeners', 10:17:34 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 10:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:34 INFO - 'USER': 'cltbld', 10:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:34 INFO - 'XPC_FLAGS': '0x0', 10:17:34 INFO - 'XPC_SERVICE_NAME': '0', 10:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:34 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:34 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 10:17:34 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 10:17:34 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 10:17:34 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 10:17:34 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 10:17:34 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 10:17:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17: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 10:17: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 10:17: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 10:17: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 10:17: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 10:17: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 10:17:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:37 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 10:17:37 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 10:17:37 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 10:17:37 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 10:17:37 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 10:17:37 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 10:17:37 INFO - Downloading docopt-0.6.1.tar.gz 10:17:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:37 INFO - Running setup.py install for blobuploader 10:17:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:38 INFO - Running setup.py install for requests 10:17:38 INFO - Running setup.py install for docopt 10:17:38 INFO - Successfully installed blobuploader requests docopt 10:17:38 INFO - Cleaning up... 10:17:38 INFO - Return code: 0 10:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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 0x10b326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc5358d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b24a9f0>, '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 0x10afa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/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.OcC8tJdbZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17: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 10:17: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 10:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/Render', 10:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:38 INFO - 'HOME': '/Users/cltbld', 10:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:38 INFO - 'LOGNAME': 'cltbld', 10:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:38 INFO - 'MOZ_NO_REMOTE': '1', 10:17:38 INFO - 'NO_EM_RESTART': '1', 10:17:38 INFO - 'PAGER': '/bin/cat', 10:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:38 INFO - 'PWD': '/builds/slave/test', 10:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:38 INFO - 'SHELL': '/bin/bash', 10:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OcC8tJdbZB/Listeners', 10:17:38 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 10:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:38 INFO - 'USER': 'cltbld', 10:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:38 INFO - 'XPC_FLAGS': '0x0', 10:17:38 INFO - 'XPC_SERVICE_NAME': '0', 10:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-5IvIwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-HpCxP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-PoyLXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-mdH7DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-KZ2gSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-lz_mJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-eLECTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-VZXiDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:39 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-wYHs8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:40 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-qCwa4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:40 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-zkXWs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:40 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-TFkKZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:40 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-iHHmct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:40 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-uquaIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:40 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-mV10ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:40 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-fB6j1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:40 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-SIkc5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:40 INFO - Running setup.py install for manifestparser 10:17:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:41 INFO - Running setup.py install for mozcrash 10:17:41 INFO - Running setup.py install for mozdebug 10:17:41 INFO - Running setup.py install for mozdevice 10:17:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:17:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:41 INFO - Running setup.py install for mozfile 10:17:41 INFO - Running setup.py install for mozhttpd 10:17:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:41 INFO - Running setup.py install for mozinfo 10:17:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:41 INFO - Running setup.py install for mozInstall 10:17:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:42 INFO - Running setup.py install for mozleak 10:17:42 INFO - Running setup.py install for mozlog 10:17:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:42 INFO - Running setup.py install for moznetwork 10:17:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:42 INFO - Running setup.py install for mozprocess 10:17:42 INFO - Running setup.py install for mozprofile 10:17:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:42 INFO - Running setup.py install for mozrunner 10:17:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:42 INFO - Running setup.py install for mozscreenshot 10:17:43 INFO - Running setup.py install for moztest 10:17:43 INFO - Running setup.py install for mozversion 10:17:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:43 INFO - Cleaning up... 10:17:43 INFO - Return code: 0 10:17:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:43 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')]} 10:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:43 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')]} 10:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:43 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 0x10b326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc5358d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b24a9f0>, '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 0x10afa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/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.OcC8tJdbZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:43 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 10:17:43 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 10:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/Render', 10:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:43 INFO - 'HOME': '/Users/cltbld', 10:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:43 INFO - 'LOGNAME': 'cltbld', 10:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:43 INFO - 'MOZ_NO_REMOTE': '1', 10:17:43 INFO - 'NO_EM_RESTART': '1', 10:17:43 INFO - 'PAGER': '/bin/cat', 10:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:43 INFO - 'PWD': '/builds/slave/test', 10:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:43 INFO - 'SHELL': '/bin/bash', 10:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OcC8tJdbZB/Listeners', 10:17:43 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 10:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:43 INFO - 'USER': 'cltbld', 10:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:43 INFO - 'XPC_FLAGS': '0x0', 10:17:43 INFO - 'XPC_SERVICE_NAME': '0', 10:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:43 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-Y50kZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:43 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)) 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:43 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-6uQzKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:43 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)) 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:43 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-55BWC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:43 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)) 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-Q7v199-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:44 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-20asap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:44 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-c5xUc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:44 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-biIn4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:44 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-qi7qyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:44 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-wkXQBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:44 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-5ZgQNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-YqKsyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:44 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-2a4IN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:44 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)) 10:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:44 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-ZaTsV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:45 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-M1BVyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:45 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-g0FIS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:45 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-OpXif_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:45 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-91YtEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:45 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)) 10:17:45 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)) 10:17:45 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)) 10:17:45 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)) 10:17:45 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)) 10:17:45 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)) 10:17:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:45 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 10:17:45 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 10:17:45 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 10:17:45 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 10:17:45 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 10:17:45 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 10:17:47 INFO - Downloading blessings-1.5.1.tar.gz 10:17:47 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 10:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:47 INFO - Installing collected packages: blessings 10:17:47 INFO - Running setup.py install for blessings 10:17:47 INFO - Successfully installed blessings 10:17:47 INFO - Cleaning up... 10:17:47 INFO - Return code: 0 10:17:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:48 INFO - Reading from file tmpfile_stdout 10:17:48 INFO - Current package versions: 10:17:48 INFO - blessings == 1.5.1 10:17:48 INFO - blobuploader == 1.2.4 10:17:48 INFO - docopt == 0.6.1 10:17:48 INFO - manifestparser == 1.1 10:17:48 INFO - mozInstall == 1.12 10:17:48 INFO - mozcrash == 0.16 10:17:48 INFO - mozdebug == 0.1 10:17:48 INFO - mozdevice == 0.47 10:17:48 INFO - mozfile == 1.2 10:17:48 INFO - mozhttpd == 0.7 10:17:48 INFO - mozinfo == 0.9 10:17:48 INFO - mozleak == 0.1 10:17:48 INFO - mozlog == 3.1 10:17:48 INFO - moznetwork == 0.27 10:17:48 INFO - mozprocess == 0.22 10:17:48 INFO - mozprofile == 0.27 10:17:48 INFO - mozrunner == 6.11 10:17:48 INFO - mozscreenshot == 0.1 10:17:48 INFO - mozsystemmonitor == 0.0 10:17:48 INFO - moztest == 0.7 10:17:48 INFO - mozversion == 1.4 10:17:48 INFO - psutil == 3.1.1 10:17:48 INFO - requests == 1.2.3 10:17:48 INFO - wsgiref == 0.1.2 10:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10b326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc5358d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b24a9f0>, '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 0x10afa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/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.OcC8tJdbZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:48 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 10:17:48 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 10:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/Render', 10:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:48 INFO - 'HOME': '/Users/cltbld', 10:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:48 INFO - 'LOGNAME': 'cltbld', 10:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:48 INFO - 'MOZ_NO_REMOTE': '1', 10:17:48 INFO - 'NO_EM_RESTART': '1', 10:17:48 INFO - 'PAGER': '/bin/cat', 10:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:48 INFO - 'PWD': '/builds/slave/test', 10:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:48 INFO - 'SHELL': '/bin/bash', 10:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OcC8tJdbZB/Listeners', 10:17:48 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 10:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:48 INFO - 'USER': 'cltbld', 10:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:48 INFO - 'XPC_FLAGS': '0x0', 10:17:48 INFO - 'XPC_SERVICE_NAME': '0', 10:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:48 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)) 10:17:48 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)) 10:17:48 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)) 10:17:48 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)) 10:17:48 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)) 10:17:48 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)) 10:17:48 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)) 10:17:48 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)) 10:17: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:17:48 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)) 10:17:48 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)) 10:17:48 INFO - Cleaning up... 10:17:48 INFO - Return code: 0 10:17:48 INFO - Running post-action listener: _resource_record_post_action 10:17:48 INFO - Running post-action listener: _start_resource_monitoring 10:17:48 INFO - Starting resource monitoring. 10:17:48 INFO - ##### 10:17:48 INFO - ##### Running install step. 10:17:48 INFO - ##### 10:17:48 INFO - Running pre-action listener: _resource_record_pre_action 10:17:48 INFO - Running main action method: install 10:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:48 INFO - Reading from file tmpfile_stdout 10:17:48 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:48 INFO - Reading from file tmpfile_stdout 10:17:48 INFO - Output received: 10:17:48 INFO - Usage: mozinstall [options] installer 10:17:48 INFO - Options: 10:17:48 INFO - -h, --help show this help message and exit 10:17:48 INFO - -d DEST, --destination=DEST 10:17:48 INFO - Directory to install application into. [default: 10:17:48 INFO - "/builds/slave/test"] 10:17:48 INFO - --app=APP Application being installed. [default: firefox] 10:17:48 INFO - mkdir: /builds/slave/test/build/application 10:17:48 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'] 10:17:48 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 10:18:19 INFO - Reading from file tmpfile_stdout 10:18:19 INFO - Output received: 10:18:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:18:19 INFO - Running post-action listener: _resource_record_post_action 10:18:19 INFO - ##### 10:18:19 INFO - ##### Running run-tests step. 10:18:19 INFO - ##### 10:18:19 INFO - Running pre-action listener: _resource_record_pre_action 10:18:19 INFO - Running main action method: run_tests 10:18:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:19 INFO - 2015-11-23 10:18:19.143 screenresolution[6028:101927] starting screenresolution argv=screenresolution get 10:18:19 INFO - 2015-11-23 10:18:19.146 screenresolution[6028:101927] Display 0: 1600x1200x32@60 10:18:19 INFO - 2015-11-23 10:18:19.151 screenresolution[6029:101929] starting screenresolution argv=screenresolution list 10:18:19 INFO - Available Modes on Display 0 10:18:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:19 INFO - Intel Iris: 10:18:19 INFO - Chipset Model: Intel Iris 10:18:19 INFO - Type: GPU 10:18:19 INFO - Bus: Built-In 10:18:19 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:19 INFO - Vendor: Intel (0x8086) 10:18:19 INFO - Device ID: 0x0a2e 10:18:19 INFO - Revision ID: 0x0009 10:18:19 INFO - Displays: 10:18:19 INFO - Display: 10:18:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:19 INFO - Display Serial Number: 1600x1200 60 10:18:19 INFO - Main Display: Yes 10:18:19 INFO - Mirror: Off 10:18:19 INFO - Online: Yes 10:18:19 INFO - Rotation: Supported 10:18:19 INFO - Return code: 0 10:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:19 INFO - Python 2.7.3 10:18:19 INFO - Return code: 0 10:18:19 INFO - grabbing minidump binary from tooltool 10:18:19 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')]} 10:18:19 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 0x10b24a9f0>, '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 0x10afa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23d8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:19 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 10:18:19 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 10:18:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:19 INFO - Return code: 0 10:18:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:18:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:18:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:19 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/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0056', '--webServer', 'localhost'] in /builds/slave/test/build 10:18:19 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/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0056 --webServer localhost 10:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LQDMyeLMvL/Render', 10:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:19 INFO - 'HOME': '/Users/cltbld', 10:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:19 INFO - 'LOGNAME': 'cltbld', 10:18:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:19 INFO - 'MOZ_NO_REMOTE': '1', 10:18:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:19 INFO - 'NO_EM_RESTART': '1', 10:18:19 INFO - 'PAGER': '/bin/cat', 10:18:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:19 INFO - 'PWD': '/builds/slave/test', 10:18:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:19 INFO - 'SHELL': '/bin/bash', 10:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OcC8tJdbZB/Listeners', 10:18:19 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 10:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:19 INFO - 'USER': 'cltbld', 10:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:19 INFO - 'XPC_FLAGS': '0x0', 10:18:19 INFO - 'XPC_SERVICE_NAME': '0', 10:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:19 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/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0056', '--webServer', 'localhost'] with output_timeout 3600 10:18:19 INFO - mozversion INFO | application_buildid: 20151123083130 10:18:19 INFO - mozversion INFO | application_changeset: 29f87d064607ef5683b5aec9eb7d0b732b101c08 10:18:19 INFO - mozversion INFO | application_display_name: Nightly 10:18:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:19 INFO - mozversion INFO | application_name: Firefox 10:18:19 INFO - mozversion INFO | application_remotingname: firefox 10:18:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:18:19 INFO - mozversion INFO | application_vendor: Mozilla 10:18:19 INFO - mozversion INFO | application_version: 45.0a1 10:18:19 INFO - mozversion INFO | platform_buildid: 20151123083130 10:18:19 INFO - mozversion INFO | platform_changeset: 29f87d064607ef5683b5aec9eb7d0b732b101c08 10:18:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:18:19 INFO - mozversion INFO | platform_version: 45.0a1 10:18:19 INFO - 2015-11-23 10:18:19,687 DEBUG : using testdate: 1448302699 10:18:19 INFO - 2015-11-23 10:18:19,687 DEBUG : actual date: 1448302699 10:18:19 INFO - 2015-11-23 10:18:19,698 INFO : starting webserver on 'localhost:56214' 10:18:19 INFO - 2015-11-23 10:18:19,699 INFO : Starting test suite t-yosemite-r7-0056 10:18:19 INFO - 2015-11-23 10:18:19,699 INFO : Starting test dromaeo_css 10:18:19 INFO - 2015-11-23 10:18:19,699 DEBUG : operating with platform_type : mac_ 10:18:19 INFO - 2015-11-23 10:18:19,700 INFO : Initialising browser for dromaeo_css test... 10:18:19 INFO - 2015-11-23 10:18:19,712 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmp4G_NPI/profile http://localhost:56214/getInfo.html 10:18:21 INFO - 2015-11-23 10:18:21,997 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:18:21 INFO - 2015-11-23 10:18:21,997 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:18:21 INFO - 2015-11-23 10:18:21,998 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:18:21 INFO - 2015-11-23 10:18:21,998 DEBUG : BROWSER_OUTPUT: __metrics 10:18:22 INFO - 2015-11-23 10:18:22,016 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:18:22 INFO - 2015-11-23 10:18:22,275 DEBUG : BROWSER_OUTPUT: console.error: 10:18:22 INFO - 2015-11-23 10:18:22,276 DEBUG : BROWSER_OUTPUT: Message: Error: Transaction canceled due to a closed connection. 10:18:22 INFO - 2015-11-23 10:18:22,276 DEBUG : BROWSER_OUTPUT: Stack: 10:18:22 INFO - 2015-11-23 10:18:22,276 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:562:1 10:18:22 INFO - 2015-11-23 10:18:22,276 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:18:22 INFO - 2015-11-23 10:18:22,276 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 10:18:22 INFO - 2015-11-23 10:18:22,276 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:18:22 INFO - 2015-11-23 10:18:22,276 DEBUG : BROWSER_OUTPUT: 10:18:22 INFO - 2015-11-23 10:18:22,684 INFO : Browser initialized. 10:18:22 INFO - 2015-11-23 10:18:22,684 INFO : Running cycle 1/1 for dromaeo_css test... 10:18:22 INFO - 2015-11-23 10:18:22,685 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmp4G_NPI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:18:34 INFO - 2015-11-23 10:18:34,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 225558528 10:18:34 INFO - 2015-11-23 10:18:34,597 DEBUG : BROWSER_OUTPUT: 10:19:26 INFO - 2015-11-23 10:19:26,197 DEBUG : BROWSER_OUTPUT: 1448302766188 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] 10:21:36 INFO - 2015-11-23 10:21:36,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56214/tests/dromaeo/cssquery-ext.html) 10:21:38 INFO - 2015-11-23 10:21:38,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 400347136 10:21:38 INFO - 2015-11-23 10:21:38,103 DEBUG : BROWSER_OUTPUT: 10:24:40 INFO - 2015-11-23 10:24:40,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-ext.html (next: http://localhost:56214/tests/dromaeo/cssquery-jquery.html) 10:24:41 INFO - 2015-11-23 10:24:41,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 353726464 10:24:41 INFO - 2015-11-23 10:24:41,338 DEBUG : BROWSER_OUTPUT: 10:27:43 INFO - 2015-11-23 10:27:43,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56214/tests/dromaeo/cssquery-mootools.html) 10:27:44 INFO - 2015-11-23 10:27:44,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 329519104 10:27:44 INFO - 2015-11-23 10:27:44,018 DEBUG : BROWSER_OUTPUT: 10:30:46 INFO - 2015-11-23 10:30:46,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56214/tests/dromaeo/cssquery-prototype.html) 10:30:46 INFO - 2015-11-23 10:30:46,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 319647744 10:30:46 INFO - 2015-11-23 10:30:46,701 DEBUG : BROWSER_OUTPUT: 10:33:49 INFO - 2015-11-23 10:33:49,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56214/tests/dromaeo/cssquery-yui.html) 10:33:50 INFO - 2015-11-23 10:33:50,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 321699840 10:33:50 INFO - 2015-11-23 10:33:50,312 DEBUG : BROWSER_OUTPUT: 10:36:52 INFO - 2015-11-23 10:36:52,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-yui.html (next: http://localhost:56214/tests/dromaeo/cssquery-dojo.html) 10:36:53 INFO - 2015-11-23 10:36:53,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 392097792 10:36:53 INFO - 2015-11-23 10:36:53,220 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,220 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:36:53 INFO - 2015-11-23 10:36:53,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:36:53 INFO - 2015-11-23 10:36:53,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:36:53 INFO - 2015-11-23 10:36:53,220 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:36:53 INFO - 2015-11-23 10:36:53,222 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3375.3080618473214;3418.675225853545;3433.17603775094;3456.3236830137394;3497.737669674775;5562.888742225153;5724.313082430114;5754.482096611304;5756.02147634902;5758.827235182946;5713.571482138836;5744.396838331967;5766.394528574502;5926.407359264072;5936.821895343136;5091.923621145667;5122.974385128069;5161.019406312807;5180.559652429548;5230.163173892178;4788.162071637467;5273.841784746463;5324.807267077036;5327.493888080646;5399.676019438826;4528.913060865401;5133.717645529495;5225.503577160163;5262.631615786877;5272.551833094191;5157.7936882524655;5259.5529380002745;5265.236540701615;5265.657732247391;5266.578673706094;5144.922826157611;5231.947680523184;5239.5546378557865;5240.764165612519;5252.474752524755;5703.287089113861;5717.428257174291;5718.857028574277;5723.942760572382;5739.827805165852;6161.599496032743;6191.380861913773;6221.440070393686;6229.065640153968;6230.470410015154;5272.92090618641;6097.797685703621;6177.042558403455;6178.69106544671;6193.628382297032;5878.925218517303;5951.196588460546;5957.761689532457;5964.850878728023;6024.78913238039;6154.292256390483;6225.23939399975;6324.683765811691;6328.145700330489;6329.68351582419;5225.869353266123;6031.336552979169;6109.14471973924;6130.623687452916;6157.907631385533;6184.859575145173;6224.408681175281;6234.532410069263;6240.625562466266;6252.874942501216;6038.969805150946;6188.876222475616;6197.380261973766;6203.534734894901;6212.409821066992;6100.69496525172;6173.9073913891325;6178.196834411498;6219.036049412348;6242.625442473466;4990.2764099205415;4999.250112483084;5002.199648056294;5006.499350064964;5017.54842064216;4346.587074227943;4469.4636643602325;4475.731456112644;4482.8655140345845;4491.214037543416;5694.572907031989;5727.799527016535;5761.798337058183;5772.971135144381;5821.970890145522;6220.937790622126;6226.066090086432;6230.56386052981;6231.688415579203;6235.781747638811;5597.216389705444;5759.769609215585;5808.099744539603;5827.88344233113;5837.503812175928;5382.973085134549;5402.837914862561;5447;5452.754626041838;5489.64317319373;6316.652584107918;6345.841353966188;6360.427561519393;6360.459360954278;6370.490360771035;6126.23422072241;6252.406021427957;6255.31191568918;6260.624362538262;6268.247810262797;6218.22272215973;6237.407446292595;6251.499880009679;6324.335944725922;6343.904841427475;6169.56813023102;6198.2871969722255;6220.34686357944;6237.282712488122;6241.96879015602;5472.288602481811;6073.679564805565;6166.969165154145;6253.937460625336;6254.2807577129215;5305.726625609748;5985.790497332572;6108.72510737009;6114.2357205349335;6129.080637904171;5164.690118592896;5982.49148822355;6074.42292982166;6086.939130608637;6105.755769769159;4804.8798780030775;6002.69986500682;6003.609765365237;6021.819345419644;6026.758929642765;5905.5570832186895;5932.406759324033;6099.359567245376;6105.17580126695;6175.320714721467;6000.669963152069;6018.909716354171;6022.668753218615;6024.638521688713;6025.487833534024 10:36:53 INFO - 2015-11-23 10:36:53,223 DEBUG : BROWSER_OUTPUT: |1;ext.html;523.1807803037825;588.9399081653023;606.4541912278949;639.862429577641;648.0861984601712;30950.84524577377;31652;39272.018199545026;39606.20787584247;39706;43176.568234317725;43655.56344436554;43780.78109609456;43813.78093109538;43824.342634860506;8640.17918297764;8821.867671984925;9844.753881152974;10024.89975100247;10043.899561004406;8820.911790882074;8924.419912705653;8939.865902011476;12146.210496317755;12278.693032674166;12034.217775844541;12099.697507562338;12111;12126;12129.272243665408;10110.342827716175;12000.159988800788;12031.63905082849;12081.214721043192;12155.57455489058;8790.42862213954;8894.288456923496;8906.59920303588;11944.223625464318;12057.035437165006;40877;41246.58753412458;41320.96697582555;41383;41410.79294603538;3286.4248756467523;3651.8539258429632;3688.6311368863167;3750.3811871041244;3893.5133108361456;24492.775361231867;28495;28933.276668083257;30253.546196807067;30408.695913040807;2757;2798.5522316429274;2800.663920329553;2868.4693331733697;2869.411770587025;491490;495219.5239023854;495715;496094;496478;67242.66378668173;67535.32464675388;67722.32277677259;67749.98375024379;67897;72643;72766;72769.63615181996;72881.63559182276;73080;16389.42637007699;16404.589885252964;16501.257443415074;16561.337546498005;16614.83385166157;12300.446479908425;12332.965060764873;12364;12368.690782730504;12383.75232495363;21024.579508409744;21450.57098858014;21490.462738431663;21518.677219841717;21696.24063157782;9307.674231401868;9519.333646644669;9532.95233523828;9536.046395360408;9544.0455954404;915.6383228624655;956.5695437053354;966.7486453521994;1049.6483677967813;1106.5186643809968;27867.860660696973;28479.717249573278;29048.564271535943;29239.56140657892;29383.971560995262;990.3414229537277;1055.472263868066;1061.792950374685;1198.1133960868895;1222.896053835434;12501.43743531525;13987.720245595234;14727.042742221936;14950.028248163835;15659.590636842739;546567;547124;548069;548432;550168;58553.41446585565;59177;59209.70395148083;59281.70359148177;59295.703521482115;1408.0777091005407;1429.2139323372103;1450.717110163529;1453.055513915942;1460.664047269134;28955.98654047098;29317.973870914415;29395.979191341197;29438.852805735834;29755;50793.746031269606;50972.74513627408;51132.23301650404;51245;51324.74337628288;504968.47515762184;508035.75892723276;509332;509635;510415;28728.425431490836;29180.854095729384;32651.836740817093;32763;33760.831195843864;41208.201704713785;41912.580874192085;41995;42372;43111.784441077594;35244.29511409706;35317.64682353144;36307;36365;36413.27173456569;30670.619822107612;35058.474122888685;35423.46864797082;35947;36063.63936360603;34475.482867757506;35745.46381804223;39102.6089739099;39431.211375772895;40937.38593921034;32649.34701306008;33324.16689582683;33650.49524257089;33654.49518257277;33863;23965.64051539263;24667.506649866544;24906.26031136537;25504.234872953843;25782 10:36:53 INFO - 2015-11-23 10:36:53,227 DEBUG : BROWSER_OUTPUT: |2;jquery.html;360.2237178879516;362.945558166275;365.3113880335567;368.6810908564092;370.7423340778159;15373;16506;19514.804851951478;20194.293199737993;20890.89554552225;11690.240134391259;11922.28466292023;11929.105317101208;15391.230438478087;20958.790412095874;3980.8606698765548;5231.189165679326;5371.409144994067;5387.299651045379;5402.270693456392;4052.898677533056;4109.4246805447265;5747.741351639186;5933.495652869511;5936.198613187229;5758.568107391941;5900.940990590104;5905.468507834294;5924.674142922137;5927.525797936176;5836.912446313288;5930.051191809312;5940.465358117768;5943.108533719934;5954.612950158225;5455.727213639302;5621.0444224481935;5627.324721033461;5636.830895073154;5640.943590564083;12729.299888506128;12915.806262906064;12925.612231633066;18901.905490472596;24889.377765555826;2182.443476913377;2198.2855571939185;2207.6578130389653;2212.9114835406563;2228;9588.185004274575;9650.517474126265;9926;9959.80080398388;10080.143187829044;1679.3198754504444;1724.9051302178375;1737.0880287848854;1740.4778566430148;1742.8692848036321;78697.03257418553;100232;100639;101960;103382.99999999924;11113.22207445471;11113.444327783578;11167.329960202414;11176.832347514794;11190.608328708619;13227.470901164039;13333.466661333438;13341.399637016357;13349.666258343424;13367.732645347038;7525.6989720410575;7778.794286885542;8238.752837414888;8296.460730052528;8307.792305192419;8307;8307.750767476986;8312.459690120122;8372.162783721578;8392.916070839336;3981.8407263709705;4205.3481710334945;4250.723702959298;4296.37702533131;4299.333603291495;1458.2490017640923;1768.628587996535;1773.3084097202102;1794.420909599544;1798.190814133645;839.8236370362171;904.2856143646445;933.5285680731188;940.2853831088422;1003.392947266893;20200.292989745583;20804.271850485464;20877.478063048544;21101.577968440546;21174.153033878472;858.3176374782063;908.68650315641;912.6258234123977;1021.7649940513575;1062.6333914799382;7992;10678.145748340114;10694.465276736131;10698.51856666452;10720.035196832323;665017;688286;723705;723851;752555;114429;119568;119741;119765;119911;1244.7448273103812;1244.8568414632252;1288.9742205155844;1316.4207748590782;1331.9533816316382;17841.43171365706;18034.549136271697;18051;18101.909490452465;18154.636907262044;48621.75689121673;49113.754431227615;49568;49736;49943;68287.63424731577;69259;70791.9381209272;77726.2227377719;79567;16134.515964521082;16243.51269461918;16861.66276674484;16928.068956207528;17029.57426064358;14481.637959051108;17143.399981000606;19617.60764784725;20293.98530073461;21273.468163296042;15597;16711.582210444834;16915.577110572332;16936.491905242863;17939.103044847965;9636.855447168438;9849.753756156153;9911.553980071058;9942.552585133832;15308.540743777705;8136.959315203623;9921.751956200864;10195.7451063724;10231.744206394602;10251.38491690501;16011.879168458096;16149.75775363347;16249;16324.265408056903;16426;16057.11685857289;16210.27053782559;16255.349786008901;16798.832011680217;16894.23975921062 10:36:53 INFO - 2015-11-23 10:36:53,228 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1656.3788579282766;1697.8896371735843;1906.045629274624;1913.6941880768272;1996.4210378990094;7529.962350188248;7705.229477052292;7716.575588342646;7717.151113377524;7725.420593455485;7883.3693304535645;8260.173982601736;8457.873131903027;8474.152584741523;8496.575171241444;2291.3126062181323;2373.5727569037567;2375.156819329139;2375.7743014413604;2376.5128148729555;2148.6347320955474;2189.5730332585154;2192.27654873892;2359.221456919221;2386.689730335054;2146.2595404585472;2173.9891300543477;2325.662778897059;2368.159303447277;2371.5494056129282;2281.178775640768;2341.391238278043;2345.7536958619357;2349.7532759060223;2351.0243249051623;2119.5125121222204;2340.157543284416;2374.0266490738886;2375.2517956843712;2378.881055947196;7727.65225564851;7840.255175758294;7864.567448790314;7873.173316801711;7882.5270483771155;5061.5950723942;5207.661502002357;5235.319408476912;5238.528532432099;5267.973660131714;3092.9793168254423;3498.8950331490096;3531.0289670340603;3537.540119784437;3584.4981702561663;1026.1790567546009;1044.5143008501084;1058.0794708603564;1058.7353161709573;1062.3678911047914;11060.004599586076;11102.722431939186;11108.16688748347;11110.61112861046;11162.162837787117;4651.069786042805;4655.534446555385;4711.269753188261;4737.976310118427;4749.715017098985;9768.755781105387;9771.657991970389;9771.951140244395;9791.461469619097;9796.069373409515;4548.56788605082;5269.947300527022;5290.576753859682;5290.735463226823;5293.629445938825;4767.951050768826;4774.570288673966;4803.519648035169;4813.470518243061;4822.324874517571;3637.4725664778457;3708.3325001499447;3715.3126671565847;3717.5724791648768;3746.868859589901;1119.3787447966456;1122.063077330422;1131.213806404541;1137.8862113788555;1138.2203190814153;1334.3261652865435;1339.4441306857545;1356.986430135686;1369.698666293414;1408.4155075643698;7312.561246325237;7436.590987495631;7740.993670822757;7873.921260787319;7912.169222231698;496.60519886689445;501.94478607353165;509.26157072244655;509.2717414097876;511.3914441814229;5925.911111333334;6086.847828804227;6162.599431036968;6232;6234.096056071844;9598.136167744937;9858.901410985798;9902;9926.106650401498;9982.251331150193;9826.508674566387;9931.950340248253;10059.597616095421;10064.74838129038;10121.443320617436;7211.603361815046;7784.182660820646;7911.406644501685;7911.5363657722355;7956.761297161094;6689.632070236184;7360.411167106726;7775.961120194363;7873.763787086396;7883.172266911892;8873;9080.90919090827;9126.361154719372;9220.492872892055;9226.215771659216;9124.543772811465;9299.907000929905;9408.95295523518;9475.289353298393;9577.473238971923;7367;7382.2617738225745;7404.888926665996;7434;7498.100227972678;7999;8058.798530036796;8063.314618257514;8065.354771618139;8076.798080048045;7446.7021319146625;7521.962390188233;7543.962280188564;7678.577678227528;7693.076830780342;7353.889691654736;7384.741534046498;7408.555486670817;7461.328480436787;7527.548347099191;7544.283293087148;7580.583067931317;7585.16563178061;7606.239376062571;7617.847643047219;6836.38472537474;6861.965690171717;6888.242293347627;6906.689198985957;6925.792226233221;6748.73005079811;6800.353966373186;6805.319468053155;6805.319468053155;6811.250762416031 10:36:53 INFO - 2015-11-23 10:36:53,229 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.530422930407;326.7239182890457;328.7320833520679;330.6511630230107;333.52472726364925;6629.403353698166;6662.233843108044;6712.9664351678175;6725.663716814158;6740.393364597186;6628.867422651544;6632.336766323365;6634.9668251658795;6640;6641.0702501649685;4879.756012199394;4901.264810278469;4902.583280421169;4907.852764417074;4915.434725006634;4723.3859598252175;4788.994311194653;4799.5680388765;4882.536159064884;4884.511548845105;4208.22147902639;4767.356406885078;4782.641301902371;4786.593139583122;4786.976065119687;4584.633229341644;4625.653076019278;4672.20572502672;4787.880302992418;4796.592289655366;3981.2634662587516;4046.5144182698264;4083.8774836754947;4085.4076158956786;4100.979495102535;6343.777967771106;6350.936490635081;6354.205724284465;6358;6398.16823812906;5465.098258787295;5554.0835762099205;5596.636218645775;5619.129034999582;5692.829215123512;6520.282768895418;6543.149390579242;7057.717691292342;7108.786736397917;7144.9642751785905;4122.6395289554675;4268.87193384199;4584.083183363307;4593.28804035375;4601.792919318638;6501.894677904767;6739.52823302374;7328.487005909588;7465.514741541837;7551.622418879034;4758.571728544378;4808.519148085164;4820.542048505386;4823.204171311694;4843.467218606021;4148.709590328648;4900.191468407673;4916.680415772963;4917.65576409655;4920;5788.913166302509;5790.855228619234;5792.507636850914;5801.419858014249;5811.651300921958;6927;7106.324899134574;7110.5022648414115;7112.217656057829;7119.038929744418;1696.7539706742452;1715.9313627455012;1717.6822287876782;1719.346648273648;1721.0878234535467;1108.9168312376603;1121.3047910295668;1125.3248051169396;1130.813415786386;1150.0339714639576;5346.8663283417445;5871.32479764824;5990.371011043865;6533.333999830108;6558.311377305409;6079.787207447718;6713;7429.294217049372;7430.554166750012;7448.5158464699625;5314.92027619586;6282.371762823681;6474.093626892239;6500.252470965899;6507.609543427409;3920.0591857954455;3956.5647778744315;3961.504811898513;3972.0467087898696;3989.68082553395;7664.616769161519;7664.923350766532;7694.73068442613;7698.961505192438;7725.266099720518;7102.893456598155;7418.480706350504;7593.6582853771715;7699.26856948589;7709;7554.584497852561;7644.082710074605;7658.578778167142;7675.539467632072;7679.731209407644;7395.001674773836;7528.322450979438;7549;7559.3196612305155;7570.697172113274;7214.3188611176;7318.853622927405;7367.8158046049275;7369.8157546061775;7403.407727381689;7714.459987801025;7720.112187098555;7720.806979825325;7739.806504837424;7740.380769538311;4815.422149342101;4817.494163112823;4821.7348045856415;4824.34871292371;4832.685875418087;6563.474922006132;6701.899471508029;7421.220771818881;7457.179710231979;7501.474896757175;5859;6179.258488981351;6289.308176100534;6788.9660551696925;7215;5819.912701309399;7166.140063192451;7176.282371762782;7188.748393806401;7210.459215558749;5687.886242275049;6782.118324617768;7003.404710599452;7010.544314619533;7045.189803172496;7139.286071392819;7147.356737893615;7151.177614574182;7155.212926578176;7156.892646610201;6742.123523941857;6800.251972282946;6994.2306346302885;6994.615296158557;7020.5779006242765 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: |5;yui.html;741.5328343143818;744.192551082076;795.5505139596128;832.3258160889679;836.41450984311;15005.474808381696;15337.539873803804;15403.537893863175;15444.227788610566;15467.071975681467;14121.152730836156;14253.002289839715;14253.78619320711;14271.215083170422;14277.571672849805;756.7427074794582;772.8956590860246;773.957432341221;774.9922500774976;960.1838437328284;969.3795970578835;971.4365667912593;984.7045886234101;986.7927735175622;988.298308201178;1009.5103874620803;1026.9935463246024;1029.0584115534277;1029.526417847791;1031.03083101884;791.2048391366698;801.7755028592004;803.3693550562809;804.7344376355788;1009.8838633557125;592.0054308761322;603.3664652115261;744.7207297263526;767.4014268870234;769.2845653542204;14976.850231497654;15152.924235378863;15153.166575838324;15165.848341516554;15175;12515.749685006249;12809.935950320281;12913.741725165444;13069.86930130696;13191.604251872459;10109.342892712024;10148.137408320228;10193.23550733698;10221.795564088676;10226.6420675276;3529.8764543240864;3561.8753343632848;3564.215872508044;3566.037169964121;3566.7681600695873;78756.60621696855;79508.60245698792;80389.19610803876;80722;80896;9736.318457708034;9823.950880245553;9941.900580994243;9979.650712225182;10391.636292729718;21966.89016554939;22089.226877059227;22099.668504972436;22369.776302237096;22423.32730018102;7319.085114360705;7397.704091836374;7491.587962662106;7601.239876012465;7627.275408836152;3860.942085868714;3909.179072394772;3915.7846318452757;3940.014996250937;3992.940105898414;3582.444721068239;3642.6539478750005;3642.908927276839;3644.908877278036;3647.1429214134655;558.902192116378;637.2480473041762;649.9837504062342;670.0719503487704;670.6110455935545;542.7787478174108;576.2566289486515;618.7988903606346;640.814163892466;644.6196743921015;8029;8281.95859020701;8417.200365965224;8428.410011299273;8490.320774338039;531.6331731105524;544.2081771023152;557.3673880146064;625.7371903800415;634.9365063493614;3245.881756454485;3417.333619944137;3967.805916237399;3997.5940866228398;4123.835046598162;93922.53038734762;94890.52554737183;95814;95901.52049239709;96060.07879842364;82066.17933820705;82929.3414131714;83637.58181209055;83814.58092709497;84046.57976710077;69929;69957;70493.29506704868;71576.64211679013;72048.63975680088;8135.7966050846835;8143.267105960492;8194.50832950025;8326.83346333082;8376.120507346885;52266.47733522616;52364.47635523596;52662.736686317854;52838.47161528336;53796.73101634467;56634.716826415606;68542.65728671325;72287;73074.26925730675;73496;10278.389586681724;10450.320729152581;10481.580736770444;10520.736981575521;10985;11107.333559986426;11355.602553910574;11489.425528723363;11741.589044383405;12005.099617528895;10223.948880255552;10483.37099774016;10829.025387715143;10842.24104312722;11349.54601815918;9648.71053868357;9897.604095836086;10211.897881021094;10555.522226888395;10747.946260268649;10123.392596444237;10675;10677;10900.127989760642;11187.72030699239;9424.246060315021;9593.32846700752;9597;9774.266929980138;9802.852957205505;9094.681686140953;9935.304528682922;9953.253505987224;9977.351472154287;10173.593056277667 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1483 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: __startTimestamp1448303813218__endTimestamp 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:36:53 INFO - 2015-11-23 10:36:53,233 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:36:53 INFO - 2015-11-23 10:36:53,234 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,234 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5725.69 Median:5982.49 stddev:631.96 (10.6%) stddev-sans-first:606.40 10:36:53 INFO - 2015-11-23 10:36:53,234 DEBUG : BROWSER_OUTPUT: Values: 3375.3 3418.7 3433.2 3456.3 3497.7 5562.9 5724.3 5754.5 5756.0 5758.8 5713.6 5744.4 5766.4 5926.4 5936.8 5091.9 5123.0 5161.0 5180.6 5230.2 4788.2 5273.8 5324.8 5327.5 5399.7 4528.9 5133.7 5225.5 5262.6 5272.6 5157.8 5259.6 5265.2 5265.7 5266.6 5144.9 5231.9 5239.6 5240.8 5252.5 5703.3 5717.4 5718.9 5723.9 5739.8 6161.6 6191.4 6221.4 6229.1 6230.5 5272.9 6097.8 6177.0 6178.7 6193.6 5878.9 5951.2 5957.8 5964.9 6024.8 6154.3 6225.2 6324.7 6328.1 6329.7 5225.9 6031.3 6109.1 6130.6 6157.9 6184.9 6224.4 6234.5 6240.6 6252.9 6039.0 6188.9 6197.4 6203.5 6212.4 6100.7 6173.9 6178.2 6219.0 6242.6 4990.3 4999.3 5002.2 5006.5 5017.5 4346.6 4469.5 4475.7 4482.9 4491.2 5694.6 5727.8 5761.8 5773.0 5822.0 6220.9 6226.1 6230.6 6231.7 6235.8 5597.2 5759.8 5808.1 5827.9 5837.5 5383.0 5402.8 5447.0 5452.8 5489.6 6316.7 6345.8 6360.4 6360.5 6370.5 6126.2 6252.4 6255.3 6260.6 6268.2 6218.2 6237.4 6251.5 6324.3 6343.9 6169.6 6198.3 6220.3 6237.3 6242.0 5472.3 6073.7 6167.0 6253.9 6254.3 5305.7 5985.8 6108.7 6114.2 6129.1 5164.7 5982.5 6074.4 6086.9 6105.8 4804.9 6002.7 6003.6 6021.8 6026.8 5905.6 5932.4 6099.4 6105.2 6175.3 6000.7 6018.9 6022.7 6024.6 6025.5 10:36:53 INFO - 2015-11-23 10:36:53,234 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,234 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66355.75 Median:35584.47 stddev:137731.24 (387.1%) stddev-sans-first:138028.92 10:36:53 INFO - 2015-11-23 10:36:53,234 DEBUG : BROWSER_OUTPUT: Values: 523.2 588.9 606.5 639.9 648.1 30950.8 31652.0 39272.0 39606.2 39706.0 43176.6 43655.6 43780.8 43813.8 43824.3 8640.2 8821.9 9844.8 10024.9 10043.9 8820.9 8924.4 8939.9 12146.2 12278.7 12034.2 12099.7 12111.0 12126.0 12129.3 10110.3 12000.2 12031.6 12081.2 12155.6 8790.4 8894.3 8906.6 11944.2 12057.0 40877.0 41246.6 41321.0 41383.0 41410.8 3286.4 3651.9 3688.6 3750.4 3893.5 24492.8 28495.0 28933.3 30253.5 30408.7 2757.0 2798.6 2800.7 2868.5 2869.4 491490.0 495219.5 495715.0 496094.0 496478.0 67242.7 67535.3 67722.3 67750.0 67897.0 72643.0 72766.0 72769.6 72881.6 73080.0 16389.4 16404.6 16501.3 16561.3 16614.8 12300.4 12333.0 12364.0 12368.7 12383.8 21024.6 21450.6 21490.5 21518.7 21696.2 9307.7 9519.3 9533.0 9536.0 9544.0 915.6 956.6 966.7 1049.6 1106.5 27867.9 28479.7 29048.6 29239.6 29384.0 990.3 1055.5 1061.8 1198.1 1222.9 12501.4 13987.7 14727.0 14950.0 15659.6 546567.0 547124.0 548069.0 548432.0 550168.0 58553.4 59177.0 59209.7 59281.7 59295.7 1408.1 1429.2 1450.7 1453.1 1460.7 28956.0 29318.0 29396.0 29438.9 29755.0 50793.7 50972.7 51132.2 51245.0 51324.7 504968.5 508035.8 509332.0 509635.0 510415.0 28728.4 29180.9 32651.8 32763.0 33760.8 41208.2 41912.6 41995.0 42372.0 43111.8 35244.3 35317.6 36307.0 36365.0 36413.3 30670.6 35058.5 35423.5 35947.0 36063.6 34475.5 35745.5 39102.6 39431.2 40937.4 32649.3 33324.2 33650.5 33654.5 33863.0 23965.6 24667.5 24906.3 25504.2 25782.0 10:36:53 INFO - 2015-11-23 10:36:53,234 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,234 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37342.14 Median:20924.84 stddev:117147.83 (559.9%) stddev-sans-first:117443.55 10:36:53 INFO - 2015-11-23 10:36:53,235 DEBUG : BROWSER_OUTPUT: Values: 360.2 362.9 365.3 368.7 370.7 15373.0 16506.0 19514.8 20194.3 20890.9 11690.2 11922.3 11929.1 15391.2 20958.8 3980.9 5231.2 5371.4 5387.3 5402.3 4052.9 4109.4 5747.7 5933.5 5936.2 5758.6 5900.9 5905.5 5924.7 5927.5 5836.9 5930.1 5940.5 5943.1 5954.6 5455.7 5621.0 5627.3 5636.8 5640.9 12729.3 12915.8 12925.6 18901.9 24889.4 2182.4 2198.3 2207.7 2212.9 2228.0 9588.2 9650.5 9926.0 9959.8 10080.1 1679.3 1724.9 1737.1 1740.5 1742.9 78697.0 100232.0 100639.0 101960.0 103383.0 11113.2 11113.4 11167.3 11176.8 11190.6 13227.5 13333.5 13341.4 13349.7 13367.7 7525.7 7778.8 8238.8 8296.5 8307.8 8307.0 8307.8 8312.5 8372.2 8392.9 3981.8 4205.3 4250.7 4296.4 4299.3 1458.2 1768.6 1773.3 1794.4 1798.2 839.8 904.3 933.5 940.3 1003.4 20200.3 20804.3 20877.5 21101.6 21174.2 858.3 908.7 912.6 1021.8 1062.6 7992.0 10678.1 10694.5 10698.5 10720.0 665017.0 688286.0 723705.0 723851.0 752555.0 114429.0 119568.0 119741.0 119765.0 119911.0 1244.7 1244.9 1289.0 1316.4 1332.0 17841.4 18034.5 18051.0 18101.9 18154.6 48621.8 49113.8 49568.0 49736.0 49943.0 68287.6 69259.0 70791.9 77726.2 79567.0 16134.5 16243.5 16861.7 16928.1 17029.6 14481.6 17143.4 19617.6 20294.0 21273.5 15597.0 16711.6 16915.6 16936.5 17939.1 9636.9 9849.8 9911.6 9942.6 15308.5 8137.0 9921.8 10195.7 10231.7 10251.4 16011.9 16149.8 16249.0 16324.3 16426.0 16057.1 16210.3 16255.3 16798.8 16894.2 10:36:53 INFO - 2015-11-23 10:36:53,236 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,236 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5785.18 Median:6197.30 stddev:3024.07 (48.8%) stddev-sans-first:3016.63 10:36:53 INFO - 2015-11-23 10:36:53,237 DEBUG : BROWSER_OUTPUT: Values: 1656.4 1697.9 1906.0 1913.7 1996.4 7530.0 7705.2 7716.6 7717.2 7725.4 7883.4 8260.2 8457.9 8474.2 8496.6 2291.3 2373.6 2375.2 2375.8 2376.5 2148.6 2189.6 2192.3 2359.2 2386.7 2146.3 2174.0 2325.7 2368.2 2371.5 2281.2 2341.4 2345.8 2349.8 2351.0 2119.5 2340.2 2374.0 2375.3 2378.9 7727.7 7840.3 7864.6 7873.2 7882.5 5061.6 5207.7 5235.3 5238.5 5268.0 3093.0 3498.9 3531.0 3537.5 3584.5 1026.2 1044.5 1058.1 1058.7 1062.4 11060.0 11102.7 11108.2 11110.6 11162.2 4651.1 4655.5 4711.3 4738.0 4749.7 9768.8 9771.7 9772.0 9791.5 9796.1 4548.6 5269.9 5290.6 5290.7 5293.6 4768.0 4774.6 4803.5 4813.5 4822.3 3637.5 3708.3 3715.3 3717.6 3746.9 1119.4 1122.1 1131.2 1137.9 1138.2 1334.3 1339.4 1357.0 1369.7 1408.4 7312.6 7436.6 7741.0 7873.9 7912.2 496.6 501.9 509.3 509.3 511.4 5925.9 6086.8 6162.6 6232.0 6234.1 9598.1 9858.9 9902.0 9926.1 9982.3 9826.5 9932.0 10059.6 10064.7 10121.4 7211.6 7784.2 7911.4 7911.5 7956.8 6689.6 7360.4 7776.0 7873.8 7883.2 8873.0 9080.9 9126.4 9220.5 9226.2 9124.5 9299.9 9409.0 9475.3 9577.5 7367.0 7382.3 7404.9 7434.0 7498.1 7999.0 8058.8 8063.3 8065.4 8076.8 7446.7 7522.0 7544.0 7678.6 7693.1 7353.9 7384.7 7408.6 7461.3 7527.5 7544.3 7580.6 7585.2 7606.2 7617.8 6836.4 6862.0 6888.2 6906.7 6925.8 6748.7 6800.4 6805.3 6805.3 6811.3 10:36:53 INFO - 2015-11-23 10:36:53,237 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,237 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5756.22 Median:6436.13 stddev:1834.89 (28.5%) stddev-sans-first:1794.11 10:36:53 INFO - 2015-11-23 10:36:53,238 DEBUG : BROWSER_OUTPUT: Values: 320.5 326.7 328.7 330.7 333.5 6629.4 6662.2 6713.0 6725.7 6740.4 6628.9 6632.3 6635.0 6640.0 6641.1 4879.8 4901.3 4902.6 4907.9 4915.4 4723.4 4789.0 4799.6 4882.5 4884.5 4208.2 4767.4 4782.6 4786.6 4787.0 4584.6 4625.7 4672.2 4787.9 4796.6 3981.3 4046.5 4083.9 4085.4 4101.0 6343.8 6350.9 6354.2 6358.0 6398.2 5465.1 5554.1 5596.6 5619.1 5692.8 6520.3 6543.1 7057.7 7108.8 7145.0 4122.6 4268.9 4584.1 4593.3 4601.8 6501.9 6739.5 7328.5 7465.5 7551.6 4758.6 4808.5 4820.5 4823.2 4843.5 4148.7 4900.2 4916.7 4917.7 4920.0 5788.9 5790.9 5792.5 5801.4 5811.7 6927.0 7106.3 7110.5 7112.2 7119.0 1696.8 1715.9 1717.7 1719.3 1721.1 1108.9 1121.3 1125.3 1130.8 1150.0 5346.9 5871.3 5990.4 6533.3 6558.3 6079.8 6713.0 7429.3 7430.6 7448.5 5314.9 6282.4 6474.1 6500.3 6507.6 3920.1 3956.6 3961.5 3972.0 3989.7 7664.6 7664.9 7694.7 7699.0 7725.3 7102.9 7418.5 7593.7 7699.3 7709.0 7554.6 7644.1 7658.6 7675.5 7679.7 7395.0 7528.3 7549.0 7559.3 7570.7 7214.3 7318.9 7367.8 7369.8 7403.4 7714.5 7720.1 7720.8 7739.8 7740.4 4815.4 4817.5 4821.7 4824.3 4832.7 6563.5 6701.9 7421.2 7457.2 7501.5 5859.0 6179.3 6289.3 6789.0 7215.0 5819.9 7166.1 7176.3 7188.7 7210.5 5687.9 6782.1 7003.4 7010.5 7045.2 7139.3 7147.4 7151.2 7155.2 7156.9 6742.1 6800.3 6994.2 6994.6 7020.6 10:36:53 INFO - 2015-11-23 10:36:53,239 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,239 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18613.81 Median:28596.81 stddev:26472.44 (92.6%) stddev-sans-first:26512.68 10:36:53 INFO - 2015-11-23 10:36:53,240 DEBUG : BROWSER_OUTPUT: Values: 741.5 744.2 795.6 832.3 836.4 15005.5 15337.5 15403.5 15444.2 15467.1 14121.2 14253.0 14253.8 14271.2 14277.6 756.7 772.9 774.0 775.0 960.2 969.4 971.4 984.7 986.8 988.3 1009.5 1027.0 1029.1 1029.5 1031.0 791.2 801.8 803.4 804.7 1009.9 592.0 603.4 744.7 767.4 769.3 14976.9 15152.9 15153.2 15165.8 15175.0 12515.7 12809.9 12913.7 13069.9 13191.6 10109.3 10148.1 10193.2 10221.8 10226.6 3529.9 3561.9 3564.2 3566.0 3566.8 78756.6 79508.6 80389.2 80722.0 80896.0 9736.3 9824.0 9941.9 9979.7 10391.6 21966.9 22089.2 22099.7 22369.8 22423.3 7319.1 7397.7 7491.6 7601.2 7627.3 3860.9 3909.2 3915.8 3940.0 3992.9 3582.4 3642.7 3642.9 3644.9 3647.1 558.9 637.2 650.0 670.1 670.6 542.8 576.3 618.8 640.8 644.6 8029.0 8282.0 8417.2 8428.4 8490.3 531.6 544.2 557.4 625.7 634.9 3245.9 3417.3 3967.8 3997.6 4123.8 93922.5 94890.5 95814.0 95901.5 96060.1 82066.2 82929.3 83637.6 83814.6 84046.6 69929.0 69957.0 70493.3 71576.6 72048.6 8135.8 8143.3 8194.5 8326.8 8376.1 52266.5 52364.5 52662.7 52838.5 53796.7 56634.7 68542.7 72287.0 73074.3 73496.0 10278.4 10450.3 10481.6 10520.7 10985.0 11107.3 11355.6 11489.4 11741.6 12005.1 10223.9 10483.4 10829.0 10842.2 11349.5 9648.7 9897.6 10211.9 10555.5 10747.9 10123.4 10675.0 10677.0 10900.1 11187.7 9424.2 9593.3 9597.0 9774.3 9802.9 9094.7 9935.3 9953.3 9977.4 10173.6 10:36:53 INFO - 2015-11-23 10:36:53,240 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:36:53 INFO - 2015-11-23 10:36:53,240 DEBUG : BROWSER_OUTPUT: 10:36:53 INFO - 2015-11-23 10:36:53,648 INFO : Browser exited with error code: 0 10:36:53 INFO - 2015-11-23 10:36:53,673 INFO : Completed test dromaeo_css (00:18:33) 10:36:53 INFO - 2015-11-23 10:36:53,673 INFO : Starting test kraken 10:36:53 INFO - 2015-11-23 10:36:53,673 DEBUG : operating with platform_type : mac_ 10:36:53 INFO - 2015-11-23 10:36:53,673 INFO : Initialising browser for kraken test... 10:36:53 INFO - 2015-11-23 10:36:53,686 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpe_a70e/profile http://localhost:56214/getInfo.html 10:36:55 INFO - 2015-11-23 10:36:55,862 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:36:55 INFO - 2015-11-23 10:36:55,862 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:36:55 INFO - 2015-11-23 10:36:55,862 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:36:55 INFO - 2015-11-23 10:36:55,862 DEBUG : BROWSER_OUTPUT: __metrics 10:36:55 INFO - 2015-11-23 10:36:55,879 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:36:56 INFO - 2015-11-23 10:36:56,139 DEBUG : BROWSER_OUTPUT: console.error: 10:36:56 INFO - 2015-11-23 10:36:56,140 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 10:36:56 INFO - 2015-11-23 10:36:56,140 DEBUG : BROWSER_OUTPUT: Stack: 10:36:56 INFO - 2015-11-23 10:36:56,140 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 10:36:56 INFO - 2015-11-23 10:36:56,140 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 10:36:56 INFO - 2015-11-23 10:36:56,140 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 10:36:56 INFO - 2015-11-23 10:36:56,140 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 10:36:56 INFO - 2015-11-23 10:36:56,140 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 10:36:56 INFO - 2015-11-23 10:36:56,140 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 10:36:56 INFO - 2015-11-23 10:36:56,141 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:36:56 INFO - 2015-11-23 10:36:56,141 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 10:36:56 INFO - 2015-11-23 10:36:56,141 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:36:56 INFO - 2015-11-23 10:36:56,141 DEBUG : BROWSER_OUTPUT: 10:36:56 INFO - 2015-11-23 10:36:56,563 INFO : Browser initialized. 10:36:56 INFO - 2015-11-23 10:36:56,563 INFO : Running cycle 1/1 for kraken test... 10:36:56 INFO - 2015-11-23 10:36:56,563 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpe_a70e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:37:08 INFO - 2015-11-23 10:37:08,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 225300480 10:37:08 INFO - 2015-11-23 10:37:08,375 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-23 10:37:11,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56214/tests/kraken/driver.html?testName=audio-beat-detection) 10:37:11 INFO - 2015-11-23 10:37:11,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 276226048 10:37:11 INFO - 2015-11-23 10:37:11,636 DEBUG : BROWSER_OUTPUT: 10:37:14 INFO - 2015-11-23 10:37:14,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56214/tests/kraken/driver.html?testName=audio-dft) 10:37:14 INFO - 2015-11-23 10:37:14,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 290144256 10:37:14 INFO - 2015-11-23 10:37:14,868 DEBUG : BROWSER_OUTPUT: 10:37:18 INFO - 2015-11-23 10:37:18,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56214/tests/kraken/driver.html?testName=audio-fft) 10:37:18 INFO - 2015-11-23 10:37:18,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 274518016 10:37:18 INFO - 2015-11-23 10:37:18,625 DEBUG : BROWSER_OUTPUT: 10:37:20 INFO - 2015-11-23 10:37:20,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56214/tests/kraken/driver.html?testName=audio-oscillator) 10:37:21 INFO - 2015-11-23 10:37:21,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 278872064 10:37:21 INFO - 2015-11-23 10:37:21,132 DEBUG : BROWSER_OUTPUT: 10:37:23 INFO - 2015-11-23 10:37:23,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56214/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:37:23 INFO - 2015-11-23 10:37:23,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 279080960 10:37:23 INFO - 2015-11-23 10:37:23,808 DEBUG : BROWSER_OUTPUT: 10:37:26 INFO - 2015-11-23 10:37:26,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56214/tests/kraken/driver.html?testName=imaging-darkroom) 10:37:27 INFO - 2015-11-23 10:37:27,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 280195072 10:37:27 INFO - 2015-11-23 10:37:27,137 DEBUG : BROWSER_OUTPUT: 10:37:29 INFO - 2015-11-23 10:37:29,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56214/tests/kraken/driver.html?testName=imaging-desaturate) 10:37:30 INFO - 2015-11-23 10:37:30,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 279707648 10:37:30 INFO - 2015-11-23 10:37:30,558 DEBUG : BROWSER_OUTPUT: 10:37:33 INFO - 2015-11-23 10:37:33,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56214/tests/kraken/driver.html?testName=json-parse-financial) 10:37:33 INFO - 2015-11-23 10:37:33,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 281337856 10:37:33 INFO - 2015-11-23 10:37:33,904 DEBUG : BROWSER_OUTPUT: 10:37:35 INFO - 2015-11-23 10:37:35,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56214/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:37:35 INFO - 2015-11-23 10:37:35,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 315695104 10:37:35 INFO - 2015-11-23 10:37:35,992 DEBUG : BROWSER_OUTPUT: 10:37:37 INFO - 2015-11-23 10:37:37,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:38 INFO - 2015-11-23 10:37:38,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 317153280 10:37:38 INFO - 2015-11-23 10:37:38,365 DEBUG : BROWSER_OUTPUT: 10:37:40 INFO - 2015-11-23 10:37:40,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:40 INFO - 2015-11-23 10:37:40,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 323379200 10:37:40 INFO - 2015-11-23 10:37:40,981 DEBUG : BROWSER_OUTPUT: 10:37:43 INFO - 2015-11-23 10:37:43,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:44 INFO - 2015-11-23 10:37:44,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 324788224 10:37:44 INFO - 2015-11-23 10:37:44,091 DEBUG : BROWSER_OUTPUT: 10:37:46 INFO - 2015-11-23 10:37:46,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:37:47 INFO - 2015-11-23 10:37:47,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 323854336 10:37:47 INFO - 2015-11-23 10:37:47,079 DEBUG : BROWSER_OUTPUT: 10:37:48 INFO - 2015-11-23 10:37:48,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56214/tests/kraken/driver.html?testName=ai-astar) 10:37:49 INFO - 2015-11-23 10:37:49,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 382554112 10:37:49 INFO - 2015-11-23 10:37:49,064 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;109;104;114;153;158;108;110;101;109 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;129;168;183;136;142;141;117;155;118 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;183;182;180;183;183;183;188;180;182 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: |3;audio-fft;68;64;77;73;56;57;57;72;87;64 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;87;115;76;102;110;132;76;73;99 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;87;88;130;86;85;86;84;85;86 10:37:49 INFO - 2015-11-23 10:37:49,065 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;97;92;94;100;141;92;93;93;93;92 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;87;85;110;132;85;84;87;87;86;85 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;53;55;54;53;52;55;63;51;53 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;63;65;63;61;67;65;66;67;67 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;81;83;81;80;83;82;83;81 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;123;123;119;121;120;121;129;117;130 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;134;134;131;134;123;135;134;135;124 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;66;69;90;79;65;63;64;65 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1045 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: __startTimestamp1448303869061__endTimestamp 10:37:49 INFO - 2015-11-23 10:37:49,066 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,067 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:37:49 INFO - 2015-11-23 10:37:49,067 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:37:49 INFO - 2015-11-23 10:37:49,067 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,068 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:117.60 Median:110.00 stddev:20.32 (18.5%) stddev-sans-first:21.36 10:37:49 INFO - 2015-11-23 10:37:49,068 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 104.0 114.0 153.0 158.0 108.0 110.0 101.0 109.0 10:37:49 INFO - 2015-11-23 10:37:49,068 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,068 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:148.00 stddev:21.15 (14.3%) stddev-sans-first:22.13 10:37:49 INFO - 2015-11-23 10:37:49,068 DEBUG : BROWSER_OUTPUT: Values: 154.0 129.0 168.0 183.0 136.0 142.0 141.0 117.0 155.0 118.0 10:37:49 INFO - 2015-11-23 10:37:49,068 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:2.25 (1.2%) stddev-sans-first:2.35 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: Values: 184.0 183.0 182.0 180.0 183.0 183.0 183.0 188.0 180.0 182.0 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:67.50 Median:70.00 stddev:9.99 (14.3%) stddev-sans-first:10.60 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: Values: 68.0 64.0 77.0 73.0 56.0 57.0 57.0 72.0 87.0 64.0 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:95.40 Median:76.00 stddev:19.57 (25.8%) stddev-sans-first:20.32 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 115.0 76.0 102.0 110.0 132.0 76.0 73.0 99.0 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:86.00 stddev:13.99 (16.3%) stddev-sans-first:14.75 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 88.0 130.0 86.0 85.0 86.0 84.0 85.0 86.0 10:37:49 INFO - 2015-11-23 10:37:49,069 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:98.70 Median:93.00 stddev:15.09 (16.2%) stddev-sans-first:15.99 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: Values: 97.0 92.0 94.0 100.0 141.0 92.0 93.0 93.0 93.0 92.0 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:92.80 Median:85.50 stddev:15.77 (18.5%) stddev-sans-first:16.59 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: Values: 87.0 85.0 110.0 132.0 85.0 84.0 87.0 87.0 86.0 85.0 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:3.34 (6.1%) stddev-sans-first:3.50 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: Values: 56.0 53.0 55.0 54.0 53.0 52.0 55.0 63.0 51.0 53.0 10:37:49 INFO - 2015-11-23 10:37:49,070 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,071 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.50 stddev:2.22 (3.4%) stddev-sans-first:2.15 10:37:49 INFO - 2015-11-23 10:37:49,071 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 65.0 63.0 61.0 67.0 65.0 66.0 67.0 67.0 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:1.18 (1.4%) stddev-sans-first:1.24 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 81.0 83.0 81.0 80.0 83.0 82.0 83.0 81.0 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.00 stddev:4.12 (3.3%) stddev-sans-first:4.36 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: Values: 123.0 123.0 123.0 119.0 121.0 120.0 121.0 129.0 117.0 130.0 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.30 Median:134.00 stddev:5.03 (3.8%) stddev-sans-first:4.72 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: Values: 139.0 134.0 134.0 131.0 134.0 123.0 135.0 134.0 135.0 124.0 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:65.50 stddev:8.77 (13.4%) stddev-sans-first:9.13 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 66.0 69.0 90.0 79.0 65.0 63.0 64.0 65.0 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:37:49 INFO - 2015-11-23 10:37:49,072 DEBUG : BROWSER_OUTPUT: 10:37:49 INFO - 2015-11-23 10:37:49,714 INFO : Browser exited with error code: 0 10:37:49 INFO - 2015-11-23 10:37:49,761 INFO : Completed test kraken (00:00:56) 10:37:49 INFO - 2015-11-23 10:37:49,761 INFO : Starting test v8_7 10:37:49 INFO - 2015-11-23 10:37:49,761 DEBUG : operating with platform_type : mac_ 10:37:49 INFO - 2015-11-23 10:37:49,762 INFO : Initialising browser for v8_7 test... 10:37:49 INFO - 2015-11-23 10:37:49,774 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpWshnwW/profile http://localhost:56214/getInfo.html 10:37:51 INFO - 2015-11-23 10:37:51,816 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:37:51 INFO - 2015-11-23 10:37:51,816 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:37:51 INFO - 2015-11-23 10:37:51,816 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:37:51 INFO - 2015-11-23 10:37:51,816 DEBUG : BROWSER_OUTPUT: __metrics 10:37:51 INFO - 2015-11-23 10:37:51,833 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:52 INFO - 2015-11-23 10:37:52,486 INFO : Browser initialized. 10:37:52 INFO - 2015-11-23 10:37:52,487 INFO : Running cycle 1/1 for v8_7 test... 10:37:52 INFO - 2015-11-23 10:37:52,487 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpWshnwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:38:04 INFO - 2015-11-23 10:38:04,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 226373632 10:38:04 INFO - 2015-11-23 10:38:04,342 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56214/tests/v8_7/run.html (next: http://localhost:56214/tests/v8_7/run.html) 10:38:25 INFO - 2015-11-23 10:38:25,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 698355712 10:38:25 INFO - 2015-11-23 10:38:25,974 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,974 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:38:25 INFO - 2015-11-23 10:38:25,974 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:38:25 INFO - 2015-11-23 10:38:25,974 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |0;Richards;174.33751743375174 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.6425702811245 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4648.148148148148 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1711.111111111111 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |5;Earley;785.0980392156863 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |6;Boyer;13197.368421052632 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |7;RegExp;28027.777777777777 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |8;Splay;641.8485237483953 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4504.504504504504 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:38:25 INFO - 2015-11-23 10:38:25,975 DEBUG : BROWSER_OUTPUT: __startTimestamp1448303905967__endTimestamp 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:174.34 Median:174.34 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: Values: 174.3 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.64 Median:160.64 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: Values: 160.6 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: Values: 279.3 10:38:25 INFO - 2015-11-23 10:38:25,976 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4648.15 Median:4648.15 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: Values: 4648.1 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1711.11 Median:1711.11 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: Values: 1711.1 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.10 Median:785.10 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: Values: 785.1 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13197.37 Median:13197.37 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: Values: 13197.4 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28027.78 Median:28027.78 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,977 DEBUG : BROWSER_OUTPUT: Values: 28027.8 10:38:25 INFO - 2015-11-23 10:38:25,978 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,978 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:641.85 Median:641.85 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,978 DEBUG : BROWSER_OUTPUT: Values: 641.8 10:38:25 INFO - 2015-11-23 10:38:25,978 DEBUG : BROWSER_OUTPUT: 10:38:25 INFO - 2015-11-23 10:38:25,978 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4504.50 Median:4504.50 stddev:0.00 (0.0%) 10:38:25 INFO - 2015-11-23 10:38:25,978 DEBUG : BROWSER_OUTPUT: Values: 4504.5 10:38:25 INFO - 2015-11-23 10:38:25,978 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:38:25 INFO - 2015-11-23 10:38:25,978 DEBUG : BROWSER_OUTPUT: 10:38:26 INFO - 2015-11-23 10:38:26,603 INFO : Browser exited with error code: 0 10:38:26 INFO - 2015-11-23 10:38:26,621 INFO : Completed test v8_7 (00:00:36) 10:38:27 INFO - 2015-11-23 10:38:27,126 INFO : Completed test suite (00:20:07) 10:38:27 INFO - 2015-11-23 10:38:27,127 DEBUG : Working with test: dromaeo_css 10:38:27 INFO - 2015-11-23 10:38:27,127 DEBUG : Generating results file: dromaeo_css 10:38:27 INFO - 2015-11-23 10:38:27,128 DEBUG : Working with test: kraken 10:38:27 INFO - 2015-11-23 10:38:27,128 DEBUG : Generating results file: kraken 10:38:27 INFO - 2015-11-23 10:38:27,128 INFO : javascript benchmark 10:38:27 INFO - 2015-11-23 10:38:27,128 DEBUG : Working with test: v8_7 10:38:27 INFO - 2015-11-23 10:38:27,128 DEBUG : Generating results file: v8_7 10:38:27 INFO - 2015-11-23 10:38:27,128 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:38:27 INFO - 2015-11-23 10:38:27,541 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:38:27 INFO - 2015-11-23 10:38:27,541 DEBUG : process_Request line: dromaeo_css 7568.74 graph.html#tests=[[72,64,59]] 10:38:27 INFO - 2015-11-23 10:38:27,541 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:38:27 INFO - 2015-11-23 10:38:27,566 DEBUG : process_Request line: kraken 1413.80 graph.html#tests=[[232,64,59]] 10:38:27 INFO - 2015-11-23 10:38:27,567 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:38:27 INFO - 2015-11-23 10:38:27,592 DEBUG : process_Request line: v8_7 20309.77 graph.html#tests=[[230,64,59]] 10:38:27 INFO - 2015-11-23 10:38:27,593 INFO : javascript benchmark 10:38:27 INFO - 2015-11-23 10:38:27,595 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3375.3080618473214, 3418.675225853545, 3433.17603775094, 3456.3236830137394, 3497.737669674775, 5562.888742225153, 5724.313082430114, 5754.482096611304, 5756.02147634902, 5758.827235182946, 5713.571482138836, 5744.396838331967, 5766.394528574502, 5926.407359264072, 5936.821895343136, 5091.923621145667, 5122.974385128069, 5161.019406312807, 5180.559652429548, 5230.163173892178, 4788.162071637467, 5273.841784746463, 5324.807267077036, 5327.493888080646, 5399.676019438826, 4528.913060865401, 5133.717645529495, 5225.503577160163, 5262.631615786877, 5272.551833094191, 5157.7936882524655, 5259.5529380002745, 5265.236540701615, 5265.657732247391, 5266.578673706094, 5144.922826157611, 5231.947680523184, 5239.5546378557865, 5240.764165612519, 5252.474752524755, 5703.287089113861, 5717.428257174291, 5718.857028574277, 5723.942760572382, 5739.827805165852, 6161.599496032743, 6191.380861913773, 6221.440070393686, 6229.065640153968, 6230.470410015154, 5272.92090618641, 6097.797685703621, 6177.042558403455, 6178.69106544671, 6193.628382297032, 5878.925218517303, 5951.196588460546, 5957.761689532457, 5964.850878728023, 6024.78913238039, 6154.292256390483, 6225.23939399975, 6324.683765811691, 6328.145700330489, 6329.68351582419, 5225.869353266123, 6031.336552979169, 6109.14471973924, 6130.623687452916, 6157.907631385533, 6184.859575145173, 6224.408681175281, 6234.532410069263, 6240.625562466266, 6252.874942501216, 6038.969805150946, 6188.876222475616, 6197.380261973766, 6203.534734894901, 6212.409821066992, 6100.69496525172, 6173.9073913891325, 6178.196834411498, 6219.036049412348, 6242.625442473466, 4990.2764099205415, 4999.250112483084, 5002.199648056294, 5006.499350064964, 5017.54842064216, 4346.587074227943, 4469.4636643602325, 4475.731456112644, 4482.8655140345845, 4491.214037543416, 5694.572907031989, 5727.799527016535, 5761.798337058183, 5772.971135144381, 5821.970890145522, 6220.937790622126, 6226.066090086432, 6230.56386052981, 6231.688415579203, 6235.781747638811, 5597.216389705444, 5759.769609215585, 5808.099744539603, 5827.88344233113, 5837.503812175928, 5382.973085134549, 5402.837914862561, 5447.0, 5452.754626041838, 5489.64317319373, 6316.652584107918, 6345.841353966188, 6360.427561519393, 6360.459360954278, 6370.490360771035, 6126.23422072241, 6252.406021427957, 6255.31191568918, 6260.624362538262, 6268.247810262797, 6218.22272215973, 6237.407446292595, 6251.499880009679, 6324.335944725922, 6343.904841427475, 6169.56813023102, 6198.2871969722255, 6220.34686357944, 6237.282712488122, 6241.96879015602, 5472.288602481811, 6073.679564805565, 6166.969165154145, 6253.937460625336, 6254.2807577129215, 5305.726625609748, 5985.790497332572, 6108.72510737009, 6114.2357205349335, 6129.080637904171, 5164.690118592896, 5982.49148822355, 6074.42292982166, 6086.939130608637, 6105.755769769159, 4804.8798780030775, 6002.69986500682, 6003.609765365237, 6021.819345419644, 6026.758929642765, 5905.5570832186895, 5932.406759324033, 6099.359567245376, 6105.17580126695, 6175.320714721467, 6000.669963152069, 6018.909716354171, 6022.668753218615, 6024.638521688713, 6025.487833534024], "unit": "ms", "name": "dojo.html", "value": 5687.731492027611}, {"lowerIsBetter": false, "replicates": [523.1807803037825, 588.9399081653023, 606.4541912278949, 639.862429577641, 648.0861984601712, 30950.84524577377, 31652.0, 39272.018199545026, 39606.20787584247, 39706.0, 43176.568234317725, 43655.56344436554, 43780.78109609456, 43813.78093109538, 43824.342634860506, 8640.17918297764, 8821.867671984925, 9844.753881152974, 10024.89975100247, 10043.899561004406, 8820.911790882074, 8924.419912705653, 8939.865902011476, 12146.210496317755, 12278.693032674166, 12034.217775844541, 12099.697507562338, 12111.0, 12126.0, 12129.272243665408, 10110.342827716175, 12000.159988800788, 12031.63905082849, 12081.214721043192, 12155.57455489058, 8790.42862213954, 8894.288456923496, 8906.59920303588, 11944.223625464318, 12057.035437165006, 40877.0, 41246.58753412458, 41320.96697582555, 41383.0, 41410.79294603538, 3286.4248756467523, 3651.8539258429632, 3688.6311368863167, 3750.3811871041244, 3893.5133108361456, 24492.775361231867, 28495.0, 28933.276668083257, 30253.546196807067, 30408.695913040807, 2757.0, 2798.5522316429274, 2800.663920329553, 2868.4693331733697, 2869.411770587025, 491490.0, 495219.5239023854, 495715.0, 496094.0, 496478.0, 67242.66378668173, 67535.32464675388, 67722.32277677259, 67749.98375024379, 67897.0, 72643.0, 72766.0, 72769.63615181996, 72881.63559182276, 73080.0, 16389.42637007699, 16404.589885252964, 16501.257443415074, 16561.337546498005, 16614.83385166157, 12300.446479908425, 12332.965060764873, 12364.0, 12368.690782730504, 12383.75232495363, 21024.579508409744, 21450.57098858014, 21490.462738431663, 21518.677219841717, 21696.24063157782, 9307.674231401868, 9519.333646644669, 9532.95233523828, 9536.046395360408, 9544.0455954404, 915.6383228624655, 956.5695437053354, 966.7486453521994, 1049.6483677967813, 1106.5186643809968, 27867.860660696973, 28479.717249573278, 29048.564271535943, 29239.56140657892, 29383.971560995262, 990.3414229537277, 1055.472263868066, 1061.792950374685, 1198.1133960868895, 1222.896053835434, 12501.43743531525, 13987.720245595234, 14727.042742221936, 14950.028248163835, 15659.590636842739, 546567.0, 547124.0, 548069.0, 548432.0, 550168.0, 58553.41446585565, 59177.0, 59209.70395148083, 59281.70359148177, 59295.703521482115, 1408.0777091005407, 1429.2139323372103, 1450.717110163529, 1453.055513915942, 1460.664047269134, 28955.98654047098, 29317.973870914415, 29395.979191341197, 29438.852805735834, 29755.0, 50793.746031269606, 50972.74513627408, 51132.23301650404, 51245.0, 51324.74337628288, 504968.47515762184, 508035.75892723276, 509332.0, 509635.0, 510415.0, 28728.425431490836, 29180.854095729384, 32651.836740817093, 32763.0, 33760.831195843864, 41208.201704713785, 41912.580874192085, 41995.0, 42372.0, 43111.784441077594, 35244.29511409706, 35317.64682353144, 36307.0, 36365.0, 36413.27173456569, 30670.619822107612, 35058.474122888685, 35423.46864797082, 35947.0, 36063.63936360603, 34475.482867757506, 35745.46381804223, 39102.6089739099, 39431.211375772895, 40937.38593921034, 32649.34701306008, 33324.16689582683, 33650.49524257089, 33654.49518257277, 33863.0, 23965.64051539263, 24667.506649866544, 24906.26031136537, 25504.234872953843, 25782.0], "unit": "ms", "name": "ext.html", "value": 20388.38401223077}, {"lowerIsBetter": false, "replicates": [360.2237178879516, 362.945558166275, 365.3113880335567, 368.6810908564092, 370.7423340778159, 15373.0, 16506.0, 19514.804851951478, 20194.293199737993, 20890.89554552225, 11690.240134391259, 11922.28466292023, 11929.105317101208, 15391.230438478087, 20958.790412095874, 3980.8606698765548, 5231.189165679326, 5371.409144994067, 5387.299651045379, 5402.270693456392, 4052.898677533056, 4109.4246805447265, 5747.741351639186, 5933.495652869511, 5936.198613187229, 5758.568107391941, 5900.940990590104, 5905.468507834294, 5924.674142922137, 5927.525797936176, 5836.912446313288, 5930.051191809312, 5940.465358117768, 5943.108533719934, 5954.612950158225, 5455.727213639302, 5621.0444224481935, 5627.324721033461, 5636.830895073154, 5640.943590564083, 12729.299888506128, 12915.806262906064, 12925.612231633066, 18901.905490472596, 24889.377765555826, 2182.443476913377, 2198.2855571939185, 2207.6578130389653, 2212.9114835406563, 2228.0, 9588.185004274575, 9650.517474126265, 9926.0, 9959.80080398388, 10080.143187829044, 1679.3198754504444, 1724.9051302178375, 1737.0880287848854, 1740.4778566430148, 1742.8692848036321, 78697.03257418553, 100232.0, 100639.0, 101960.0, 103382.99999999924, 11113.22207445471, 11113.444327783578, 11167.329960202414, 11176.832347514794, 11190.608328708619, 13227.470901164039, 13333.466661333438, 13341.399637016357, 13349.666258343424, 13367.732645347038, 7525.6989720410575, 7778.794286885542, 8238.752837414888, 8296.460730052528, 8307.792305192419, 8307.0, 8307.750767476986, 8312.459690120122, 8372.162783721578, 8392.916070839336, 3981.8407263709705, 4205.3481710334945, 4250.723702959298, 4296.37702533131, 4299.333603291495, 1458.2490017640923, 1768.628587996535, 1773.3084097202102, 1794.420909599544, 1798.190814133645, 839.8236370362171, 904.2856143646445, 933.5285680731188, 940.2853831088422, 1003.392947266893, 20200.292989745583, 20804.271850485464, 20877.478063048544, 21101.577968440546, 21174.153033878472, 858.3176374782063, 908.68650315641, 912.6258234123977, 1021.7649940513575, 1062.6333914799382, 7992.0, 10678.145748340114, 10694.465276736131, 10698.51856666452, 10720.035196832323, 665017.0, 688286.0, 723705.0, 723851.0, 752555.0, 114429.0, 119568.0, 119741.0, 119765.0, 119911.0, 1244.7448273103812, 1244.8568414632252, 1288.9742205155844, 1316.4207748590782, 1331.9533816316382, 17841.43171365706, 18034.549136271697, 18051.0, 18101.909490452465, 18154.636907262044, 48621.75689121673, 49113.754431227615, 49568.0, 49736.0, 49943.0, 68287.63424731577, 69259.0, 70791.9381209272, 77726.2227377719, 79567.0, 16134.515964521082, 16243.51269461918, 16861.66276674484, 16928.068956207528, 17029.57426064358, 14481.637959051108, 17143.399981000606, 19617.60764784725, 20293.98530073461, 21273.468163296042, 15597.0, 16711.582210444834, 16915.577110572332, 16936.491905242863, 17939.103044847965, 9636.855447168438, 9849.753756156153, 9911.553980071058, 9942.552585133832, 15308.540743777705, 8136.959315203623, 9921.751956200864, 10195.7451063724, 10231.744206394602, 10251.38491690501, 16011.879168458096, 16149.75775363347, 16249.0, 16324.265408056903, 16426.0, 16057.11685857289, 16210.27053782559, 16255.349786008901, 16798.832011680217, 16894.23975921062], "unit": "ms", "name": "jquery.html", "value": 9760.225818429984}, {"lowerIsBetter": false, "replicates": [1656.3788579282766, 1697.8896371735843, 1906.045629274624, 1913.6941880768272, 1996.4210378990094, 7529.962350188248, 7705.229477052292, 7716.575588342646, 7717.151113377524, 7725.420593455485, 7883.3693304535645, 8260.173982601736, 8457.873131903027, 8474.152584741523, 8496.575171241444, 2291.3126062181323, 2373.5727569037567, 2375.156819329139, 2375.7743014413604, 2376.5128148729555, 2148.6347320955474, 2189.5730332585154, 2192.27654873892, 2359.221456919221, 2386.689730335054, 2146.2595404585472, 2173.9891300543477, 2325.662778897059, 2368.159303447277, 2371.5494056129282, 2281.178775640768, 2341.391238278043, 2345.7536958619357, 2349.7532759060223, 2351.0243249051623, 2119.5125121222204, 2340.157543284416, 2374.0266490738886, 2375.2517956843712, 2378.881055947196, 7727.65225564851, 7840.255175758294, 7864.567448790314, 7873.173316801711, 7882.5270483771155, 5061.5950723942, 5207.661502002357, 5235.319408476912, 5238.528532432099, 5267.973660131714, 3092.9793168254423, 3498.8950331490096, 3531.0289670340603, 3537.540119784437, 3584.4981702561663, 1026.1790567546009, 1044.5143008501084, 1058.0794708603564, 1058.7353161709573, 1062.3678911047914, 11060.004599586076, 11102.722431939186, 11108.16688748347, 11110.61112861046, 11162.162837787117, 4651.069786042805, 4655.534446555385, 4711.269753188261, 4737.976310118427, 4749.715017098985, 9768.755781105387, 9771.657991970389, 9771.951140244395, 9791.461469619097, 9796.069373409515, 4548.56788605082, 5269.947300527022, 5290.576753859682, 5290.735463226823, 5293.629445938825, 4767.951050768826, 4774.570288673966, 4803.519648035169, 4813.470518243061, 4822.324874517571, 3637.4725664778457, 3708.3325001499447, 3715.3126671565847, 3717.5724791648768, 3746.868859589901, 1119.3787447966456, 1122.063077330422, 1131.213806404541, 1137.8862113788555, 1138.2203190814153, 1334.3261652865435, 1339.4441306857545, 1356.986430135686, 1369.698666293414, 1408.4155075643698, 7312.561246325237, 7436.590987495631, 7740.993670822757, 7873.921260787319, 7912.169222231698, 496.60519886689445, 501.94478607353165, 509.26157072244655, 509.2717414097876, 511.3914441814229, 5925.911111333334, 6086.847828804227, 6162.599431036968, 6232.0, 6234.096056071844, 9598.136167744937, 9858.901410985798, 9902.0, 9926.106650401498, 9982.251331150193, 9826.508674566387, 9931.950340248253, 10059.597616095421, 10064.74838129038, 10121.443320617436, 7211.603361815046, 7784.182660820646, 7911.406644501685, 7911.5363657722355, 7956.761297161094, 6689.632070236184, 7360.411167106726, 7775.961120194363, 7873.763787086396, 7883.172266911892, 8873.0, 9080.90919090827, 9126.361154719372, 9220.492872892055, 9226.215771659216, 9124.543772811465, 9299.907000929905, 9408.95295523518, 9475.289353298393, 9577.473238971923, 7367.0, 7382.2617738225745, 7404.888926665996, 7434.0, 7498.100227972678, 7999.0, 8058.798530036796, 8063.314618257514, 8065.354771618139, 8076.798080048045, 7446.7021319146625, 7521.962390188233, 7543.962280188564, 7678.577678227528, 7693.076830780342, 7353.889691654736, 7384.741534046498, 7408.555486670817, 7461.328480436787, 7527.548347099191, 7544.283293087148, 7580.583067931317, 7585.16563178061, 7606.239376062571, 7617.847643047219, 6836.38472537474, 6861.965690171717, 6888.242293347627, 6906.689198985957, 6925.792226233221, 6748.73005079811, 6800.353966373186, 6805.319468053155, 6805.319468053155, 6811.250762416031], "unit": "ms", "name": "mootools.html", "value": 4657.576270309195}, {"lowerIsBetter": false, "replicates": [320.530422930407, 326.7239182890457, 328.7320833520679, 330.6511630230107, 333.52472726364925, 6629.403353698166, 6662.233843108044, 6712.9664351678175, 6725.663716814158, 6740.393364597186, 6628.867422651544, 6632.336766323365, 6634.9668251658795, 6640.0, 6641.0702501649685, 4879.756012199394, 4901.264810278469, 4902.583280421169, 4907.852764417074, 4915.434725006634, 4723.3859598252175, 4788.994311194653, 4799.5680388765, 4882.536159064884, 4884.511548845105, 4208.22147902639, 4767.356406885078, 4782.641301902371, 4786.593139583122, 4786.976065119687, 4584.633229341644, 4625.653076019278, 4672.20572502672, 4787.880302992418, 4796.592289655366, 3981.2634662587516, 4046.5144182698264, 4083.8774836754947, 4085.4076158956786, 4100.979495102535, 6343.777967771106, 6350.936490635081, 6354.205724284465, 6358.0, 6398.16823812906, 5465.098258787295, 5554.0835762099205, 5596.636218645775, 5619.129034999582, 5692.829215123512, 6520.282768895418, 6543.149390579242, 7057.717691292342, 7108.786736397917, 7144.9642751785905, 4122.6395289554675, 4268.87193384199, 4584.083183363307, 4593.28804035375, 4601.792919318638, 6501.894677904767, 6739.52823302374, 7328.487005909588, 7465.514741541837, 7551.622418879034, 4758.571728544378, 4808.519148085164, 4820.542048505386, 4823.204171311694, 4843.467218606021, 4148.709590328648, 4900.191468407673, 4916.680415772963, 4917.65576409655, 4920.0, 5788.913166302509, 5790.855228619234, 5792.507636850914, 5801.419858014249, 5811.651300921958, 6927.0, 7106.324899134574, 7110.5022648414115, 7112.217656057829, 7119.038929744418, 1696.7539706742452, 1715.9313627455012, 1717.6822287876782, 1719.346648273648, 1721.0878234535467, 1108.9168312376603, 1121.3047910295668, 1125.3248051169396, 1130.813415786386, 1150.0339714639576, 5346.8663283417445, 5871.32479764824, 5990.371011043865, 6533.333999830108, 6558.311377305409, 6079.787207447718, 6713.0, 7429.294217049372, 7430.554166750012, 7448.5158464699625, 5314.92027619586, 6282.371762823681, 6474.093626892239, 6500.252470965899, 6507.609543427409, 3920.0591857954455, 3956.5647778744315, 3961.504811898513, 3972.0467087898696, 3989.68082553395, 7664.616769161519, 7664.923350766532, 7694.73068442613, 7698.961505192438, 7725.266099720518, 7102.893456598155, 7418.480706350504, 7593.6582853771715, 7699.26856948589, 7709.0, 7554.584497852561, 7644.082710074605, 7658.578778167142, 7675.539467632072, 7679.731209407644, 7395.001674773836, 7528.322450979438, 7549.0, 7559.3196612305155, 7570.697172113274, 7214.3188611176, 7318.853622927405, 7367.8158046049275, 7369.8157546061775, 7403.407727381689, 7714.459987801025, 7720.112187098555, 7720.806979825325, 7739.806504837424, 7740.380769538311, 4815.422149342101, 4817.494163112823, 4821.7348045856415, 4824.34871292371, 4832.685875418087, 6563.474922006132, 6701.899471508029, 7421.220771818881, 7457.179710231979, 7501.474896757175, 5859.0, 6179.258488981351, 6289.308176100534, 6788.9660551696925, 7215.0, 5819.912701309399, 7166.140063192451, 7176.282371762782, 7188.748393806401, 7210.459215558749, 5687.886242275049, 6782.118324617768, 7003.404710599452, 7010.544314619533, 7045.189803172496, 7139.286071392819, 7147.356737893615, 7151.177614574182, 7155.212926578176, 7156.892646610201, 6742.123523941857, 6800.251972282946, 6994.2306346302885, 6994.615296158557, 7020.5779006242765], "unit": "ms", "name": "prototype.html", "value": 5152.825562498479}, {"lowerIsBetter": false, "replicates": [741.5328343143818, 744.192551082076, 795.5505139596128, 832.3258160889679, 836.41450984311, 15005.474808381696, 15337.539873803804, 15403.537893863175, 15444.227788610566, 15467.071975681467, 14121.152730836156, 14253.002289839715, 14253.78619320711, 14271.215083170422, 14277.571672849805, 756.7427074794582, 772.8956590860246, 773.957432341221, 774.9922500774976, 960.1838437328284, 969.3795970578835, 971.4365667912593, 984.7045886234101, 986.7927735175622, 988.298308201178, 1009.5103874620803, 1026.9935463246024, 1029.0584115534277, 1029.526417847791, 1031.03083101884, 791.2048391366698, 801.7755028592004, 803.3693550562809, 804.7344376355788, 1009.8838633557125, 592.0054308761322, 603.3664652115261, 744.7207297263526, 767.4014268870234, 769.2845653542204, 14976.850231497654, 15152.924235378863, 15153.166575838324, 15165.848341516554, 15175.0, 12515.749685006249, 12809.935950320281, 12913.741725165444, 13069.86930130696, 13191.604251872459, 10109.342892712024, 10148.137408320228, 10193.23550733698, 10221.795564088676, 10226.6420675276, 3529.8764543240864, 3561.8753343632848, 3564.215872508044, 3566.037169964121, 3566.7681600695873, 78756.60621696855, 79508.60245698792, 80389.19610803876, 80722.0, 80896.0, 9736.318457708034, 9823.950880245553, 9941.900580994243, 9979.650712225182, 10391.636292729718, 21966.89016554939, 22089.226877059227, 22099.668504972436, 22369.776302237096, 22423.32730018102, 7319.085114360705, 7397.704091836374, 7491.587962662106, 7601.239876012465, 7627.275408836152, 3860.942085868714, 3909.179072394772, 3915.7846318452757, 3940.014996250937, 3992.940105898414, 3582.444721068239, 3642.6539478750005, 3642.908927276839, 3644.908877278036, 3647.1429214134655, 558.902192116378, 637.2480473041762, 649.9837504062342, 670.0719503487704, 670.6110455935545, 542.7787478174108, 576.2566289486515, 618.7988903606346, 640.814163892466, 644.6196743921015, 8029.0, 8281.95859020701, 8417.200365965224, 8428.410011299273, 8490.320774338039, 531.6331731105524, 544.2081771023152, 557.3673880146064, 625.7371903800415, 634.9365063493614, 3245.881756454485, 3417.333619944137, 3967.805916237399, 3997.5940866228398, 4123.835046598162, 93922.53038734762, 94890.52554737183, 95814.0, 95901.52049239709, 96060.07879842364, 82066.17933820705, 82929.3414131714, 83637.58181209055, 83814.58092709497, 84046.57976710077, 69929.0, 69957.0, 70493.29506704868, 71576.64211679013, 72048.63975680088, 8135.7966050846835, 8143.267105960492, 8194.50832950025, 8326.83346333082, 8376.120507346885, 52266.47733522616, 52364.47635523596, 52662.736686317854, 52838.47161528336, 53796.73101634467, 56634.716826415606, 68542.65728671325, 72287.0, 73074.26925730675, 73496.0, 10278.389586681724, 10450.320729152581, 10481.580736770444, 10520.736981575521, 10985.0, 11107.333559986426, 11355.602553910574, 11489.425528723363, 11741.589044383405, 12005.099617528895, 10223.948880255552, 10483.37099774016, 10829.025387715143, 10842.24104312722, 11349.54601815918, 9648.71053868357, 9897.604095836086, 10211.897881021094, 10555.522226888395, 10747.946260268649, 10123.392596444237, 10675.0, 10677.0, 10900.127989760642, 11187.72030699239, 9424.246060315021, 9593.32846700752, 9597.0, 9774.266929980138, 9802.852957205505, 9094.681686140953, 9935.304528682922, 9953.253505987224, 9977.351472154287, 10173.593056277667], "unit": "ms", "name": "yui.html", "value": 6920.1658125913245}], "name": "dromaeo_css", "value": 7568.740879374769}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 104.0, 114.0, 153.0, 158.0, 108.0, 110.0, 101.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 117.6}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 168.0, 183.0, 136.0, 142.0, 141.0, 117.0, 155.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [184.0, 183.0, 182.0, 180.0, 183.0, 183.0, 183.0, 188.0, 180.0, 182.0], "unit": "ms", "name": "audio-dft", "value": 182.8}, {"lowerIsBetter": true, "replicates": [68.0, 64.0, 77.0, 73.0, 56.0, 57.0, 57.0, 72.0, 87.0, 64.0], "unit": "ms", "name": "audio-fft", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 115.0, 76.0, 102.0, 110.0, 132.0, 76.0, 73.0, 99.0], "unit": "ms", "name": "audio-oscillator", "value": 95.4}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 88.0, 130.0, 86.0, 85.0, 86.0, 84.0, 85.0, 86.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 90.3}, {"lowerIsBetter": true, "replicates": [97.0, 92.0, 94.0, 100.0, 141.0, 92.0, 93.0, 93.0, 93.0, 92.0], "unit": "ms", "name": "imaging-darkroom", "value": 98.7}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 110.0, 132.0, 85.0, 84.0, 87.0, 87.0, 86.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 92.8}, {"lowerIsBetter": true, "replicates": [56.0, 53.0, 55.0, 54.0, 53.0, 52.0, 55.0, 63.0, 51.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 65.0, 63.0, 61.0, 67.0, 65.0, 66.0, 67.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 81.0, 83.0, 81.0, 80.0, 83.0, 82.0, 83.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 123.0, 119.0, 121.0, 120.0, 121.0, 129.0, 117.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [139.0, 134.0, 134.0, 131.0, 134.0, 123.0, 135.0, 134.0, 135.0, 124.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 132.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 66.0, 69.0, 90.0, 79.0, 65.0, 63.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1413.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [174.33751743375174], "unit": "score", "name": "Richards", "value": 202.4922720000001}, {"lowerIsBetter": false, "replicates": [160.6425702811245], "unit": "score", "name": "DeltaBlue", "value": 411.5845499999999}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [4648.148148148148], "unit": "score", "name": "Decrypt", "value": 57.266031872509984}, {"lowerIsBetter": false, "replicates": [1711.111111111111], "unit": "score", "name": "RayTrace", "value": 432.4611038961038}, {"lowerIsBetter": false, "replicates": [785.0980392156863], "unit": "score", "name": "Earley", "value": 848.8914335664339}, {"lowerIsBetter": false, "replicates": [13197.368421052632], "unit": "score", "name": "Boyer", "value": 50.49968893320038}, {"lowerIsBetter": false, "replicates": [28027.777777777777], "unit": "score", "name": "RegExp", "value": 32.502933597621436}, {"lowerIsBetter": false, "replicates": [641.8485237483953], "unit": "score", "name": "Splay", "value": 126.962978}, {"lowerIsBetter": false, "replicates": [4504.504504504504], "unit": "score", "name": "NavierStokes", "value": 329.44800000000015}], "name": "v8_7", "value": 20309.766701276276}]} 10:38:27 INFO - RETURN: dromaeo_css: 7568.74 10:38:27 INFO - RETURN: kraken: 1413.80 10:38:27 INFO - RETURN: v8_7: 20309.77 10:38:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20309.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1413.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7568.74"}}} 10:38:27 INFO - Return code: 0 10:38:27 INFO - # TBPL SUCCESS # 10:38:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:38:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:38:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:38:27 INFO - 2015-11-23 10:38:27.704 screenresolution[6055:104224] starting screenresolution argv=screenresolution get 10:38:27 INFO - 2015-11-23 10:38:27.707 screenresolution[6055:104224] Display 0: 1600x1200x32@60 10:38:27 INFO - 2015-11-23 10:38:27.713 screenresolution[6056:104227] starting screenresolution argv=screenresolution list 10:38:27 INFO - Available Modes on Display 0 10:38:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:38:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:38:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:38:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:38:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:38:27 INFO - Intel Iris: 10:38:27 INFO - Chipset Model: Intel Iris 10:38:27 INFO - Type: GPU 10:38:27 INFO - Bus: Built-In 10:38:27 INFO - VRAM (Dynamic, Max): 1536 MB 10:38:27 INFO - Vendor: Intel (0x8086) 10:38:27 INFO - Device ID: 0x0a2e 10:38:27 INFO - Revision ID: 0x0009 10:38:27 INFO - Displays: 10:38:27 INFO - Display: 10:38:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:38:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:38:27 INFO - Display Serial Number: 1600x1200 60 10:38:27 INFO - Main Display: Yes 10:38:27 INFO - Mirror: Off 10:38:27 INFO - Online: Yes 10:38:27 INFO - Rotation: Supported 10:38:27 INFO - Return code: 0 10:38:27 INFO - Running post-action listener: _resource_record_post_action 10:38:27 INFO - Running post-run listener: _resource_record_post_run 10:38:29 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 25894400; Write bytes: 691351552; Read time: 271; Write time: 2164 10:38:29 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336914944; Write bytes: 338806784; Read time: 25939; Write time: 686 10:38:29 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 25894400; Write bytes: 341284864; Read time: 271; Write time: 1444 10:38:29 INFO - Running post-run listener: _upload_blobber_files 10:38:29 INFO - Blob upload gear active. 10:38:29 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:38:29 INFO - Copying logs to upload dir... 10:38:29 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.846507 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-23 10:38:29.081697) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:38:29.085002) ========= 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.LQDMyeLMvL/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.OcC8tJdbZB/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009475 build_url: 'https://queue.taskcluster.net/v1/task/gAt8FJ61SYKGS02LU5x8fA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:38:29.108170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:38:29.108479) ========= 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.LQDMyeLMvL/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.OcC8tJdbZB/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005128 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:38:29.157364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 10:38:29.157680) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 10:38:29.158038) ========= ========= Total master_lag: 1.59 =========