builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0095 starttime: 1447656995.23 results: success (0) buildid: 20151115210907 builduid: a89dd5d0cfca4e208dbc92de74ff1128 revision: 951e77fb1760a8f2047fe7f83217f69f480181a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.228272) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.228804) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.229178) ========= 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.hfTL40YFsd/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.MDH2ZOVo7f/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006289 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.271011) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.271360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.355256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.355606) ========= 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.hfTL40YFsd/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.MDH2ZOVo7f/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005822 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.428514) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.428870) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.429631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.429993) ========= 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.hfTL40YFsd/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.MDH2ZOVo7f/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-15 22:56:35-- 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, 63.245.215.25, ... 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% 5.55M=0.002s 2015-11-15 22:56:35 (5.55 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.411969 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.866717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.867223) ========= 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.hfTL40YFsd/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.MDH2ZOVo7f/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.021673 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:35.925920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-15 22:56:35.926578) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 951e77fb1760a8f2047fe7f83217f69f480181a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 951e77fb1760a8f2047fe7f83217f69f480181a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-15 22:56:36,012 truncating revision to first 12 chars 2015-11-15 22:56:36,013 Setting DEBUG logging. 2015-11-15 22:56:36,013 attempt 1/10 2015-11-15 22:56:36,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/951e77fb1760?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 22:56:37,040 unpacking tar archive at: mozilla-inbound-951e77fb1760/testing/mozharness/ program finished with exit code 0 elapsedTime=1.333140 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-15 22:56:37.281649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:37.281966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:37.296561) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:37.296881) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 22:56:37.297353) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-15 22:56:37.297687) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 22:56:37 INFO - MultiFileLogger online at 20151115 22:56:37 in /builds/slave/test 22:56:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:56:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:56:37 INFO - {'append_to_log': False, 22:56:37 INFO - 'base_work_dir': '/builds/slave/test', 22:56:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:56:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:56:37 INFO - 'branch': 'Mozilla-Inbound', 22:56:37 INFO - 'buildbot_json_path': 'buildprops.json', 22:56:37 INFO - 'config_files': ('talos/mac_config.py',), 22:56:37 INFO - 'default_actions': ('clobber', 22:56:37 INFO - 'read-buildbot-config', 22:56:37 INFO - 'download-and-extract', 22:56:37 INFO - 'populate-webroot', 22:56:37 INFO - 'create-virtualenv', 22:56:37 INFO - 'install', 22:56:37 INFO - 'run-tests'), 22:56:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:56:37 INFO - 'download_minidump_stackwalk': True, 22:56:37 INFO - 'download_symbols': 'ondemand', 22:56:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:56:37 INFO - 'tooltool.py': '/tools/tooltool.py', 22:56:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:56:37 INFO - '/tools/misc-python/virtualenv.py')}, 22:56:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:56:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:56:37 INFO - 'installer_path': 'installer.exe', 22:56:37 INFO - 'log_level': 'info', 22:56:37 INFO - 'log_name': 'talos', 22:56:37 INFO - 'log_to_console': True, 22:56:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:56:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:56:37 INFO - 'opt_config_files': (), 22:56:37 INFO - 'pip_index': False, 22:56:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:37 INFO - 'cmd': ('bash', 22:56:37 INFO - '-c', 22:56:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:37 INFO - 'enabled': True, 22:56:37 INFO - 'halt_on_failure': False, 22:56:37 INFO - 'name': 'check_screen_resolution'},), 22:56:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:37 INFO - 'cmd': ('bash', 22:56:37 INFO - '-c', 22:56:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:37 INFO - 'enabled': True, 22:56:37 INFO - 'halt_on_failure': False, 22:56:37 INFO - 'name': 'check_screen_resolution'},), 22:56:37 INFO - 'run_cmd_checks_enabled': True, 22:56:37 INFO - 'sps_profile': False, 22:56:37 INFO - 'sps_profile_interval': 0, 22:56:37 INFO - 'suite': 'dromaeojs', 22:56:37 INFO - 'system_bits': '64', 22:56:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:56:37 INFO - 'title': 't-yosemite-r5-0095', 22:56:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:56:37 INFO - 'use_talos_json': True, 22:56:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:56:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:56:37 INFO - 'work_dir': 'build'} 22:56:37 INFO - ##### 22:56:37 INFO - ##### Running clobber step. 22:56:37 INFO - ##### 22:56:37 INFO - Running pre-action listener: _resource_record_pre_action 22:56:37 INFO - Running main action method: clobber 22:56:37 INFO - rmtree: /builds/slave/test/build 22:56:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:56:40 INFO - Running post-action listener: _resource_record_post_action 22:56:40 INFO - ##### 22:56:40 INFO - ##### Running read-buildbot-config step. 22:56:40 INFO - ##### 22:56:40 INFO - Running pre-action listener: _resource_record_pre_action 22:56:40 INFO - Running main action method: read_buildbot_config 22:56:40 INFO - Using buildbot properties: 22:56:40 INFO - { 22:56:40 INFO - "properties": { 22:56:40 INFO - "buildnumber": 3297, 22:56:40 INFO - "product": "firefox", 22:56:40 INFO - "script_repo_revision": "production", 22:56:40 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 22:56:40 INFO - "repository": "", 22:56:40 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 22:56:40 INFO - "buildid": "20151115210907", 22:56:40 INFO - "slavename": "t-yosemite-r5-0095", 22:56:40 INFO - "pgo_build": "False", 22:56:40 INFO - "basedir": "/builds/slave/test", 22:56:40 INFO - "project": "", 22:56:40 INFO - "platform": "yosemite", 22:56:40 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:56:40 INFO - "slavebuilddir": "test", 22:56:40 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 22:56:40 INFO - "branch": "mozilla-inbound", 22:56:40 INFO - "repo_path": "integration/mozilla-inbound", 22:56:40 INFO - "stage_platform": "macosx64", 22:56:40 INFO - "builduid": "a89dd5d0cfca4e208dbc92de74ff1128", 22:56:40 INFO - "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2" 22:56:40 INFO - }, 22:56:40 INFO - "sourcestamp": { 22:56:40 INFO - "repository": "", 22:56:40 INFO - "hasPatch": false, 22:56:40 INFO - "project": "", 22:56:40 INFO - "branch": "mozilla-inbound-macosx64-talos", 22:56:40 INFO - "changes": [ 22:56:40 INFO - { 22:56:40 INFO - "category": null, 22:56:40 INFO - "files": [ 22:56:40 INFO - { 22:56:40 INFO - "url": null, 22:56:40 INFO - "name": "https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 22:56:40 INFO - } 22:56:40 INFO - ], 22:56:40 INFO - "repository": "", 22:56:40 INFO - "rev": "951e77fb1760a8f2047fe7f83217f69f480181a2", 22:56:40 INFO - "who": "nnethercote@mozilla.com", 22:56:40 INFO - "when": 1447656924, 22:56:40 INFO - "number": 6665003, 22:56:40 INFO - "comments": "Bug 1217465 - Fill in missing pixels caused by truncated BMP files. r=seth.\n\nThis fixes failures for\nimage/test/reftest/bmp/bmpsuite/b/{badrle.bmp,shortfile.bmp} with the Skia\nback-end.", 22:56:40 INFO - "project": "", 22:56:40 INFO - "at": "Sun 15 Nov 2015 22:55:24", 22:56:40 INFO - "branch": "mozilla-inbound-macosx64-talos", 22:56:40 INFO - "revlink": "", 22:56:40 INFO - "properties": [ 22:56:40 INFO - [ 22:56:40 INFO - "buildid", 22:56:40 INFO - "20151115210907", 22:56:40 INFO - "Change" 22:56:40 INFO - ], 22:56:40 INFO - [ 22:56:40 INFO - "builduid", 22:56:40 INFO - "a89dd5d0cfca4e208dbc92de74ff1128", 22:56:40 INFO - "Change" 22:56:40 INFO - ], 22:56:40 INFO - [ 22:56:40 INFO - "pgo_build", 22:56:40 INFO - "False", 22:56:40 INFO - "Change" 22:56:40 INFO - ] 22:56:40 INFO - ], 22:56:40 INFO - "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2" 22:56:40 INFO - } 22:56:40 INFO - ], 22:56:40 INFO - "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2" 22:56:40 INFO - } 22:56:40 INFO - } 22:56:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 22:56:40 INFO - Running post-action listener: _resource_record_post_action 22:56:40 INFO - ##### 22:56:40 INFO - ##### Running download-and-extract step. 22:56:40 INFO - ##### 22:56:40 INFO - Running pre-action listener: _resource_record_pre_action 22:56:40 INFO - Running main action method: download_and_extract 22:56:40 INFO - mkdir: /builds/slave/test/build/tests 22:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:40 INFO - https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/test_packages.json 22:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/test_packages.json 22:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:56:41 INFO - Downloaded 1149 bytes. 22:56:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:56:41 INFO - Using the following test package requirements: 22:56:41 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:56:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:56:41 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 22:56:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:56:41 INFO - u'jsshell-mac.zip'], 22:56:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:56:41 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 22:56:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:56:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:56:41 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 22:56:41 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:56:41 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 22:56:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:56:41 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 22:56:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:56:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:56:41 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 22:56:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:41 INFO - https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/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 22:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/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 22:56:42 INFO - Downloaded 17464104 bytes. 22:56:42 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 22:56:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:56:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:56:48 INFO - Return code: 0 22:56:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:48 INFO - https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/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 22:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/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 22:56:50 INFO - Downloaded 17464104 bytes. 22:56:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 22:56:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:56:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:56:55 INFO - Return code: 0 22:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:55 INFO - https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/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 22:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/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 22:56:56 INFO - Downloaded 11131693 bytes. 22:56:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 22:56:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:56:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:56:57 INFO - Return code: 0 22:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:57 INFO - https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:56:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:56:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:56:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 22:56:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mOYplzfFSJ6GBerQ78TcGQ/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 22:57:00 INFO - Downloaded 108781214 bytes. 22:57:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:57:00 INFO - mkdir: /builds/slave/test/properties 22:57:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:57:00 INFO - Writing to file /builds/slave/test/properties/build_url 22:57:00 INFO - Contents: 22:57:00 INFO - build_url:https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:57:00 INFO - Running post-action listener: _resource_record_post_action 22:57:00 INFO - Running post-action listener: set_extra_try_arguments 22:57:00 INFO - ##### 22:57:00 INFO - ##### Running populate-webroot step. 22:57:00 INFO - ##### 22:57:00 INFO - Running pre-action listener: _resource_record_pre_action 22:57:00 INFO - Running main action method: populate_webroot 22:57:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:57:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:57:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:57:00 INFO - '../fennec_ids.txt'], 22:57:00 INFO - 'tests': ['tcheck2']}, 22:57:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:57:00 INFO - '--tppagecycles', 22:57:00 INFO - '7'], 22:57:00 INFO - 'tests': ['tsvgm']}}, 22:57:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:57:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:57:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:57:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:57:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:00 INFO - 'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:00 INFO - 'tests': ['damp', 'tps']}, 22:57:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:00 INFO - 'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['damp', 'tps']}, 22:57:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:57:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:57:00 INFO - 'other': {'tests': ['a11yr', 22:57:00 INFO - 'ts_paint', 22:57:00 INFO - 'tpaint', 22:57:00 INFO - 'sessionrestore', 22:57:00 INFO - 'sessionrestore_no_auto_restore']}, 22:57:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['a11yr', 22:57:00 INFO - 'ts_paint', 22:57:00 INFO - 'tpaint', 22:57:00 INFO - 'sessionrestore', 22:57:00 INFO - 'sessionrestore_no_auto_restore']}, 22:57:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['a11yr', 22:57:00 INFO - 'ts_paint', 22:57:00 INFO - 'tpaint', 22:57:00 INFO - 'sessionrestore', 22:57:00 INFO - 'sessionrestore_no_auto_restore']}, 22:57:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['a11yr', 22:57:00 INFO - 'ts_paint', 22:57:00 INFO - 'tpaint', 22:57:00 INFO - 'sessionrestore', 22:57:00 INFO - 'sessionrestore_no_auto_restore']}, 22:57:00 INFO - 'other_l64': {'tests': ['a11yr', 22:57:00 INFO - 'ts_paint', 22:57:00 INFO - 'tpaint', 22:57:00 INFO - 'sessionrestore', 22:57:00 INFO - 'sessionrestore_no_auto_restore']}, 22:57:00 INFO - 'other_nol64': {'tests': ['a11yr', 22:57:00 INFO - 'ts_paint', 22:57:00 INFO - 'tpaint', 22:57:00 INFO - 'sessionrestore', 22:57:00 INFO - 'sessionrestore_no_auto_restore']}, 22:57:00 INFO - 'svgr': {'tests': ['tsvgx', 22:57:00 INFO - 'tsvgr_opacity', 22:57:00 INFO - 'tart', 22:57:00 INFO - 'tscrollx', 22:57:00 INFO - 'cart']}, 22:57:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['tsvgx', 22:57:00 INFO - 'tsvgr_opacity', 22:57:00 INFO - 'tart', 22:57:00 INFO - 'tscrollx', 22:57:00 INFO - 'cart']}, 22:57:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:00 INFO - 'tests': ['tp5o']}, 22:57:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:00 INFO - 'talos_options': ['--e10s'], 22:57:00 INFO - 'tests': ['tp5o']}, 22:57:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:00 INFO - 'talos_options': ['--xperf_path', 22:57:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:00 INFO - 'tests': ['tp5n']}, 22:57:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:00 INFO - 'talos_options': ['--e10s', 22:57:00 INFO - '--xperf_path', 22:57:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:00 INFO - 'tests': ['tp5n']}}, 22:57:00 INFO - 'talos.zip': {'path': '', 22:57:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:57:00 INFO - Running post-action listener: _resource_record_post_action 22:57:00 INFO - ##### 22:57:00 INFO - ##### Running create-virtualenv step. 22:57:00 INFO - ##### 22:57:00 INFO - Running pre-action listener: _resource_record_pre_action 22:57:00 INFO - Running main action method: create_virtualenv 22:57:00 INFO - Creating virtualenv /builds/slave/test/build/venv 22:57:00 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 22:57:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:57:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:57:00 INFO - Using real prefix '/tools/python27' 22:57:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:57:01 INFO - Installing distribute.............................................................................................................................................................................................done. 22:57:06 INFO - Installing pip.................done. 22:57:06 INFO - Return code: 0 22:57:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:06 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 0x104ab2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a8f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e90c8b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049d59f0>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049c98c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:06 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 22:57:06 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 22:57:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/Render', 22:57:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:06 INFO - 'HOME': '/Users/cltbld', 22:57:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:06 INFO - 'LOGNAME': 'cltbld', 22:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:06 INFO - 'MOZ_NO_REMOTE': '1', 22:57:06 INFO - 'NO_EM_RESTART': '1', 22:57:06 INFO - 'PAGER': '/bin/cat', 22:57:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:06 INFO - 'PWD': '/builds/slave/test', 22:57:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:06 INFO - 'SHELL': '/bin/bash', 22:57:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MDH2ZOVo7f/Listeners', 22:57:06 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 22:57:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:06 INFO - 'USER': 'cltbld', 22:57:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:06 INFO - 'XPC_FLAGS': '0x0', 22:57:06 INFO - 'XPC_SERVICE_NAME': '0', 22:57:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:07 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 22:57:07 INFO - Cleaning up... 22:57:07 INFO - Return code: 0 22:57:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104ab2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a8f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e90c8b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049d59f0>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049c98c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:57:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/Render', 22:57:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:07 INFO - 'HOME': '/Users/cltbld', 22:57:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:07 INFO - 'LOGNAME': 'cltbld', 22:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:07 INFO - 'MOZ_NO_REMOTE': '1', 22:57:07 INFO - 'NO_EM_RESTART': '1', 22:57:07 INFO - 'PAGER': '/bin/cat', 22:57:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:07 INFO - 'PWD': '/builds/slave/test', 22:57:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:07 INFO - 'SHELL': '/bin/bash', 22:57:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MDH2ZOVo7f/Listeners', 22:57:07 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 22:57:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:07 INFO - 'USER': 'cltbld', 22:57:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:07 INFO - 'XPC_FLAGS': '0x0', 22:57:07 INFO - 'XPC_SERVICE_NAME': '0', 22:57:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:07 INFO - Downloading/unpacking psutil>=0.7.1 22:57:07 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 22:57:07 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 22:57:07 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 22:57:07 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 22:57:07 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 22:57:07 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 22:57:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:57:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:57:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:10 INFO - Installing collected packages: psutil 22:57:10 INFO - Running setup.py install for psutil 22:57:10 INFO - building 'psutil._psutil_osx' extension 22:57:10 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 22:57:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:57:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:57:11 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 22:57:11 INFO - building 'psutil._psutil_posix' extension 22:57:11 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 22:57:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:57:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:57:11 INFO - ^ 22:57:11 INFO - 1 warning generated. 22:57:11 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 22:57:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:11 INFO - Successfully installed psutil 22:57:11 INFO - Cleaning up... 22:57:11 INFO - Return code: 0 22:57:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:57: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')]} 22:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57: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')]} 22:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:11 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 0x104ab2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a8f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e90c8b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049d59f0>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049c98c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:11 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 22:57:11 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 22:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/Render', 22:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:11 INFO - 'HOME': '/Users/cltbld', 22:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:11 INFO - 'LOGNAME': 'cltbld', 22:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:11 INFO - 'MOZ_NO_REMOTE': '1', 22:57:11 INFO - 'NO_EM_RESTART': '1', 22:57:11 INFO - 'PAGER': '/bin/cat', 22:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:11 INFO - 'PWD': '/builds/slave/test', 22:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:11 INFO - 'SHELL': '/bin/bash', 22:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MDH2ZOVo7f/Listeners', 22:57:11 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 22:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:11 INFO - 'USER': 'cltbld', 22:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:11 INFO - 'XPC_FLAGS': '0x0', 22:57:11 INFO - 'XPC_SERVICE_NAME': '0', 22:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:57:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:57:14 INFO - Installing collected packages: mozsystemmonitor 22:57:14 INFO - Running setup.py install for mozsystemmonitor 22:57:15 INFO - Successfully installed mozsystemmonitor 22:57:15 INFO - Cleaning up... 22:57:15 INFO - Return code: 0 22:57:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:57: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')]} 22:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57: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')]} 22:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104ab2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a8f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e90c8b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049d59f0>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049c98c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/Render', 22:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:15 INFO - 'HOME': '/Users/cltbld', 22:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:15 INFO - 'LOGNAME': 'cltbld', 22:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:15 INFO - 'MOZ_NO_REMOTE': '1', 22:57:15 INFO - 'NO_EM_RESTART': '1', 22:57:15 INFO - 'PAGER': '/bin/cat', 22:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:15 INFO - 'PWD': '/builds/slave/test', 22:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:15 INFO - 'SHELL': '/bin/bash', 22:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MDH2ZOVo7f/Listeners', 22:57:15 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 22:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:15 INFO - 'USER': 'cltbld', 22:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:15 INFO - 'XPC_FLAGS': '0x0', 22:57:15 INFO - 'XPC_SERVICE_NAME': '0', 22:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:15 INFO - Downloading/unpacking blobuploader==1.2.4 22:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:18 INFO - Downloading blobuploader-1.2.4.tar.gz 22:57:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:57:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:57:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:57:19 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 22:57:19 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 22:57:19 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 22:57:19 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 22:57:19 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 22:57:19 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 22:57:19 INFO - Downloading docopt-0.6.1.tar.gz 22:57:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:57:19 INFO - Installing collected packages: blobuploader, requests, docopt 22:57:19 INFO - Running setup.py install for blobuploader 22:57:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:57:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:57:19 INFO - Running setup.py install for requests 22:57:20 INFO - Running setup.py install for docopt 22:57:20 INFO - Successfully installed blobuploader requests docopt 22:57:20 INFO - Cleaning up... 22:57:20 INFO - Return code: 0 22:57:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:20 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')]} 22:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:20 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')]} 22:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:20 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 0x104ab2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a8f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e90c8b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049d59f0>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049c98c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:20 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 22:57:20 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 22:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/Render', 22:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:20 INFO - 'HOME': '/Users/cltbld', 22:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:20 INFO - 'LOGNAME': 'cltbld', 22:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:20 INFO - 'MOZ_NO_REMOTE': '1', 22:57:20 INFO - 'NO_EM_RESTART': '1', 22:57:20 INFO - 'PAGER': '/bin/cat', 22:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:20 INFO - 'PWD': '/builds/slave/test', 22:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:20 INFO - 'SHELL': '/bin/bash', 22:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MDH2ZOVo7f/Listeners', 22:57:20 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 22:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:20 INFO - 'USER': 'cltbld', 22:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:20 INFO - 'XPC_FLAGS': '0x0', 22:57:20 INFO - 'XPC_SERVICE_NAME': '0', 22:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:57:21 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-i7kO5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:57:21 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-FD29Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:57:21 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-7d4Of7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:57:21 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-20kJHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:57:21 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-9Ym9uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:57:21 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-iT3jtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:57:21 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-GaQoLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:57:22 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-MsybJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:57:22 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-vyiOIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:57:22 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-Isrf6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:22 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-tIGzfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:22 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-RP0dd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:22 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-9frYaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:22 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-XGtiGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:23 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-lccydf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:23 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-oYOY9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:23 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-Zdvwns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:57:23 INFO - Running setup.py install for manifestparser 22:57:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:57:23 INFO - Running setup.py install for mozcrash 22:57:23 INFO - Running setup.py install for mozdebug 22:57:23 INFO - Running setup.py install for mozdevice 22:57:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:57:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:57:24 INFO - Running setup.py install for mozfile 22:57:24 INFO - Running setup.py install for mozhttpd 22:57:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:57:24 INFO - Running setup.py install for mozinfo 22:57:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:57:24 INFO - Running setup.py install for mozInstall 22:57:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:57:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:57:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:57:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:57:24 INFO - Running setup.py install for mozleak 22:57:25 INFO - Running setup.py install for mozlog 22:57:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:57:25 INFO - Running setup.py install for moznetwork 22:57:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:57:25 INFO - Running setup.py install for mozprocess 22:57:25 INFO - Running setup.py install for mozprofile 22:57:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:57:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:57:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:57:25 INFO - Running setup.py install for mozrunner 22:57:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:57:26 INFO - Running setup.py install for mozscreenshot 22:57:26 INFO - Running setup.py install for moztest 22:57:26 INFO - Running setup.py install for mozversion 22:57:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:57:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:57:26 INFO - Cleaning up... 22:57:26 INFO - Return code: 0 22:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:26 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')]} 22:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:26 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')]} 22:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:26 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 0x104ab2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a8f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e90c8b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049d59f0>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049c98c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:26 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 22:57:26 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 22:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/Render', 22:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:26 INFO - 'HOME': '/Users/cltbld', 22:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:26 INFO - 'LOGNAME': 'cltbld', 22:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:26 INFO - 'MOZ_NO_REMOTE': '1', 22:57:26 INFO - 'NO_EM_RESTART': '1', 22:57:26 INFO - 'PAGER': '/bin/cat', 22:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:26 INFO - 'PWD': '/builds/slave/test', 22:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:26 INFO - 'SHELL': '/bin/bash', 22:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MDH2ZOVo7f/Listeners', 22:57:26 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 22:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:26 INFO - 'USER': 'cltbld', 22:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:26 INFO - 'XPC_FLAGS': '0x0', 22:57:26 INFO - 'XPC_SERVICE_NAME': '0', 22:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:57:27 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-hzarjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:57:27 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)) 22:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:57:27 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-TzeOf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:57:27 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)) 22:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:57:27 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-e7Ksp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:57:27 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)) 22:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:57:27 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-2KFwAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:57:27 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)) 22:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:57:27 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-KprImJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:57:27 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)) 22:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:57:27 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-LrAdvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:57:27 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)) 22:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:57:27 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-isyCJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:57:28 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)) 22:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:57:28 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-G6LAlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:57:28 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)) 22:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:57:28 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-Rt3X_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:57:28 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)) 22:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:57:28 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-0vVctM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:28 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-_7pkNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:28 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)) 22:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:28 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-fOSySw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:28 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)) 22:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:28 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-ZeTMm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:28 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)) 22:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:28 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-gzuWpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:29 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)) 22:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:29 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-xJKFNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:29 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)) 22:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:29 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-fwKmhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:29 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)) 22:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:29 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-WDt4gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:29 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)) 22:57:29 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)) 22:57:29 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)) 22:57:29 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)) 22:57:29 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)) 22:57:29 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)) 22:57:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:32 INFO - Downloading blessings-1.5.1.tar.gz 22:57:32 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 22:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:57:32 INFO - Installing collected packages: blessings 22:57:32 INFO - Running setup.py install for blessings 22:57:32 INFO - Successfully installed blessings 22:57:32 INFO - Cleaning up... 22:57:32 INFO - Return code: 0 22:57:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:33 INFO - Reading from file tmpfile_stdout 22:57:33 INFO - Current package versions: 22:57:33 INFO - blessings == 1.5.1 22:57:33 INFO - blobuploader == 1.2.4 22:57:33 INFO - docopt == 0.6.1 22:57:33 INFO - manifestparser == 1.1 22:57:33 INFO - mozInstall == 1.12 22:57:33 INFO - mozcrash == 0.16 22:57:33 INFO - mozdebug == 0.1 22:57:33 INFO - mozdevice == 0.47 22:57:33 INFO - mozfile == 1.2 22:57:33 INFO - mozhttpd == 0.7 22:57:33 INFO - mozinfo == 0.9 22:57:33 INFO - mozleak == 0.1 22:57:33 INFO - mozlog == 3.0 22:57:33 INFO - moznetwork == 0.27 22:57:33 INFO - mozprocess == 0.22 22:57:33 INFO - mozprofile == 0.27 22:57:33 INFO - mozrunner == 6.11 22:57:33 INFO - mozscreenshot == 0.1 22:57:33 INFO - mozsystemmonitor == 0.0 22:57:33 INFO - moztest == 0.7 22:57:33 INFO - mozversion == 1.4 22:57:33 INFO - psutil == 3.1.1 22:57:33 INFO - requests == 1.2.3 22:57:33 INFO - wsgiref == 0.1.2 22:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:33 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')]} 22:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:33 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')]} 22:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:33 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 0x104ab2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a8f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e90c8b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049d59f0>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049c98c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/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.MDH2ZOVo7f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:33 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 22:57:33 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 22:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/Render', 22:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:33 INFO - 'HOME': '/Users/cltbld', 22:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:33 INFO - 'LOGNAME': 'cltbld', 22:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:33 INFO - 'MOZ_NO_REMOTE': '1', 22:57:33 INFO - 'NO_EM_RESTART': '1', 22:57:33 INFO - 'PAGER': '/bin/cat', 22:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:33 INFO - 'PWD': '/builds/slave/test', 22:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:33 INFO - 'SHELL': '/bin/bash', 22:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MDH2ZOVo7f/Listeners', 22:57:33 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 22:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:33 INFO - 'USER': 'cltbld', 22:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:33 INFO - 'XPC_FLAGS': '0x0', 22:57:33 INFO - 'XPC_SERVICE_NAME': '0', 22:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 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)) 22:57:33 INFO - Cleaning up... 22:57:33 INFO - Return code: 0 22:57:33 INFO - Running post-action listener: _resource_record_post_action 22:57:33 INFO - Running post-action listener: _start_resource_monitoring 22:57:33 INFO - Starting resource monitoring. 22:57:33 INFO - ##### 22:57:33 INFO - ##### Running install step. 22:57:33 INFO - ##### 22:57:33 INFO - Running pre-action listener: _resource_record_pre_action 22:57:33 INFO - Running main action method: install 22:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:33 INFO - Reading from file tmpfile_stdout 22:57:33 INFO - Detecting whether we're running mozinstall >=1.0... 22:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:57:33 INFO - Reading from file tmpfile_stdout 22:57:33 INFO - Output received: 22:57:33 INFO - Usage: mozinstall [options] installer 22:57:33 INFO - Options: 22:57:33 INFO - -h, --help show this help message and exit 22:57:33 INFO - -d DEST, --destination=DEST 22:57:33 INFO - Directory to install application into. [default: 22:57:33 INFO - "/builds/slave/test"] 22:57:33 INFO - --app=APP Application being installed. [default: firefox] 22:57:33 INFO - mkdir: /builds/slave/test/build/application 22:57:33 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'] 22:57:33 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 22:58:16 INFO - Reading from file tmpfile_stdout 22:58:16 INFO - Output received: 22:58:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:58:16 INFO - Running post-action listener: _resource_record_post_action 22:58:16 INFO - ##### 22:58:16 INFO - ##### Running run-tests step. 22:58:16 INFO - ##### 22:58:16 INFO - Running pre-action listener: _resource_record_pre_action 22:58:16 INFO - Running main action method: run_tests 22:58:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:58:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:58:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:58:16 INFO - 2015-11-15 22:58:16.140 screenresolution[1913:19824] starting screenresolution argv=screenresolution get 22:58:16 INFO - 2015-11-15 22:58:16.144 screenresolution[1913:19824] Display 0: 1600x1200x32@60 22:58:16 INFO - 2015-11-15 22:58:16.151 screenresolution[1914:19826] starting screenresolution argv=screenresolution list 22:58:16 INFO - Available Modes on Display 0 22:58:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:58:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:58:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:58:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:58:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:58:16 INFO - Intel HD Graphics 3000: 22:58:16 INFO - Chipset Model: Intel HD Graphics 3000 22:58:16 INFO - Type: GPU 22:58:16 INFO - Bus: Built-In 22:58:16 INFO - VRAM (Total): 512 MB 22:58:16 INFO - VRAM (Dynamic, Max): 10 22:58:16 INFO - Vendor: Intel (0x8086) 22:58:16 INFO - Device ID: 0x0116 22:58:16 INFO - Revision ID: 0x0009 22:58:16 INFO - Displays: 22:58:16 INFO - Display: 22:58:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:58:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:58:16 INFO - Display Serial Number: 1600x1200 60 22:58:16 INFO - Main Display: Yes 22:58:16 INFO - Mirror: Off 22:58:16 INFO - Online: Yes 22:58:16 INFO - Rotation: Supported 22:58:16 INFO - Return code: 0 22:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:58:16 INFO - Python 2.7.3 22:58:16 INFO - Return code: 0 22:58:16 INFO - grabbing minidump binary from tooltool 22:58:16 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')]} 22:58:16 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 0x1049d59f0>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1049c98c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:58:16 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 22:58:16 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 22:58:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:58:16 INFO - Return code: 0 22:58:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:58:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:58:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:58:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:58:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0095', '--webServer', 'localhost'] in /builds/slave/test/build 22:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0095 --webServer localhost 22:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hfTL40YFsd/Render', 22:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:58:16 INFO - 'HOME': '/Users/cltbld', 22:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:58:16 INFO - 'LOGNAME': 'cltbld', 22:58:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:58:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:16 INFO - 'MOZ_NO_REMOTE': '1', 22:58:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:58:16 INFO - 'NO_EM_RESTART': '1', 22:58:16 INFO - 'PAGER': '/bin/cat', 22:58:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:16 INFO - 'PWD': '/builds/slave/test', 22:58:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:58:16 INFO - 'SHELL': '/bin/bash', 22:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MDH2ZOVo7f/Listeners', 22:58:16 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 22:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:58:16 INFO - 'USER': 'cltbld', 22:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:16 INFO - 'XPC_FLAGS': '0x0', 22:58:16 INFO - 'XPC_SERVICE_NAME': '0', 22:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:58:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0095', '--webServer', 'localhost'] with output_timeout 3600 22:58:16 INFO - mozversion INFO | application_buildid: 20151115210907 22:58:16 INFO - mozversion INFO | application_changeset: 951e77fb1760a8f2047fe7f83217f69f480181a2 22:58:16 INFO - mozversion INFO | application_display_name: Nightly 22:58:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:58:16 INFO - mozversion INFO | application_name: Firefox 22:58:16 INFO - mozversion INFO | application_remotingname: firefox 22:58:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:58:16 INFO - mozversion INFO | application_vendor: Mozilla 22:58:16 INFO - mozversion INFO | application_version: 45.0a1 22:58:16 INFO - mozversion INFO | platform_buildid: 20151115210907 22:58:16 INFO - mozversion INFO | platform_changeset: 951e77fb1760a8f2047fe7f83217f69f480181a2 22:58:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:58:16 INFO - mozversion INFO | platform_version: 45.0a1 22:58:16 INFO - 2015-11-15 22:58:16,832 DEBUG : using testdate: 1447657096 22:58:16 INFO - 2015-11-15 22:58:16,832 DEBUG : actual date: 1447657096 22:58:16 INFO - 2015-11-15 22:58:16,880 INFO : starting webserver on 'localhost:57346' 22:58:16 INFO - 2015-11-15 22:58:16,881 INFO : Starting test suite t-yosemite-r5-0095 22:58:16 INFO - 2015-11-15 22:58:16,881 INFO : Starting test dromaeo_css 22:58:16 INFO - 2015-11-15 22:58:16,881 DEBUG : operating with platform_type : mac_ 22:58:16 INFO - 2015-11-15 22:58:16,882 INFO : Initialising browser for dromaeo_css test... 22:58:16 INFO - 2015-11-15 22:58:16,898 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpxtREtv/profile http://localhost:57346/getInfo.html 22:58:19 INFO - 2015-11-15 22:58:19,546 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:58:19 INFO - 2015-11-15 22:58:19,546 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:58:19 INFO - 2015-11-15 22:58:19,546 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:58:19 INFO - 2015-11-15 22:58:19,547 DEBUG : BROWSER_OUTPUT: __metrics 22:58:19 INFO - 2015-11-15 22:58:19,564 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:58:20 INFO - 2015-11-15 22:58:20,355 INFO : Browser initialized. 22:58:20 INFO - 2015-11-15 22:58:20,355 INFO : Running cycle 1/1 for dromaeo_css test... 22:58:20 INFO - 2015-11-15 22:58:20,356 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpxtREtv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:58:32 INFO - 2015-11-15 22:58:32,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 230383616 22:58:32 INFO - 2015-11-15 22:58:32,563 DEBUG : BROWSER_OUTPUT: 22:59:24 INFO - 2015-11-15 22:59:24,357 DEBUG : BROWSER_OUTPUT: 1447657164352 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] 23:01:34 INFO - 2015-11-15 23:01:34,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57346/tests/dromaeo/cssquery-ext.html) 23:01:35 INFO - 2015-11-15 23:01:35,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 343052288 23:01:35 INFO - 2015-11-15 23:01:35,938 DEBUG : BROWSER_OUTPUT: 23:04:38 INFO - 2015-11-15 23:04:38,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/dromaeo/cssquery-ext.html (next: http://localhost:57346/tests/dromaeo/cssquery-jquery.html) 23:04:39 INFO - 2015-11-15 23:04:39,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 361906176 23:04:39 INFO - 2015-11-15 23:04:39,477 DEBUG : BROWSER_OUTPUT: 23:07:41 INFO - 2015-11-15 23:07:41,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57346/tests/dromaeo/cssquery-mootools.html) 23:07:42 INFO - 2015-11-15 23:07:42,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 328478720 23:07:42 INFO - 2015-11-15 23:07:42,340 DEBUG : BROWSER_OUTPUT: 23:10:44 INFO - 2015-11-15 23:10:44,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57346/tests/dromaeo/cssquery-prototype.html) 23:10:45 INFO - 2015-11-15 23:10:45,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 318730240 23:10:45 INFO - 2015-11-15 23:10:45,081 DEBUG : BROWSER_OUTPUT: 23:13:48 INFO - 2015-11-15 23:13:48,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57346/tests/dromaeo/cssquery-yui.html) 23:13:49 INFO - 2015-11-15 23:13:49,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 319795200 23:13:49 INFO - 2015-11-15 23:13:49,058 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/dromaeo/cssquery-yui.html (next: http://localhost:57346/tests/dromaeo/cssquery-dojo.html) 23:16:52 INFO - 2015-11-15 23:16:52,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 363003904 23:16:52 INFO - 2015-11-15 23:16:52,565 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,565 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:16:52 INFO - 2015-11-15 23:16:52,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:16:52 INFO - 2015-11-15 23:16:52,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:16:52 INFO - 2015-11-15 23:16:52,565 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:16:52 INFO - 2015-11-15 23:16:52,565 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2609.882555285012;2703.8648067596628;2712.2541301142196;2738.739819717127;2742.6708794944598;4406.008648054186;4473.418455600771;4487.775611219442;4546.613537849283;4567.931481027783;4443.888902777432;4479.574440428162;4496.123255965088;4664.673472856902;4671.159191345557;4089.5705950875176;4170.186813571355;4205.201011807762;4214.978925105385;4225.704200705952;4224.239636865363;4248.893777655568;4257.957420425787;4295.226859165349;4323.373110898918;4013.478247827793;4133.607307305801;4146;4195.992961689203;4223.13425747721;4042.312806822847;4043.1711499142607;4050.291199040186;4056.391541268804;4086.3257562502154;3986.5814089520472;4091.2431200227757;4104.835806567734;4127.071408932996;4143.585641435862;4455.977720111411;4525.86422407325;4538.841140560065;4581.198290299218;4592.3800286961505;4839.782209800533;4860.833399984013;4881.438634557036;4883.584895283905;4889.3888263967;4603.194440972817;4709.387779588666;4766.451858036301;4779.259214821674;4886.389201349832;4497.595216430537;4502.527234640348;4520.9095818084115;4523.344115103358;4566.45202575693;4837.22604383304;4913.803447862117;4953.43035550909;4971;4985.551300382983;4507.977460112678;4600.194965880957;4601.585857272861;4636.374089497942;4784.545468180518;4807.95192048082;4808.663393562417;4811.855644330676;4828;4845.297431872359;4739.620830333565;4742.668013239109;4763.571278584944;4782.163121453732;4798.49615790344;4559.817607295671;4688.695234809795;4695.43654761424;4730.172219861511;4747.548982846624;3644.2529281497227;3759.154190307214;3785.9242815143543;3787.962120378761;3802.923941521154;3414.5048967899515;3416.231347946692;3454.809985450774;3455.1189446690933;3498.3003399320237;4339.153864996359;4497.325401189848;4499.482559505634;4506.0312032912425;4529.569690879362;4765.332853400527;4831.782569784298;4837;4840.515948405202;4923.163062279421;4480.215962206601;4519.954800451954;4520.141173177086;4529.184746745552;4582.358469814229;4146.398772178018;4280.935785963213;4282.357646353072;4328.285832837547;4356.390105385249;4742.288656701522;4844.927326090041;4880.804767809248;4939.2838038484215;4975.527324904128;4717.127331443694;4724.905501889874;4742.004179122423;4761.761911904322;4793.376861008047;4803.495632958489;4851.733154676526;4856.902861942812;4911.705297682151;4925.014997000686;4595.1039547287955;4655.371524844103;4723.8819029523165;4726.858194254178;4746.525347465225;4901.215805471107;4947.653664243612;4968.3292755479;4976.626752993468;4981;4557.225271703752;4761.952380476151;4769.332293478985;4798.688085274446;4799.928001079917;4527.456705195266;4588.839390621312;4603.654725895638;4661.673682842168;4726.291056341439;4564.475085365226;4657.254839225708;4657.813687452464;4677.111348843709;4684;4444.599986001275;4696.788644510937;4761.8333358333675;4781.6891902026255;4784.306275590089;4436.733795972252;4522.841700540465;4571.200039992921;4646.4191976003;4657.417822772153 23:16:52 INFO - 2015-11-15 23:16:52,567 DEBUG : BROWSER_OUTPUT: |1;ext.html;464.7908441201459;472.2444089456869;473.2357243052471;481.95421434963686;495.9213710180357;24702.382440439;25349.36626584334;32770.83614581927;33650.32699346012;33812;35669.859808411515;35671.11426614612;35677.286454270965;35692.46461303076;35805.64194358056;6858.382745552899;7515.661795219228;7724.034495688039;7766.456348055638;7803.882941755878;6923.480738944574;7009.789706308793;9252.352335336529;9402.952985235064;9462.432254064744;9181.219596334286;9246.53767311635;9263.166315031645;9309.162175404212;9345.11221433966;7084.114485689289;7267;9226.169644731974;9262.629494820232;9283.489408082552;6915.619640919747;9132.726018219464;9298.209652179572;9328.440293582338;9350.812983740356;33039.6696033039;33048.173795655064;33222.16944576381;33279.667203327896;33437;2390.9043638254448;2467.222824810179;2582.160797740723;2707.1878436468983;2763.488754580389;22147;22313.888430557905;22612.321630351114;22830;23059.884700576556;1926.3257859749117;1952.726618273443;1989.5622962948128;1995.6008798240264;1998.980010199894;229393;230242;230617.85675002757;231409;232152;49810.75094624504;50339.748301258995;50360.496395036316;50380.74809625928;50809;42830;43697.563024369985;44026.55973440289;52488.212676809875;52540.47459525356;10558.894411055944;10609.575616975235;10800.891991079989;10828.187885908588;10830.296030757976;7645.15903250642;7716.884246736304;7721.150673425918;7741;7771.145174030852;16369.754453683205;16421.261043253082;16442.260098295606;16444.424445144363;16452.87395394871;6621.569597976116;6782.593044417351;6815.897761533581;6866.896996545056;6869.7595584154315;778.1634742651672;860.7245681382022;876.2814492116403;898.196114477552;902.9322800789967;23676.7632323678;23878.328517003643;24037.879810601185;24202.87898560496;24259.393515161908;852.2995678831251;864.8443280209623;872.2803686958284;916.4959272400154;1000.8598796168542;11213.21507494484;11478.311301321948;11497.195196336343;11502.482388292547;11559.30644161353;260817;266931;269693;269953;270249;44533.332000020026;44560.77719611381;45041.32438013433;45184.77407612941;45200.321995170096;1103.365564800243;1119.9160062995309;1128.6952522818958;1131.1516362727955;1134.0983917785215;22371.217007404663;22681.546369072195;22715.432114197276;22771.430714232276;22862.657060144444;38439.807800960814;38705.806470967465;38936.41595376128;39087.2182556353;39302.01744956399;224309.96125484313;226696;229100;229252;229657;22273.44316392103;22630.886845565667;25092.12177573776;25883.223503294932;26560.203193903442;30282;31190.844045779624;31219.531707024868;31290.21774455657;31351.372972540878;26187.345316367242;29186.270343241587;29225.269368265963;29386.265343365732;29474.557881631365;27778.166655000383;28199.43601128007;28506.42987140287;28601.284967875137;28623.856880715462;24456.510869782862;24918;29068.273293166993;29588.112356629335;29652.70347296586;22140.446488837908;23891.522169556858;24029.879850600635;24157.15449959243;24184.516309673356;19582.412527624194;19773.505662358555;19966.30117945865;19996.800032000076;20656.48358791042 23:16:52 INFO - 2015-11-15 23:16:52,571 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277.77500224817885;279.40068552953915;280.1301957422204;284.80063955231344;286.7462295868157;9582.377145485538;9990.656421269878;13953.651158721037;14390.568282951515;14696.559103226893;15342.463013794519;15382.923085384557;15662.373505059812;15794.210289485509;15881.841181588181;4608.4700259470255;4755.9286610700865;4763.261694437368;4771.18889788735;4816.759162041902;4685.92971105432;4724.220503616899;4746.3117847912035;4763.118823017736;4807.399075115611;3370.96629033709;3477.7739446935866;3499.4575840744724;4694.342792009122;4699.412573428322;4927.841957140069;5062.670926389773;5115.897682046357;5156.561692256163;5170;4336.848210312655;4464.330350447426;4471.0610771737975;4490.2142125127975;4511.300748384006;17311;17704.380346687805;17828.821711782846;17918.731219031593;17950.19224134917;520.5575261028133;520.7656554550467;522.3679347988938;1702.1234064456814;1709.3590651911472;11312.547498100066;11365.374904380256;11494.885051149466;11538.480768365444;12189.817152742717;1387.7155183187422;1405.8242719660043;1410.6896482773773;1444.9422023119062;1466.787315839208;48998;50207.497925020645;50408.24387634188;50621.684723103914;51177.23234151491;8805.515696636618;8814.86777698335;8817.250533704579;8837.513936733412;8879.200871921428;11030.338179709242;11039.172062095375;11040.613578524713;11059.612913548148;11275.154363422776;5849.502792262705;5875.383084776037;5905.704714764331;6009.609375390673;6166.136740856284;5318.867028324323;5374;5382.327209098863;5387.461253874581;5438.293021907127;5112;5177.223416487557;5198.2722418861385;5203.2195170723935;5253.816116435906;1483.7700156475548;1525.1078119300334;1525.6033431307717;1546.4510098914948;1571.088768514259;288.71417296875944;355.6727810414425;373.84298594590337;376.94722738816586;383.4918732679211;8945.239654629298;9384.202342800801;9395.718128456158;9464.716058518256;9512.239020878313;359.3621322153199;373.7944130728089;376.52181729204307;389.8908305674416;397.90251388410024;4988.700677959334;5133;5206.167013277857;5281.996420680135;5298.70857102863;289601;296203;296785;315156;473515;49538.75230623824;52366.47633523692;52387.73806130945;54475.727621362435;55007.17489237665;401.2436557089907;411.26178509575385;413.1221155045528;413.72280572016217;414.4798278160949;8571.271441927505;8703.521306328214;8729.258013068706;8839.867401988846;8885.911140888767;25913.22260332193;26278.21165365042;26520.734792651827;26723.33191670224;27071.86464067667;37053.629463705016;37858.15638146834;37986.45225190246;38099.80950095232;38130;5009.724465154306;5046.21783623539;5095.363079615048;5096.770645321044;5115.616328775432;9395.436273823592;9611.711648650551;9802.65690700822;9828.017198280115;9914.652987145704;8244.381671374791;8479.576021199038;8552.743417697478;8569.82860342802;8600.182982616641;8076.919230807852;8143.307818835466;8241.340692744687;8269.503829770232;8374.581270936551;7947.721829735931;8282.958585207036;8534.23191912706;8582.399232053696;8613;4973.552380285647;5058.140116180185;5101.617378696538;5136.768845401891;5165.560927321219;8110.06734225548;8412.158784121539;8449.28181104613;8495.660173592987;8504.957475212585 23:16:52 INFO - 2015-11-15 23:16:52,572 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1047.2302857399814;1357.3620398412745;1441.9495317663884;1455.665197004689;1499.0930487055332;5997.730102145403;6206.751729930803;6216.564840461164;6495.707693153808;6515.153030106091;6485.156929599158;6542.934570654292;6590.242122155953;6598.736050557972;6658.0012998050315;1835.4585397307826;1853.453231296764;1853.6292741451696;1857.8606604504716;1857.9535511612182;1883.2937648381858;1886.6038131992298;1890.9716354254697;1928.2961718972545;1934.42934334371;1805.4583624912539;1815.3192552792702;1819.235920913213;1821.3079029968594;1821.9635607287846;1753.7281721333213;1755.4733579925971;1762.929482820692;1763.1360633289723;1773.618671985523;1808.1230603157458;1834.6697594432997;1840.917158727847;1842.1618163735468;1848.639515294518;5949.405059494059;6515.446187074104;6576.967115164442;6593.967030164867;6600.372964568406;3728.5712143103347;3827.9617203827884;3947.822347994347;4066.6746660267404;4067.654249388776;2359.3865594945264;2392.294273189396;2401.135591187171;2438.1588352018703;2456.545539075259;727.71982786627;737.9667914943841;745.202633182495;752.9623518824037;764.4037650632515;8861.778455538599;8903.777405564913;8907.421017633833;8951.776205594848;9000.189982901506;3543.0965103898343;3629.256002519477;3667.4132138857653;3675.1363429594026;3686.5576130863933;7833.882491762628;7836.255555722198;7851.882221766678;7878.448508604342;7933.246341597539;4105.322621767375;4109.383592461155;4110.2396056729;4138.937915931264;4142.730722503027;3705.555333360014;3713.145976425383;3727.6458736419995;3731.421629647409;3750.212455384345;2924.7952643314766;3001.369712360385;3013.547967804803;3014.743746781548;3019.381026889482;948.7201275623707;951.0774548687762;955.2644463762864;958.7411398922392;975.3124047546463;1073.9731506712394;1094.102835674755;1125.3585456289836;1127.21095233337;1141.9257748246337;6302.275238347557;6315.96842015787;6334.5565810393755;6336.778212762531;6340.4293613575;384.79028929233635;392.71135715249267;392.96659783918113;396.81548080142875;397.56665234894103;4595.6783025187915;4730.5032971538185;4793.832215872428;4807.471178170398;4808.326834243208;7218.458615603746;7240.927590724025;7251.311125443074;7306.488545801849;7664.08031036268;7583.2416758324825;7669.424793140425;7746.961265193638;7795.103563090317;7805.180456052146;6075.392460753889;6076.270847498328;6287;6321.273053598803;6322.114903913548;6035.728392222272;6052.939470605237;6062.484688801501;6067.271927368744;6071.058985857199;6778.152730908637;6909.136357955255;6974.37230649244;6991.615461149482;7126.35862772353;6899.793006209822;7098.183708873546;7230.566166030055;7262.818429539092;7272.636368181676;5754.4533269339345;5821.359650438533;5849.210356601804;5859.062549991981;5877.794277200277;6326.6520341381665;6358.300586935526;6401.295857455583;6410.9038364425505;6434.774782882577;5881.411858814085;5966.791162309299;5971.522278217819;5982.52139828804;6005.579609427473;5827.329857066492;5833.241678581927;5927.733252003584;5942.019566771434;5961.672108034099;5986.132010858489;6050.15297858309;6052.515798736003;6081.665508397081;6097;5260.763265653131;5481.725913704219;5492.423295554069;5500.642458240201;5512.779488820403;5542.695151766691;5599.916001259903;5602.915956260578;5644.096944488862;5653.236813030188 23:16:52 INFO - 2015-11-15 23:16:52,576 DEBUG : BROWSER_OUTPUT: |4;prototype.html;257.84786975684347;259.8999385236683;266.37003486753827;267.33167082294267;268.9569668852984;5140.357455318085;5216.035033518801;5329;5351.866203344918;5352.5182733553975;5143.897122057557;5282.973585132078;5289.629725919187;5350.3312085989255;5353.544948679367;3873.9031524211837;3977.303971804937;4003.5996400359877;4014.6386825185728;4049.088954985134;3976.741511801738;4044.0698639312977;4046.8178931947987;4054.4121102440126;4074.22589707956;3976.6619837313865;3993.7803420811842;4002.559718430985;4035.778032208227;4093.0176757578115;4019.6583290420203;4021.4571032910476;4039.5758445363404;4061.2892743770017;4081.510218773766;3495.0912762681887;3497;3507.175813683782;3517.0679769860753;3552.307300076486;5015.824446144404;5168.483151684839;5194.792208311663;5211.270422140903;5214.608904332153;4570.680052396334;4584.335271385664;4595.356650068959;4608.239640459354;4628.583427491509;5426.674399536001;5458.972705136489;5590.2732644756325;5594.1608758686525;5607.635503692247;3697.2605478904056;3708.7774733516076;3798.620137986207;3813.7521061131215;3826.6747326477284;5732.168835518826;5845.503132233723;5847.473727364558;5863.091220860773;5889.823305300848;3857.9421308680394;3864.3237433449035;3879.359905615598;3892.708046896494;3906.003968987947;3757.3988161894513;3913.6673382762215;3913.784741839226;3919.529656441245;3927.351986922183;4573.63410927125;4591.288350305708;4598.724076555351;4606.193916064675;4608.953910460852;5625.54995600351;5639.887202256014;5645.927273817962;5658.377578466366;5671.291088613923;1395.665040390299;1397.8672026157499;1402.186731695614;1404.4241860837212;1410.3864818803854;894.8836651235428;904.9411788233743;915.9313051521029;931.5807886451124;935.7613808478794;5152.3044389007755;5270.209468579744;5289.841304760864;5314.335708036496;5332.120200166929;5765.365809760923;5768.509676677446;5786.855328616818;5790.276215473066;5817.680027598522;5298.15229563268;5301.575873930076;5311.787528498894;5325.786968521294;5328.413874473805;3026.3493348929646;3130.139211716796;3162.3833352496044;3172.5717028200897;3177.7140057394945;5981.312149102821;5985.461308482258;6043.848903777441;6058.787942422082;6065.60573562717;5985.191999080155;5986.461218490357;5997.370276120944;5997.490213331916;6030.728617212236;5819.185314055951;6002.699865006733;6004.249468816398;6025.0962355646125;6041.909371359433;5588.413216612197;5824.504917082096;5831.067029275465;5831.562632802472;5880.6477409035015;5585.245991791056;5635.661860288232;5676.290463692038;5680.545556355564;5740.167675687086;6027;6029.879402412015;6047.274327080779;6062.605930614496;6066.969665151646;3902.707296952683;3912.5109361329833;3945.0137465633593;3950.0914789597978;3969.64273215412;5728.169415434655;5874.383189765184;5891.764329426775;5902.675352855634;5930.021546444788;5752.6836024019085;5762.855928601818;5767.452092051249;5786.218860453785;5793.275840519935;5727.255456790591;5731.168980497721;5745.339285982165;5759.913601296068;5769.538436924952;5373.919391209057;5590.413006634408;5629.831105066854;5642.633228840113;5680.914786278292;5718.542516598745;5726.455986681259;5727.455891690282;5743.052396354722;5803.332616749128;5581.832545023656;5587.664740115606;5592.580556458363;5596.692181930033;5639.859003524781 23:16:52 INFO - 2015-11-15 23:16:52,577 DEBUG : BROWSER_OUTPUT: |5;yui.html;548.287226605413;557.1420013179701;586.2466730251627;587.4184557288286;618.5051958433253;10907.781844363108;11305.773884522316;11307.151963602722;11347.659570212887;11530.192886497927;10651.25441219113;10721.3031152975;11103.55585776568;11133.610323638653;11150.052245559138;583.104933926423;590.8434264919799;593.7803012885239;721.3940290156255;745.6048294403947;737.3290305821703;743.0860042148161;750.8047907544051;761.958092304923;765.2080097099503;758.8292634157326;770.8805135204052;770.96916123355;778.381186956371;779.275273995187;613.9508839292846;615.5229696984828;625.4558534075338;755.391909512842;761.2273542354487;570.5749216833485;573.1975234671452;577.6678409914316;577.9624324418942;579.1631093070515;11383.715407114805;11486.597969071043;11534.134939879543;11538.192326537146;11564.884351156548;9503.192228660502;9672.70981870545;9955.5022248888;10129.392236465763;10358.948205259001;7615.733449329302;7802.375809935192;7806.219378062148;7865.252800983954;7948.5628290444;2694.865256737175;2769.8615069246657;2823.71762823718;2843.8293702377923;2848.3591191981636;40167;40731.7963410184;40775.388369174485;40846.38730419046;40856.79571602153;5197.8440646780655;5353.0899747043095;5395.217693434509;5445.183222516575;5570.387257401682;9750.951245243728;9947.20422366209;9973.102420782165;9993.500324983721;9997.650082247086;5229.6339256251695;5248.212768084818;5294.97352513235;5299.814506492255;5483.177523371526;3045.482268014443;3110.533419986975;3196.344749326429;3262.0703099616494;3291.8847840325475;2273.352094653049;2285.4400671835506;2291.4385975435794;2295.781900719429;2302.3323236261294;338.15798661333105;340.8398052915126;342.5461263825441;342.8080275045982;347.64366524312277;386.14276306599305;404.86841776422193;437.33879344190956;492.4902725678905;518.6447283610738;5891.852703682443;6641.369069938348;6719.596824190564;6862.897056544156;6895.724171033203;320.65049096484944;443.6473003961858;474.9501302363202;529.5842763430766;536.5224949794685;2605.231456720272;2800.6919238883706;2847.345110624568;2900.332923427581;2935.427591619614;48601.27098093531;49777.50222497801;49778.751106244235;51555.74222128865;52633;42516.787416063344;42826.78586607109;43416;43649.10737050458;44312.3353149703;38448.23103537913;38815.80592097021;40720.59279407168;41221.587784122974;41546.169076618906;6691.464682825265;6827.6244806536115;6866;7052.435805135679;7235.963820180866;27394.589081163398;28762;29913.551296730133;30230.407374635764;30243;37614;37938.620613794614;38418.615813841505;39340.2131957365;39356;6131.754729810757;6185.84535386619;6276.717547710273;6290.24517057956;6427.525402719893;9063.818723625622;9438.24494040489;9463.242940564876;9579.089986451276;10000.899991000288;8959.641614335354;9033.096690331176;9055.909440905507;9105.726828195166;9228.861567076634;9029;9091.499967501852;9129.269658427176;9197.448153110567;9266.166045055978;7371.299726525972;8386.95806520988;8883.33374996865;8949.239314658327;8984.146506081912;7473.364763995121;7487.251274872469;7497;7590.354819840375;7861;7454.962725186339;7513.887291690519;7682.308592226726;7819.491733037335;7940.920590794018 23:16:52 INFO - 2015-11-15 23:16:52,577 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:16:52 INFO - 2015-11-15 23:16:52,577 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:16:52 INFO - 2015-11-15 23:16:52,578 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1050 23:16:52 INFO - 2015-11-15 23:16:52,578 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:16:52 INFO - 2015-11-15 23:16:52,578 DEBUG : BROWSER_OUTPUT: __startTimestamp1447658212561__endTimestamp 23:16:52 INFO - 2015-11-15 23:16:52,578 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,578 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:16:52 INFO - 2015-11-15 23:16:52,578 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:16:52 INFO - 2015-11-15 23:16:52,578 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,578 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4476.59 Median:4592.38 stddev:466.77 (10.2%) stddev-sans-first:444.63 23:16:52 INFO - 2015-11-15 23:16:52,580 DEBUG : BROWSER_OUTPUT: Values: 2609.9 2703.9 2712.3 2738.7 2742.7 4406.0 4473.4 4487.8 4546.6 4567.9 4443.9 4479.6 4496.1 4664.7 4671.2 4089.6 4170.2 4205.2 4215.0 4225.7 4224.2 4248.9 4258.0 4295.2 4323.4 4013.5 4133.6 4146.0 4196.0 4223.1 4042.3 4043.2 4050.3 4056.4 4086.3 3986.6 4091.2 4104.8 4127.1 4143.6 4456.0 4525.9 4538.8 4581.2 4592.4 4839.8 4860.8 4881.4 4883.6 4889.4 4603.2 4709.4 4766.5 4779.3 4886.4 4497.6 4502.5 4520.9 4523.3 4566.5 4837.2 4913.8 4953.4 4971.0 4985.6 4508.0 4600.2 4601.6 4636.4 4784.5 4808.0 4808.7 4811.9 4828.0 4845.3 4739.6 4742.7 4763.6 4782.2 4798.5 4559.8 4688.7 4695.4 4730.2 4747.5 3644.3 3759.2 3785.9 3788.0 3802.9 3414.5 3416.2 3454.8 3455.1 3498.3 4339.2 4497.3 4499.5 4506.0 4529.6 4765.3 4831.8 4837.0 4840.5 4923.2 4480.2 4520.0 4520.1 4529.2 4582.4 4146.4 4280.9 4282.4 4328.3 4356.4 4742.3 4844.9 4880.8 4939.3 4975.5 4717.1 4724.9 4742.0 4761.8 4793.4 4803.5 4851.7 4856.9 4911.7 4925.0 4595.1 4655.4 4723.9 4726.9 4746.5 4901.2 4947.7 4968.3 4976.6 4981.0 4557.2 4762.0 4769.3 4798.7 4799.9 4527.5 4588.8 4603.7 4661.7 4726.3 4564.5 4657.3 4657.8 4677.1 4684.0 4444.6 4696.8 4761.8 4781.7 4784.3 4436.7 4522.8 4571.2 4646.4 4657.4 23:16:52 INFO - 2015-11-15 23:16:52,580 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,581 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37857.66 Median:29531.34 stddev:63480.08 (215.0%) stddev-sans-first:63596.07 23:16:52 INFO - 2015-11-15 23:16:52,582 DEBUG : BROWSER_OUTPUT: Values: 464.8 472.2 473.2 482.0 495.9 24702.4 25349.4 32770.8 33650.3 33812.0 35669.9 35671.1 35677.3 35692.5 35805.6 6858.4 7515.7 7724.0 7766.5 7803.9 6923.5 7009.8 9252.4 9403.0 9462.4 9181.2 9246.5 9263.2 9309.2 9345.1 7084.1 7267.0 9226.2 9262.6 9283.5 6915.6 9132.7 9298.2 9328.4 9350.8 33039.7 33048.2 33222.2 33279.7 33437.0 2390.9 2467.2 2582.2 2707.2 2763.5 22147.0 22313.9 22612.3 22830.0 23059.9 1926.3 1952.7 1989.6 1995.6 1999.0 229393.0 230242.0 230617.9 231409.0 232152.0 49810.8 50339.7 50360.5 50380.7 50809.0 42830.0 43697.6 44026.6 52488.2 52540.5 10558.9 10609.6 10800.9 10828.2 10830.3 7645.2 7716.9 7721.2 7741.0 7771.1 16369.8 16421.3 16442.3 16444.4 16452.9 6621.6 6782.6 6815.9 6866.9 6869.8 778.2 860.7 876.3 898.2 902.9 23676.8 23878.3 24037.9 24202.9 24259.4 852.3 864.8 872.3 916.5 1000.9 11213.2 11478.3 11497.2 11502.5 11559.3 260817.0 266931.0 269693.0 269953.0 270249.0 44533.3 44560.8 45041.3 45184.8 45200.3 1103.4 1119.9 1128.7 1131.2 1134.1 22371.2 22681.5 22715.4 22771.4 22862.7 38439.8 38705.8 38936.4 39087.2 39302.0 224310.0 226696.0 229100.0 229252.0 229657.0 22273.4 22630.9 25092.1 25883.2 26560.2 30282.0 31190.8 31219.5 31290.2 31351.4 26187.3 29186.3 29225.3 29386.3 29474.6 27778.2 28199.4 28506.4 28601.3 28623.9 24456.5 24918.0 29068.3 29588.1 29652.7 22140.4 23891.5 24029.9 24157.2 24184.5 19582.4 19773.5 19966.3 19996.8 20656.5 23:16:52 INFO - 2015-11-15 23:16:52,582 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,582 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19458.76 Median:26962.92 stddev:56017.87 (207.8%) stddev-sans-first:56156.50 23:16:52 INFO - 2015-11-15 23:16:52,584 DEBUG : BROWSER_OUTPUT: Values: 277.8 279.4 280.1 284.8 286.7 9582.4 9990.7 13953.7 14390.6 14696.6 15342.5 15382.9 15662.4 15794.2 15881.8 4608.5 4755.9 4763.3 4771.2 4816.8 4685.9 4724.2 4746.3 4763.1 4807.4 3371.0 3477.8 3499.5 4694.3 4699.4 4927.8 5062.7 5115.9 5156.6 5170.0 4336.8 4464.3 4471.1 4490.2 4511.3 17311.0 17704.4 17828.8 17918.7 17950.2 520.6 520.8 522.4 1702.1 1709.4 11312.5 11365.4 11494.9 11538.5 12189.8 1387.7 1405.8 1410.7 1444.9 1466.8 48998.0 50207.5 50408.2 50621.7 51177.2 8805.5 8814.9 8817.3 8837.5 8879.2 11030.3 11039.2 11040.6 11059.6 11275.2 5849.5 5875.4 5905.7 6009.6 6166.1 5318.9 5374.0 5382.3 5387.5 5438.3 5112.0 5177.2 5198.3 5203.2 5253.8 1483.8 1525.1 1525.6 1546.5 1571.1 288.7 355.7 373.8 376.9 383.5 8945.2 9384.2 9395.7 9464.7 9512.2 359.4 373.8 376.5 389.9 397.9 4988.7 5133.0 5206.2 5282.0 5298.7 289601.0 296203.0 296785.0 315156.0 473515.0 49538.8 52366.5 52387.7 54475.7 55007.2 401.2 411.3 413.1 413.7 414.5 8571.3 8703.5 8729.3 8839.9 8885.9 25913.2 26278.2 26520.7 26723.3 27071.9 37053.6 37858.2 37986.5 38099.8 38130.0 5009.7 5046.2 5095.4 5096.8 5115.6 9395.4 9611.7 9802.7 9828.0 9914.7 8244.4 8479.6 8552.7 8569.8 8600.2 8076.9 8143.3 8241.3 8269.5 8374.6 7947.7 8283.0 8534.2 8582.4 8613.0 4973.6 5058.1 5101.6 5136.8 5165.6 8110.1 8412.2 8449.3 8495.7 8505.0 23:16:52 INFO - 2015-11-15 23:16:52,584 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,584 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4565.59 Median:5868.43 stddev:2395.15 (40.8%) stddev-sans-first:2387.26 23:16:52 INFO - 2015-11-15 23:16:52,584 DEBUG : BROWSER_OUTPUT: Values: 1047.2 1357.4 1441.9 1455.7 1499.1 5997.7 6206.8 6216.6 6495.7 6515.2 6485.2 6542.9 6590.2 6598.7 6658.0 1835.5 1853.5 1853.6 1857.9 1858.0 1883.3 1886.6 1891.0 1928.3 1934.4 1805.5 1815.3 1819.2 1821.3 1822.0 1753.7 1755.5 1762.9 1763.1 1773.6 1808.1 1834.7 1840.9 1842.2 1848.6 5949.4 6515.4 6577.0 6594.0 6600.4 3728.6 3828.0 3947.8 4066.7 4067.7 2359.4 2392.3 2401.1 2438.2 2456.5 727.7 738.0 745.2 753.0 764.4 8861.8 8903.8 8907.4 8951.8 9000.2 3543.1 3629.3 3667.4 3675.1 3686.6 7833.9 7836.3 7851.9 7878.4 7933.2 4105.3 4109.4 4110.2 4138.9 4142.7 3705.6 3713.1 3727.6 3731.4 3750.2 2924.8 3001.4 3013.5 3014.7 3019.4 948.7 951.1 955.3 958.7 975.3 1074.0 1094.1 1125.4 1127.2 1141.9 6302.3 6316.0 6334.6 6336.8 6340.4 384.8 392.7 393.0 396.8 397.6 4595.7 4730.5 4793.8 4807.5 4808.3 7218.5 7240.9 7251.3 7306.5 7664.1 7583.2 7669.4 7747.0 7795.1 7805.2 6075.4 6076.3 6287.0 6321.3 6322.1 6035.7 6052.9 6062.5 6067.3 6071.1 6778.2 6909.1 6974.4 6991.6 7126.4 6899.8 7098.2 7230.6 7262.8 7272.6 5754.5 5821.4 5849.2 5859.1 5877.8 6326.7 6358.3 6401.3 6410.9 6434.8 5881.4 5966.8 5971.5 5982.5 6005.6 5827.3 5833.2 5927.7 5942.0 5961.7 5986.1 6050.2 6052.5 6081.7 6097.0 5260.8 5481.7 5492.4 5500.6 5512.8 5542.7 5599.9 5602.9 5644.1 5653.2 23:16:52 INFO - 2015-11-15 23:16:52,584 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,586 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4692.06 Median:5341.23 stddev:1441.81 (27.0%) stddev-sans-first:1406.92 23:16:52 INFO - 2015-11-15 23:16:52,586 DEBUG : BROWSER_OUTPUT: Values: 257.8 259.9 266.4 267.3 269.0 5140.4 5216.0 5329.0 5351.9 5352.5 5143.9 5283.0 5289.6 5350.3 5353.5 3873.9 3977.3 4003.6 4014.6 4049.1 3976.7 4044.1 4046.8 4054.4 4074.2 3976.7 3993.8 4002.6 4035.8 4093.0 4019.7 4021.5 4039.6 4061.3 4081.5 3495.1 3497.0 3507.2 3517.1 3552.3 5015.8 5168.5 5194.8 5211.3 5214.6 4570.7 4584.3 4595.4 4608.2 4628.6 5426.7 5459.0 5590.3 5594.2 5607.6 3697.3 3708.8 3798.6 3813.8 3826.7 5732.2 5845.5 5847.5 5863.1 5889.8 3857.9 3864.3 3879.4 3892.7 3906.0 3757.4 3913.7 3913.8 3919.5 3927.4 4573.6 4591.3 4598.7 4606.2 4609.0 5625.5 5639.9 5645.9 5658.4 5671.3 1395.7 1397.9 1402.2 1404.4 1410.4 894.9 904.9 915.9 931.6 935.8 5152.3 5270.2 5289.8 5314.3 5332.1 5765.4 5768.5 5786.9 5790.3 5817.7 5298.2 5301.6 5311.8 5325.8 5328.4 3026.3 3130.1 3162.4 3172.6 3177.7 5981.3 5985.5 6043.8 6058.8 6065.6 5985.2 5986.5 5997.4 5997.5 6030.7 5819.2 6002.7 6004.2 6025.1 6041.9 5588.4 5824.5 5831.1 5831.6 5880.6 5585.2 5635.7 5676.3 5680.5 5740.2 6027.0 6029.9 6047.3 6062.6 6067.0 3902.7 3912.5 3945.0 3950.1 3969.6 5728.2 5874.4 5891.8 5902.7 5930.0 5752.7 5762.9 5767.5 5786.2 5793.3 5727.3 5731.2 5745.3 5759.9 5769.5 5373.9 5590.4 5629.8 5642.6 5680.9 5718.5 5726.5 5727.5 5743.1 5803.3 5581.8 5587.7 5592.6 5596.7 5639.9 23:16:52 INFO - 2015-11-15 23:16:52,586 DEBUG : BROWSER_OUTPUT: 23:16:52 INFO - 2015-11-15 23:16:52,586 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11172.93 Median:2996.74 stddev:13837.21 (461.7%) stddev-sans-first:13853.03 23:16:52 INFO - 2015-11-15 23:16:52,588 DEBUG : BROWSER_OUTPUT: Values: 548.3 557.1 586.2 587.4 618.5 10907.8 11305.8 11307.2 11347.7 11530.2 10651.3 10721.3 11103.6 11133.6 11150.1 583.1 590.8 593.8 721.4 745.6 737.3 743.1 750.8 762.0 765.2 758.8 770.9 771.0 778.4 779.3 614.0 615.5 625.5 755.4 761.2 570.6 573.2 577.7 578.0 579.2 11383.7 11486.6 11534.1 11538.2 11564.9 9503.2 9672.7 9955.5 10129.4 10358.9 7615.7 7802.4 7806.2 7865.3 7948.6 2694.9 2769.9 2823.7 2843.8 2848.4 40167.0 40731.8 40775.4 40846.4 40856.8 5197.8 5353.1 5395.2 5445.2 5570.4 9751.0 9947.2 9973.1 9993.5 9997.7 5229.6 5248.2 5295.0 5299.8 5483.2 3045.5 3110.5 3196.3 3262.1 3291.9 2273.4 2285.4 2291.4 2295.8 2302.3 338.2 340.8 342.5 342.8 347.6 386.1 404.9 437.3 492.5 518.6 5891.9 6641.4 6719.6 6862.9 6895.7 320.7 443.6 475.0 529.6 536.5 2605.2 2800.7 2847.3 2900.3 2935.4 48601.3 49777.5 49778.8 51555.7 52633.0 42516.8 42826.8 43416.0 43649.1 44312.3 38448.2 38815.8 40720.6 41221.6 41546.2 6691.5 6827.6 6866.0 7052.4 7236.0 27394.6 28762.0 29913.6 30230.4 30243.0 37614.0 37938.6 38418.6 39340.2 39356.0 6131.8 6185.8 6276.7 6290.2 6427.5 9063.8 9438.2 9463.2 9579.1 10000.9 8959.6 9033.1 9055.9 9105.7 9228.9 9029.0 9091.5 9129.3 9197.4 9266.2 7371.3 8387.0 8883.3 8949.2 8984.1 7473.4 7487.3 7497.0 7590.4 7861.0 7455.0 7513.9 7682.3 7819.5 7940.9 23:16:52 INFO - 2015-11-15 23:16:52,588 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:16:52 INFO - 2015-11-15 23:16:52,588 DEBUG : BROWSER_OUTPUT: 23:16:53 INFO - 2015-11-15 23:16:53,318 INFO : Browser exited with error code: 0 23:16:53 INFO - 2015-11-15 23:16:53,351 INFO : Completed test dromaeo_css (00:18:36) 23:16:53 INFO - 2015-11-15 23:16:53,351 INFO : Starting test kraken 23:16:53 INFO - 2015-11-15 23:16:53,351 DEBUG : operating with platform_type : mac_ 23:16:53 INFO - 2015-11-15 23:16:53,351 INFO : Initialising browser for kraken test... 23:16:53 INFO - 2015-11-15 23:16:53,366 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmplg69Ke/profile http://localhost:57346/getInfo.html 23:16:55 INFO - 2015-11-15 23:16:55,908 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:16:55 INFO - 2015-11-15 23:16:55,908 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:16:55 INFO - 2015-11-15 23:16:55,908 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:16:55 INFO - 2015-11-15 23:16:55,908 DEBUG : BROWSER_OUTPUT: __metrics 23:16:55 INFO - 2015-11-15 23:16:55,926 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:16:56 INFO - 2015-11-15 23:16:56,726 INFO : Browser initialized. 23:16:56 INFO - 2015-11-15 23:16:56,726 INFO : Running cycle 1/1 for kraken test... 23:16:56 INFO - 2015-11-15 23:16:56,727 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmplg69Ke/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:17:08 INFO - 2015-11-15 23:17:08,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 228356096 23:17:08 INFO - 2015-11-15 23:17:08,893 DEBUG : BROWSER_OUTPUT: 23:17:11 INFO - 2015-11-15 23:17:11,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57346/tests/kraken/driver.html?testName=audio-beat-detection) 23:17:12 INFO - 2015-11-15 23:17:12,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 286269440 23:17:12 INFO - 2015-11-15 23:17:12,405 DEBUG : BROWSER_OUTPUT: 23:17:15 INFO - 2015-11-15 23:17:15,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57346/tests/kraken/driver.html?testName=audio-dft) 23:17:16 INFO - 2015-11-15 23:17:16,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 300085248 23:17:16 INFO - 2015-11-15 23:17:16,084 DEBUG : BROWSER_OUTPUT: 23:17:19 INFO - 2015-11-15 23:17:19,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57346/tests/kraken/driver.html?testName=audio-fft) 23:17:20 INFO - 2015-11-15 23:17:20,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 284405760 23:17:20 INFO - 2015-11-15 23:17:20,090 DEBUG : BROWSER_OUTPUT: 23:17:22 INFO - 2015-11-15 23:17:22,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57346/tests/kraken/driver.html?testName=audio-oscillator) 23:17:22 INFO - 2015-11-15 23:17:22,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 285126656 23:17:22 INFO - 2015-11-15 23:17:22,957 DEBUG : BROWSER_OUTPUT: 23:17:25 INFO - 2015-11-15 23:17:25,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:17:26 INFO - 2015-11-15 23:17:26,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 284237824 23:17:26 INFO - 2015-11-15 23:17:26,031 DEBUG : BROWSER_OUTPUT: 23:17:29 INFO - 2015-11-15 23:17:29,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57346/tests/kraken/driver.html?testName=imaging-darkroom) 23:17:30 INFO - 2015-11-15 23:17:30,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 281194496 23:17:30 INFO - 2015-11-15 23:17:30,161 DEBUG : BROWSER_OUTPUT: 23:17:33 INFO - 2015-11-15 23:17:33,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57346/tests/kraken/driver.html?testName=imaging-desaturate) 23:17:34 INFO - 2015-11-15 23:17:34,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 281735168 23:17:34 INFO - 2015-11-15 23:17:34,426 DEBUG : BROWSER_OUTPUT: 23:17:37 INFO - 2015-11-15 23:17:37,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57346/tests/kraken/driver.html?testName=json-parse-financial) 23:17:38 INFO - 2015-11-15 23:17:38,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 283320320 23:17:38 INFO - 2015-11-15 23:17:38,308 DEBUG : BROWSER_OUTPUT: 23:17:40 INFO - 2015-11-15 23:17:40,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:17:40 INFO - 2015-11-15 23:17:40,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 318869504 23:17:40 INFO - 2015-11-15 23:17:40,645 DEBUG : BROWSER_OUTPUT: 23:17:42 INFO - 2015-11-15 23:17:42,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57346/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:17:43 INFO - 2015-11-15 23:17:43,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 320933888 23:17:43 INFO - 2015-11-15 23:17:43,354 DEBUG : BROWSER_OUTPUT: 23:17:45 INFO - 2015-11-15 23:17:45,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:17:46 INFO - 2015-11-15 23:17:46,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 327774208 23:17:46 INFO - 2015-11-15 23:17:46,325 DEBUG : BROWSER_OUTPUT: 23:17:49 INFO - 2015-11-15 23:17:49,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:17:49 INFO - 2015-11-15 23:17:49,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 328179712 23:17:49 INFO - 2015-11-15 23:17:49,939 DEBUG : BROWSER_OUTPUT: 23:17:52 INFO - 2015-11-15 23:17:52,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:17:53 INFO - 2015-11-15 23:17:53,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 327872512 23:17:53 INFO - 2015-11-15 23:17:53,555 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57346/tests/kraken/driver.html?testName=ai-astar) 23:17:55 INFO - 2015-11-15 23:17:55,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 388263936 23:17:55 INFO - 2015-11-15 23:17:55,771 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,771 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:17:55 INFO - 2015-11-15 23:17:55,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:17:55 INFO - 2015-11-15 23:17:55,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:17:55 INFO - 2015-11-15 23:17:55,772 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:17:55 INFO - 2015-11-15 23:17:55,772 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;130;125;133;134;133;128;125;123;131 23:17:55 INFO - 2015-11-15 23:17:55,772 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;191;160;185;198;161;195;181;155;200;156 23:17:55 INFO - 2015-11-15 23:17:55,773 DEBUG : BROWSER_OUTPUT: |2;audio-dft;190;198;196;196;198;198;196;189;197;198 23:17:55 INFO - 2015-11-15 23:17:55,773 DEBUG : BROWSER_OUTPUT: |3;audio-fft;87;98;102;151;81;85;87;86;135;81 23:17:55 INFO - 2015-11-15 23:17:55,773 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;119;121;166;109;109;110;152;108;105;147 23:17:55 INFO - 2015-11-15 23:17:55,773 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;141;141;148;141;141;139;134;141;141;148 23:17:55 INFO - 2015-11-15 23:17:55,773 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;154;155;155;154;150;154;154;155;154;147 23:17:55 INFO - 2015-11-15 23:17:55,773 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;124;120;117;115;124;115;123;115;129 23:17:55 INFO - 2015-11-15 23:17:55,774 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;69;70;73;73;74;75;83;72;72 23:17:55 INFO - 2015-11-15 23:17:55,774 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;81;83;85;85;88;86;85;82;83 23:17:55 INFO - 2015-11-15 23:17:55,774 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;100;105;106;104;105;105;107;104;106;106 23:17:55 INFO - 2015-11-15 23:17:55,774 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;154;161;168;154;155;151;155;152;163;172 23:17:55 INFO - 2015-11-15 23:17:55,775 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;165;188;189;188;178;176;183;188;190;176 23:17:55 INFO - 2015-11-15 23:17:55,775 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;82;87;88;88;87;86;86;89;86 23:17:55 INFO - 2015-11-15 23:17:55,775 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:17:55 INFO - 2015-11-15 23:17:55,775 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:17:55 INFO - 2015-11-15 23:17:55,775 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1006 23:17:55 INFO - 2015-11-15 23:17:55,775 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:17:55 INFO - 2015-11-15 23:17:55,776 DEBUG : BROWSER_OUTPUT: __startTimestamp1447658275767__endTimestamp 23:17:55 INFO - 2015-11-15 23:17:55,776 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,776 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:17:55 INFO - 2015-11-15 23:17:55,776 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:17:55 INFO - 2015-11-15 23:17:55,776 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,776 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:128.90 Median:130.50 stddev:3.87 (3.0%) stddev-sans-first:4.04 23:17:55 INFO - 2015-11-15 23:17:55,777 DEBUG : BROWSER_OUTPUT: Values: 127.0 130.0 125.0 133.0 134.0 133.0 128.0 125.0 123.0 131.0 23:17:55 INFO - 2015-11-15 23:17:55,777 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,777 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:178.20 Median:188.00 stddev:18.34 (9.8%) stddev-sans-first:18.85 23:17:55 INFO - 2015-11-15 23:17:55,777 DEBUG : BROWSER_OUTPUT: Values: 191.0 160.0 185.0 198.0 161.0 195.0 181.0 155.0 200.0 156.0 23:17:55 INFO - 2015-11-15 23:17:55,777 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,778 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:195.60 Median:197.50 stddev:3.34 (1.7%) stddev-sans-first:2.86 23:17:55 INFO - 2015-11-15 23:17:55,778 DEBUG : BROWSER_OUTPUT: Values: 190.0 198.0 196.0 196.0 198.0 198.0 196.0 189.0 197.0 198.0 23:17:55 INFO - 2015-11-15 23:17:55,778 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,778 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:99.30 Median:85.50 stddev:24.29 (28.4%) stddev-sans-first:25.35 23:17:55 INFO - 2015-11-15 23:17:55,778 DEBUG : BROWSER_OUTPUT: Values: 87.0 98.0 102.0 151.0 81.0 85.0 87.0 86.0 135.0 81.0 23:17:55 INFO - 2015-11-15 23:17:55,778 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,778 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:124.60 Median:120.00 stddev:22.04 (18.4%) stddev-sans-first:23.28 23:17:55 INFO - 2015-11-15 23:17:55,779 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 166.0 109.0 109.0 110.0 152.0 108.0 105.0 147.0 23:17:55 INFO - 2015-11-15 23:17:55,779 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,779 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:141.50 Median:141.00 stddev:4.06 (2.9%) stddev-sans-first:4.30 23:17:55 INFO - 2015-11-15 23:17:55,779 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 148.0 141.0 141.0 139.0 134.0 141.0 141.0 148.0 23:17:55 INFO - 2015-11-15 23:17:55,779 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,779 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:153.20 Median:154.00 stddev:2.62 (1.7%) stddev-sans-first:2.76 23:17:55 INFO - 2015-11-15 23:17:55,780 DEBUG : BROWSER_OUTPUT: Values: 154.0 155.0 155.0 154.0 150.0 154.0 154.0 155.0 154.0 147.0 23:17:55 INFO - 2015-11-15 23:17:55,780 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,780 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:119.60 Median:121.50 stddev:5.17 (4.3%) stddev-sans-first:5.07 23:17:55 INFO - 2015-11-15 23:17:55,780 DEBUG : BROWSER_OUTPUT: Values: 114.0 124.0 120.0 117.0 115.0 124.0 115.0 123.0 115.0 129.0 23:17:55 INFO - 2015-11-15 23:17:55,781 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,781 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.60 Median:73.00 stddev:4.65 (6.4%) stddev-sans-first:4.03 23:17:55 INFO - 2015-11-15 23:17:55,781 DEBUG : BROWSER_OUTPUT: Values: 65.0 69.0 70.0 73.0 73.0 74.0 75.0 83.0 72.0 72.0 23:17:55 INFO - 2015-11-15 23:17:55,781 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,782 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:83.50 Median:85.00 stddev:3.06 (3.6%) stddev-sans-first:2.17 23:17:55 INFO - 2015-11-15 23:17:55,783 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 83.0 85.0 85.0 88.0 86.0 85.0 82.0 83.0 23:17:55 INFO - 2015-11-15 23:17:55,783 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,783 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:104.80 Median:105.50 stddev:1.93 (1.8%) stddev-sans-first:1.00 23:17:55 INFO - 2015-11-15 23:17:55,783 DEBUG : BROWSER_OUTPUT: Values: 100.0 105.0 106.0 104.0 105.0 105.0 107.0 104.0 106.0 106.0 23:17:55 INFO - 2015-11-15 23:17:55,783 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,783 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:158.50 Median:158.00 stddev:7.17 (4.5%) stddev-sans-first:7.42 23:17:55 INFO - 2015-11-15 23:17:55,783 DEBUG : BROWSER_OUTPUT: Values: 154.0 161.0 168.0 154.0 155.0 151.0 155.0 152.0 163.0 172.0 23:17:55 INFO - 2015-11-15 23:17:55,784 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,784 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:188.00 stddev:8.16 (4.3%) stddev-sans-first:5.85 23:17:55 INFO - 2015-11-15 23:17:55,784 DEBUG : BROWSER_OUTPUT: Values: 165.0 188.0 189.0 188.0 178.0 176.0 183.0 188.0 190.0 176.0 23:17:55 INFO - 2015-11-15 23:17:55,784 DEBUG : BROWSER_OUTPUT: 23:17:55 INFO - 2015-11-15 23:17:55,784 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.90 Median:87.00 stddev:2.81 (3.2%) stddev-sans-first:2.01 23:17:55 INFO - 2015-11-15 23:17:55,784 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 87.0 88.0 88.0 87.0 86.0 86.0 89.0 86.0 23:17:55 INFO - 2015-11-15 23:17:55,784 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:17:55 INFO - 2015-11-15 23:17:55,784 DEBUG : BROWSER_OUTPUT: 23:17:56 INFO - 2015-11-15 23:17:56,501 INFO : Browser exited with error code: 0 23:17:56 INFO - 2015-11-15 23:17:56,559 INFO : Completed test kraken (00:01:03) 23:17:56 INFO - 2015-11-15 23:17:56,559 INFO : Starting test v8_7 23:17:56 INFO - 2015-11-15 23:17:56,559 DEBUG : operating with platform_type : mac_ 23:17:56 INFO - 2015-11-15 23:17:56,559 INFO : Initialising browser for v8_7 test... 23:17:56 INFO - 2015-11-15 23:17:56,575 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpvWbiW7/profile http://localhost:57346/getInfo.html 23:17:59 INFO - 2015-11-15 23:17:59,104 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:17:59 INFO - 2015-11-15 23:17:59,104 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:17:59 INFO - 2015-11-15 23:17:59,104 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:17:59 INFO - 2015-11-15 23:17:59,104 DEBUG : BROWSER_OUTPUT: __metrics 23:17:59 INFO - 2015-11-15 23:17:59,125 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:17:59 INFO - 2015-11-15 23:17:59,927 INFO : Browser initialized. 23:17:59 INFO - 2015-11-15 23:17:59,928 INFO : Running cycle 1/1 for v8_7 test... 23:17:59 INFO - 2015-11-15 23:17:59,928 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpvWbiW7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:18:12 INFO - 2015-11-15 23:18:12,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 228106240 23:18:12 INFO - 2015-11-15 23:18:12,081 DEBUG : BROWSER_OUTPUT: 23:18:34 INFO - 2015-11-15 23:18:34,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57346/tests/v8_7/run.html (next: http://localhost:57346/tests/v8_7/run.html) 23:18:35 INFO - 2015-11-15 23:18:35,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 629227520 23:18:35 INFO - 2015-11-15 23:18:35,052 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,052 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:18:35 INFO - 2015-11-15 23:18:35,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: |0;Richards;197.43336623889437 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;231.535077564251 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: |2;Encrypt;383.8771593090211 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6903.448275862069 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2309.4688221709007 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: |5;Earley;972.7626459143969 23:18:35 INFO - 2015-11-15 23:18:35,053 DEBUG : BROWSER_OUTPUT: |6;Boyer;15363.636363636364 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: |7;RegExp;36232.142857142855 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: |8;Splay;868.8097306689835 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6856.164383561644 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: __startTimestamp1447658315049__endTimestamp 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:197.43 Median:197.43 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: Values: 197.4 23:18:35 INFO - 2015-11-15 23:18:35,054 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,055 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:231.54 Median:231.54 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,055 DEBUG : BROWSER_OUTPUT: Values: 231.5 23:18:35 INFO - 2015-11-15 23:18:35,055 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,055 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:383.88 Median:383.88 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,055 DEBUG : BROWSER_OUTPUT: Values: 383.9 23:18:35 INFO - 2015-11-15 23:18:35,055 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,055 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6903.45 Median:6903.45 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,055 DEBUG : BROWSER_OUTPUT: Values: 6903.4 23:18:35 INFO - 2015-11-15 23:18:35,056 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,056 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2309.47 Median:2309.47 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,056 DEBUG : BROWSER_OUTPUT: Values: 2309.5 23:18:35 INFO - 2015-11-15 23:18:35,056 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,056 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:972.76 Median:972.76 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,056 DEBUG : BROWSER_OUTPUT: Values: 972.8 23:18:35 INFO - 2015-11-15 23:18:35,056 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,056 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15363.64 Median:15363.64 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,057 DEBUG : BROWSER_OUTPUT: Values: 15363.6 23:18:35 INFO - 2015-11-15 23:18:35,057 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,057 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36232.14 Median:36232.14 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,057 DEBUG : BROWSER_OUTPUT: Values: 36232.1 23:18:35 INFO - 2015-11-15 23:18:35,057 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,057 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:868.81 Median:868.81 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,057 DEBUG : BROWSER_OUTPUT: Values: 868.8 23:18:35 INFO - 2015-11-15 23:18:35,057 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,058 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6856.16 Median:6856.16 stddev:0.00 (0.0%) 23:18:35 INFO - 2015-11-15 23:18:35,058 DEBUG : BROWSER_OUTPUT: Values: 6856.2 23:18:35 INFO - 2015-11-15 23:18:35,058 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:18:35 INFO - 2015-11-15 23:18:35,058 DEBUG : BROWSER_OUTPUT: 23:18:35 INFO - 2015-11-15 23:18:35,816 INFO : Browser exited with error code: 0 23:18:35 INFO - 2015-11-15 23:18:35,840 INFO : Completed test v8_7 (00:00:39) 23:18:35 INFO - 2015-11-15 23:18:35,948 INFO : Completed test suite (00:20:19) 23:18:35 INFO - 2015-11-15 23:18:35,948 DEBUG : Working with test: dromaeo_css 23:18:35 INFO - 2015-11-15 23:18:35,948 DEBUG : Generating results file: dromaeo_css 23:18:35 INFO - 2015-11-15 23:18:35,949 DEBUG : Working with test: kraken 23:18:35 INFO - 2015-11-15 23:18:35,949 DEBUG : Generating results file: kraken 23:18:35 INFO - 2015-11-15 23:18:35,949 INFO : javascript benchmark 23:18:35 INFO - 2015-11-15 23:18:35,949 DEBUG : Working with test: v8_7 23:18:35 INFO - 2015-11-15 23:18:35,949 DEBUG : Generating results file: v8_7 23:18:35 INFO - 2015-11-15 23:18:35,949 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:18:36 INFO - 2015-11-15 23:18:36,001 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 23:18:36 INFO - 2015-11-15 23:18:36,001 DEBUG : process_Request line: dromaeo_css 5589.54 graph.html#tests=[[72,63,55]] 23:18:36 INFO - 2015-11-15 23:18:36,001 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:18:36 INFO - 2015-11-15 23:18:36,029 DEBUG : process_Request line: kraken 1828.30 graph.html#tests=[[232,63,55]] 23:18:36 INFO - 2015-11-15 23:18:36,029 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:18:36 INFO - 2015-11-15 23:18:36,136 DEBUG : process_Request line: v8_7 15292.22 graph.html#tests=[[230,63,55]] 23:18:36 INFO - 2015-11-15 23:18:36,137 INFO : javascript benchmark 23:18:36 INFO - 2015-11-15 23:18:36,140 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [277.77500224817885, 279.40068552953915, 280.1301957422204, 284.80063955231344, 286.7462295868157, 9582.377145485538, 9990.656421269878, 13953.651158721037, 14390.568282951515, 14696.559103226893, 15342.463013794519, 15382.923085384557, 15662.373505059812, 15794.210289485509, 15881.841181588181, 4608.4700259470255, 4755.9286610700865, 4763.261694437368, 4771.18889788735, 4816.759162041902, 4685.92971105432, 4724.220503616899, 4746.3117847912035, 4763.118823017736, 4807.399075115611, 3370.96629033709, 3477.7739446935866, 3499.4575840744724, 4694.342792009122, 4699.412573428322, 4927.841957140069, 5062.670926389773, 5115.897682046357, 5156.561692256163, 5170.0, 4336.848210312655, 4464.330350447426, 4471.0610771737975, 4490.2142125127975, 4511.300748384006, 17311.0, 17704.380346687805, 17828.821711782846, 17918.731219031593, 17950.19224134917, 520.5575261028133, 520.7656554550467, 522.3679347988938, 1702.1234064456814, 1709.3590651911472, 11312.547498100066, 11365.374904380256, 11494.885051149466, 11538.480768365444, 12189.817152742717, 1387.7155183187422, 1405.8242719660043, 1410.6896482773773, 1444.9422023119062, 1466.787315839208, 48998.0, 50207.497925020645, 50408.24387634188, 50621.684723103914, 51177.23234151491, 8805.515696636618, 8814.86777698335, 8817.250533704579, 8837.513936733412, 8879.200871921428, 11030.338179709242, 11039.172062095375, 11040.613578524713, 11059.612913548148, 11275.154363422776, 5849.502792262705, 5875.383084776037, 5905.704714764331, 6009.609375390673, 6166.136740856284, 5318.867028324323, 5374.0, 5382.327209098863, 5387.461253874581, 5438.293021907127, 5112.0, 5177.223416487557, 5198.2722418861385, 5203.2195170723935, 5253.816116435906, 1483.7700156475548, 1525.1078119300334, 1525.6033431307717, 1546.4510098914948, 1571.088768514259, 288.71417296875944, 355.6727810414425, 373.84298594590337, 376.94722738816586, 383.4918732679211, 8945.239654629298, 9384.202342800801, 9395.718128456158, 9464.716058518256, 9512.239020878313, 359.3621322153199, 373.7944130728089, 376.52181729204307, 389.8908305674416, 397.90251388410024, 4988.700677959334, 5133.0, 5206.167013277857, 5281.996420680135, 5298.70857102863, 289601.0, 296203.0, 296785.0, 315156.0, 473515.0, 49538.75230623824, 52366.47633523692, 52387.73806130945, 54475.727621362435, 55007.17489237665, 401.2436557089907, 411.26178509575385, 413.1221155045528, 413.72280572016217, 414.4798278160949, 8571.271441927505, 8703.521306328214, 8729.258013068706, 8839.867401988846, 8885.911140888767, 25913.22260332193, 26278.21165365042, 26520.734792651827, 26723.33191670224, 27071.86464067667, 37053.629463705016, 37858.15638146834, 37986.45225190246, 38099.80950095232, 38130.0, 5009.724465154306, 5046.21783623539, 5095.363079615048, 5096.770645321044, 5115.616328775432, 9395.436273823592, 9611.711648650551, 9802.65690700822, 9828.017198280115, 9914.652987145704, 8244.381671374791, 8479.576021199038, 8552.743417697478, 8569.82860342802, 8600.182982616641, 8076.919230807852, 8143.307818835466, 8241.340692744687, 8269.503829770232, 8374.581270936551, 7947.721829735931, 8282.958585207036, 8534.23191912706, 8582.399232053696, 8613.0, 4973.552380285647, 5058.140116180185, 5101.617378696538, 5136.768845401891, 5165.560927321219, 8110.06734225548, 8412.158784121539, 8449.28181104613, 8495.660173592987, 8504.957475212585], "dojo.html": [2609.882555285012, 2703.8648067596628, 2712.2541301142196, 2738.739819717127, 2742.6708794944598, 4406.008648054186, 4473.418455600771, 4487.775611219442, 4546.613537849283, 4567.931481027783, 4443.888902777432, 4479.574440428162, 4496.123255965088, 4664.673472856902, 4671.159191345557, 4089.5705950875176, 4170.186813571355, 4205.201011807762, 4214.978925105385, 4225.704200705952, 4224.239636865363, 4248.893777655568, 4257.957420425787, 4295.226859165349, 4323.373110898918, 4013.478247827793, 4133.607307305801, 4146.0, 4195.992961689203, 4223.13425747721, 4042.312806822847, 4043.1711499142607, 4050.291199040186, 4056.391541268804, 4086.3257562502154, 3986.5814089520472, 4091.2431200227757, 4104.835806567734, 4127.071408932996, 4143.585641435862, 4455.977720111411, 4525.86422407325, 4538.841140560065, 4581.198290299218, 4592.3800286961505, 4839.782209800533, 4860.833399984013, 4881.438634557036, 4883.584895283905, 4889.3888263967, 4603.194440972817, 4709.387779588666, 4766.451858036301, 4779.259214821674, 4886.389201349832, 4497.595216430537, 4502.527234640348, 4520.9095818084115, 4523.344115103358, 4566.45202575693, 4837.22604383304, 4913.803447862117, 4953.43035550909, 4971.0, 4985.551300382983, 4507.977460112678, 4600.194965880957, 4601.585857272861, 4636.374089497942, 4784.545468180518, 4807.95192048082, 4808.663393562417, 4811.855644330676, 4828.0, 4845.297431872359, 4739.620830333565, 4742.668013239109, 4763.571278584944, 4782.163121453732, 4798.49615790344, 4559.817607295671, 4688.695234809795, 4695.43654761424, 4730.172219861511, 4747.548982846624, 3644.2529281497227, 3759.154190307214, 3785.9242815143543, 3787.962120378761, 3802.923941521154, 3414.5048967899515, 3416.231347946692, 3454.809985450774, 3455.1189446690933, 3498.3003399320237, 4339.153864996359, 4497.325401189848, 4499.482559505634, 4506.0312032912425, 4529.569690879362, 4765.332853400527, 4831.782569784298, 4837.0, 4840.515948405202, 4923.163062279421, 4480.215962206601, 4519.954800451954, 4520.141173177086, 4529.184746745552, 4582.358469814229, 4146.398772178018, 4280.935785963213, 4282.357646353072, 4328.285832837547, 4356.390105385249, 4742.288656701522, 4844.927326090041, 4880.804767809248, 4939.2838038484215, 4975.527324904128, 4717.127331443694, 4724.905501889874, 4742.004179122423, 4761.761911904322, 4793.376861008047, 4803.495632958489, 4851.733154676526, 4856.902861942812, 4911.705297682151, 4925.014997000686, 4595.1039547287955, 4655.371524844103, 4723.8819029523165, 4726.858194254178, 4746.525347465225, 4901.215805471107, 4947.653664243612, 4968.3292755479, 4976.626752993468, 4981.0, 4557.225271703752, 4761.952380476151, 4769.332293478985, 4798.688085274446, 4799.928001079917, 4527.456705195266, 4588.839390621312, 4603.654725895638, 4661.673682842168, 4726.291056341439, 4564.475085365226, 4657.254839225708, 4657.813687452464, 4677.111348843709, 4684.0, 4444.599986001275, 4696.788644510937, 4761.8333358333675, 4781.6891902026255, 4784.306275590089, 4436.733795972252, 4522.841700540465, 4571.200039992921, 4646.4191976003, 4657.417822772153], "mootools.html": [1047.2302857399814, 1357.3620398412745, 1441.9495317663884, 1455.665197004689, 1499.0930487055332, 5997.730102145403, 6206.751729930803, 6216.564840461164, 6495.707693153808, 6515.153030106091, 6485.156929599158, 6542.934570654292, 6590.242122155953, 6598.736050557972, 6658.0012998050315, 1835.4585397307826, 1853.453231296764, 1853.6292741451696, 1857.8606604504716, 1857.9535511612182, 1883.2937648381858, 1886.6038131992298, 1890.9716354254697, 1928.2961718972545, 1934.42934334371, 1805.4583624912539, 1815.3192552792702, 1819.235920913213, 1821.3079029968594, 1821.9635607287846, 1753.7281721333213, 1755.4733579925971, 1762.929482820692, 1763.1360633289723, 1773.618671985523, 1808.1230603157458, 1834.6697594432997, 1840.917158727847, 1842.1618163735468, 1848.639515294518, 5949.405059494059, 6515.446187074104, 6576.967115164442, 6593.967030164867, 6600.372964568406, 3728.5712143103347, 3827.9617203827884, 3947.822347994347, 4066.6746660267404, 4067.654249388776, 2359.3865594945264, 2392.294273189396, 2401.135591187171, 2438.1588352018703, 2456.545539075259, 727.71982786627, 737.9667914943841, 745.202633182495, 752.9623518824037, 764.4037650632515, 8861.778455538599, 8903.777405564913, 8907.421017633833, 8951.776205594848, 9000.189982901506, 3543.0965103898343, 3629.256002519477, 3667.4132138857653, 3675.1363429594026, 3686.5576130863933, 7833.882491762628, 7836.255555722198, 7851.882221766678, 7878.448508604342, 7933.246341597539, 4105.322621767375, 4109.383592461155, 4110.2396056729, 4138.937915931264, 4142.730722503027, 3705.555333360014, 3713.145976425383, 3727.6458736419995, 3731.421629647409, 3750.212455384345, 2924.7952643314766, 3001.369712360385, 3013.547967804803, 3014.743746781548, 3019.381026889482, 948.7201275623707, 951.0774548687762, 955.2644463762864, 958.7411398922392, 975.3124047546463, 1073.9731506712394, 1094.102835674755, 1125.3585456289836, 1127.21095233337, 1141.9257748246337, 6302.275238347557, 6315.96842015787, 6334.5565810393755, 6336.778212762531, 6340.4293613575, 384.79028929233635, 392.71135715249267, 392.96659783918113, 396.81548080142875, 397.56665234894103, 4595.6783025187915, 4730.5032971538185, 4793.832215872428, 4807.471178170398, 4808.326834243208, 7218.458615603746, 7240.927590724025, 7251.311125443074, 7306.488545801849, 7664.08031036268, 7583.2416758324825, 7669.424793140425, 7746.961265193638, 7795.103563090317, 7805.180456052146, 6075.392460753889, 6076.270847498328, 6287.0, 6321.273053598803, 6322.114903913548, 6035.728392222272, 6052.939470605237, 6062.484688801501, 6067.271927368744, 6071.058985857199, 6778.152730908637, 6909.136357955255, 6974.37230649244, 6991.615461149482, 7126.35862772353, 6899.793006209822, 7098.183708873546, 7230.566166030055, 7262.818429539092, 7272.636368181676, 5754.4533269339345, 5821.359650438533, 5849.210356601804, 5859.062549991981, 5877.794277200277, 6326.6520341381665, 6358.300586935526, 6401.295857455583, 6410.9038364425505, 6434.774782882577, 5881.411858814085, 5966.791162309299, 5971.522278217819, 5982.52139828804, 6005.579609427473, 5827.329857066492, 5833.241678581927, 5927.733252003584, 5942.019566771434, 5961.672108034099, 5986.132010858489, 6050.15297858309, 6052.515798736003, 6081.665508397081, 6097.0, 5260.763265653131, 5481.725913704219, 5492.423295554069, 5500.642458240201, 5512.779488820403, 5542.695151766691, 5599.916001259903, 5602.915956260578, 5644.096944488862, 5653.236813030188], "ext.html": [464.7908441201459, 472.2444089456869, 473.2357243052471, 481.95421434963686, 495.9213710180357, 24702.382440439, 25349.36626584334, 32770.83614581927, 33650.32699346012, 33812.0, 35669.859808411515, 35671.11426614612, 35677.286454270965, 35692.46461303076, 35805.64194358056, 6858.382745552899, 7515.661795219228, 7724.034495688039, 7766.456348055638, 7803.882941755878, 6923.480738944574, 7009.789706308793, 9252.352335336529, 9402.952985235064, 9462.432254064744, 9181.219596334286, 9246.53767311635, 9263.166315031645, 9309.162175404212, 9345.11221433966, 7084.114485689289, 7267.0, 9226.169644731974, 9262.629494820232, 9283.489408082552, 6915.619640919747, 9132.726018219464, 9298.209652179572, 9328.440293582338, 9350.812983740356, 33039.6696033039, 33048.173795655064, 33222.16944576381, 33279.667203327896, 33437.0, 2390.9043638254448, 2467.222824810179, 2582.160797740723, 2707.1878436468983, 2763.488754580389, 22147.0, 22313.888430557905, 22612.321630351114, 22830.0, 23059.884700576556, 1926.3257859749117, 1952.726618273443, 1989.5622962948128, 1995.6008798240264, 1998.980010199894, 229393.0, 230242.0, 230617.85675002757, 231409.0, 232152.0, 49810.75094624504, 50339.748301258995, 50360.496395036316, 50380.74809625928, 50809.0, 42830.0, 43697.563024369985, 44026.55973440289, 52488.212676809875, 52540.47459525356, 10558.894411055944, 10609.575616975235, 10800.891991079989, 10828.187885908588, 10830.296030757976, 7645.15903250642, 7716.884246736304, 7721.150673425918, 7741.0, 7771.145174030852, 16369.754453683205, 16421.261043253082, 16442.260098295606, 16444.424445144363, 16452.87395394871, 6621.569597976116, 6782.593044417351, 6815.897761533581, 6866.896996545056, 6869.7595584154315, 778.1634742651672, 860.7245681382022, 876.2814492116403, 898.196114477552, 902.9322800789967, 23676.7632323678, 23878.328517003643, 24037.879810601185, 24202.87898560496, 24259.393515161908, 852.2995678831251, 864.8443280209623, 872.2803686958284, 916.4959272400154, 1000.8598796168542, 11213.21507494484, 11478.311301321948, 11497.195196336343, 11502.482388292547, 11559.30644161353, 260817.0, 266931.0, 269693.0, 269953.0, 270249.0, 44533.332000020026, 44560.77719611381, 45041.32438013433, 45184.77407612941, 45200.321995170096, 1103.365564800243, 1119.9160062995309, 1128.6952522818958, 1131.1516362727955, 1134.0983917785215, 22371.217007404663, 22681.546369072195, 22715.432114197276, 22771.430714232276, 22862.657060144444, 38439.807800960814, 38705.806470967465, 38936.41595376128, 39087.2182556353, 39302.01744956399, 224309.96125484313, 226696.0, 229100.0, 229252.0, 229657.0, 22273.44316392103, 22630.886845565667, 25092.12177573776, 25883.223503294932, 26560.203193903442, 30282.0, 31190.844045779624, 31219.531707024868, 31290.21774455657, 31351.372972540878, 26187.345316367242, 29186.270343241587, 29225.269368265963, 29386.265343365732, 29474.557881631365, 27778.166655000383, 28199.43601128007, 28506.42987140287, 28601.284967875137, 28623.856880715462, 24456.510869782862, 24918.0, 29068.273293166993, 29588.112356629335, 29652.70347296586, 22140.446488837908, 23891.522169556858, 24029.879850600635, 24157.15449959243, 24184.516309673356, 19582.412527624194, 19773.505662358555, 19966.30117945865, 19996.800032000076, 20656.48358791042], "prototype.html": [257.84786975684347, 259.8999385236683, 266.37003486753827, 267.33167082294267, 268.9569668852984, 5140.357455318085, 5216.035033518801, 5329.0, 5351.866203344918, 5352.5182733553975, 5143.897122057557, 5282.973585132078, 5289.629725919187, 5350.3312085989255, 5353.544948679367, 3873.9031524211837, 3977.303971804937, 4003.5996400359877, 4014.6386825185728, 4049.088954985134, 3976.741511801738, 4044.0698639312977, 4046.8178931947987, 4054.4121102440126, 4074.22589707956, 3976.6619837313865, 3993.7803420811842, 4002.559718430985, 4035.778032208227, 4093.0176757578115, 4019.6583290420203, 4021.4571032910476, 4039.5758445363404, 4061.2892743770017, 4081.510218773766, 3495.0912762681887, 3497.0, 3507.175813683782, 3517.0679769860753, 3552.307300076486, 5015.824446144404, 5168.483151684839, 5194.792208311663, 5211.270422140903, 5214.608904332153, 4570.680052396334, 4584.335271385664, 4595.356650068959, 4608.239640459354, 4628.583427491509, 5426.674399536001, 5458.972705136489, 5590.2732644756325, 5594.1608758686525, 5607.635503692247, 3697.2605478904056, 3708.7774733516076, 3798.620137986207, 3813.7521061131215, 3826.6747326477284, 5732.168835518826, 5845.503132233723, 5847.473727364558, 5863.091220860773, 5889.823305300848, 3857.9421308680394, 3864.3237433449035, 3879.359905615598, 3892.708046896494, 3906.003968987947, 3757.3988161894513, 3913.6673382762215, 3913.784741839226, 3919.529656441245, 3927.351986922183, 4573.63410927125, 4591.288350305708, 4598.724076555351, 4606.193916064675, 4608.953910460852, 5625.54995600351, 5639.887202256014, 5645.927273817962, 5658.377578466366, 5671.291088613923, 1395.665040390299, 1397.8672026157499, 1402.186731695614, 1404.4241860837212, 1410.3864818803854, 894.8836651235428, 904.9411788233743, 915.9313051521029, 931.5807886451124, 935.7613808478794, 5152.3044389007755, 5270.209468579744, 5289.841304760864, 5314.335708036496, 5332.120200166929, 5765.365809760923, 5768.509676677446, 5786.855328616818, 5790.276215473066, 5817.680027598522, 5298.15229563268, 5301.575873930076, 5311.787528498894, 5325.786968521294, 5328.413874473805, 3026.3493348929646, 3130.139211716796, 3162.3833352496044, 3172.5717028200897, 3177.7140057394945, 5981.312149102821, 5985.461308482258, 6043.848903777441, 6058.787942422082, 6065.60573562717, 5985.191999080155, 5986.461218490357, 5997.370276120944, 5997.490213331916, 6030.728617212236, 5819.185314055951, 6002.699865006733, 6004.249468816398, 6025.0962355646125, 6041.909371359433, 5588.413216612197, 5824.504917082096, 5831.067029275465, 5831.562632802472, 5880.6477409035015, 5585.245991791056, 5635.661860288232, 5676.290463692038, 5680.545556355564, 5740.167675687086, 6027.0, 6029.879402412015, 6047.274327080779, 6062.605930614496, 6066.969665151646, 3902.707296952683, 3912.5109361329833, 3945.0137465633593, 3950.0914789597978, 3969.64273215412, 5728.169415434655, 5874.383189765184, 5891.764329426775, 5902.675352855634, 5930.021546444788, 5752.6836024019085, 5762.855928601818, 5767.452092051249, 5786.218860453785, 5793.275840519935, 5727.255456790591, 5731.168980497721, 5745.339285982165, 5759.913601296068, 5769.538436924952, 5373.919391209057, 5590.413006634408, 5629.831105066854, 5642.633228840113, 5680.914786278292, 5718.542516598745, 5726.455986681259, 5727.455891690282, 5743.052396354722, 5803.332616749128, 5581.832545023656, 5587.664740115606, 5592.580556458363, 5596.692181930033, 5639.859003524781], "yui.html": [548.287226605413, 557.1420013179701, 586.2466730251627, 587.4184557288286, 618.5051958433253, 10907.781844363108, 11305.773884522316, 11307.151963602722, 11347.659570212887, 11530.192886497927, 10651.25441219113, 10721.3031152975, 11103.55585776568, 11133.610323638653, 11150.052245559138, 583.104933926423, 590.8434264919799, 593.7803012885239, 721.3940290156255, 745.6048294403947, 737.3290305821703, 743.0860042148161, 750.8047907544051, 761.958092304923, 765.2080097099503, 758.8292634157326, 770.8805135204052, 770.96916123355, 778.381186956371, 779.275273995187, 613.9508839292846, 615.5229696984828, 625.4558534075338, 755.391909512842, 761.2273542354487, 570.5749216833485, 573.1975234671452, 577.6678409914316, 577.9624324418942, 579.1631093070515, 11383.715407114805, 11486.597969071043, 11534.134939879543, 11538.192326537146, 11564.884351156548, 9503.192228660502, 9672.70981870545, 9955.5022248888, 10129.392236465763, 10358.948205259001, 7615.733449329302, 7802.375809935192, 7806.219378062148, 7865.252800983954, 7948.5628290444, 2694.865256737175, 2769.8615069246657, 2823.71762823718, 2843.8293702377923, 2848.3591191981636, 40167.0, 40731.7963410184, 40775.388369174485, 40846.38730419046, 40856.79571602153, 5197.8440646780655, 5353.0899747043095, 5395.217693434509, 5445.183222516575, 5570.387257401682, 9750.951245243728, 9947.20422366209, 9973.102420782165, 9993.500324983721, 9997.650082247086, 5229.6339256251695, 5248.212768084818, 5294.97352513235, 5299.814506492255, 5483.177523371526, 3045.482268014443, 3110.533419986975, 3196.344749326429, 3262.0703099616494, 3291.8847840325475, 2273.352094653049, 2285.4400671835506, 2291.4385975435794, 2295.781900719429, 2302.3323236261294, 338.15798661333105, 340.8398052915126, 342.5461263825441, 342.8080275045982, 347.64366524312277, 386.14276306599305, 404.86841776422193, 437.33879344190956, 492.4902725678905, 518.6447283610738, 5891.852703682443, 6641.369069938348, 6719.596824190564, 6862.897056544156, 6895.724171033203, 320.65049096484944, 443.6473003961858, 474.9501302363202, 529.5842763430766, 536.5224949794685, 2605.231456720272, 2800.6919238883706, 2847.345110624568, 2900.332923427581, 2935.427591619614, 48601.27098093531, 49777.50222497801, 49778.751106244235, 51555.74222128865, 52633.0, 42516.787416063344, 42826.78586607109, 43416.0, 43649.10737050458, 44312.3353149703, 38448.23103537913, 38815.80592097021, 40720.59279407168, 41221.587784122974, 41546.169076618906, 6691.464682825265, 6827.6244806536115, 6866.0, 7052.435805135679, 7235.963820180866, 27394.589081163398, 28762.0, 29913.551296730133, 30230.407374635764, 30243.0, 37614.0, 37938.620613794614, 38418.615813841505, 39340.2131957365, 39356.0, 6131.754729810757, 6185.84535386619, 6276.717547710273, 6290.24517057956, 6427.525402719893, 9063.818723625622, 9438.24494040489, 9463.242940564876, 9579.089986451276, 10000.899991000288, 8959.641614335354, 9033.096690331176, 9055.909440905507, 9105.726828195166, 9228.861567076634, 9029.0, 9091.499967501852, 9129.269658427176, 9197.448153110567, 9266.166045055978, 7371.299726525972, 8386.95806520988, 8883.33374996865, 8949.239314658327, 8984.146506081912, 7473.364763995121, 7487.251274872469, 7497.0, 7590.354819840375, 7861.0, 7454.962725186339, 7513.887291690519, 7682.308592226726, 7819.491733037335, 7940.920590794018]}, "summary": {"lowerIsBetter": false, "suite": 5589.535951866188, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6119.134891003237, "unit": "ms", "value": 6119.134891003237}, "dojo.html": {"lowerIsBetter": false, "filtered": 4448.160387419959, "unit": "ms", "value": 4448.160387419959}, "mootools.html": {"lowerIsBetter": false, "filtered": 3664.8195307257265, "unit": "ms", "value": 3664.8195307257265}, "ext.html": {"lowerIsBetter": false, "filtered": 14969.45734840219, "unit": "ms", "value": 14969.45734840219}, "prototype.html": {"lowerIsBetter": false, "filtered": 4209.156739905849, "unit": "ms", "value": 4209.156739905849}, "yui.html": {"lowerIsBetter": false, "filtered": 4851.630220370962, "unit": "ms", "value": 4851.630220370962}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1447657096, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115210907", "branch": "Mozilla-Inbound", "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2"}}, {"talos_counters": {}, "results": {"audio-dft": [190.0, 198.0, 196.0, 196.0, 198.0, 198.0, 196.0, 189.0, 197.0, 198.0], "ai-astar": [127.0, 130.0, 125.0, 133.0, 134.0, 133.0, 128.0, 125.0, 123.0, 131.0], "imaging-gaussian-blur": [141.0, 141.0, 148.0, 141.0, 141.0, 139.0, 134.0, 141.0, 141.0, 148.0], "audio-beat-detection": [191.0, 160.0, 185.0, 198.0, 161.0, 195.0, 181.0, 155.0, 200.0, 156.0], "json-stringify-tinderbox": [77.0, 81.0, 83.0, 85.0, 85.0, 88.0, 86.0, 85.0, 82.0, 83.0], "stanford-crypto-pbkdf2": [165.0, 188.0, 189.0, 188.0, 178.0, 176.0, 183.0, 188.0, 190.0, 176.0], "json-parse-financial": [65.0, 69.0, 70.0, 73.0, 73.0, 74.0, 75.0, 83.0, 72.0, 72.0], "stanford-crypto-sha256-iterative": [80.0, 82.0, 87.0, 88.0, 88.0, 87.0, 86.0, 86.0, 89.0, 86.0], "audio-fft": [87.0, 98.0, 102.0, 151.0, 81.0, 85.0, 87.0, 86.0, 135.0, 81.0], "imaging-darkroom": [154.0, 155.0, 155.0, 154.0, 150.0, 154.0, 154.0, 155.0, 154.0, 147.0], "stanford-crypto-ccm": [154.0, 161.0, 168.0, 154.0, 155.0, 151.0, 155.0, 152.0, 163.0, 172.0], "audio-oscillator": [119.0, 121.0, 166.0, 109.0, 109.0, 110.0, 152.0, 108.0, 105.0, 147.0], "stanford-crypto-aes": [100.0, 105.0, 106.0, 104.0, 105.0, 105.0, 107.0, 104.0, 106.0, 106.0], "imaging-desaturate": [114.0, 124.0, 120.0, 117.0, 115.0, 124.0, 115.0, 123.0, 115.0, 129.0]}, "summary": {"lowerIsBetter": true, "suite": 1828.2999999999997, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 99.3, "unit": "ms", "value": 99.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 182.1, "unit": "ms", "value": 182.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 178.2, "unit": "ms", "value": 178.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 158.5, "unit": "ms", "value": 158.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 153.2, "unit": "ms", "value": 153.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.6, "unit": "ms", "value": 72.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 124.6, "unit": "ms", "value": 124.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 128.9, "unit": "ms", "value": 128.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 195.6, "unit": "ms", "value": 195.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 85.9, "unit": "ms", "value": 85.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 83.5, "unit": "ms", "value": 83.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 141.5, "unit": "ms", "value": 141.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 104.8, "unit": "ms", "value": 104.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 119.6, "unit": "ms", "value": 119.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1447657096, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115210907", "branch": "Mozilla-Inbound", "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [231.535077564251], "Encrypt": [383.8771593090211], "NavierStokes": [6856.164383561644], "Decrypt": [6903.448275862069], "Splay": [868.8097306689835], "Richards": [197.43336623889437], "RegExp": [36232.142857142855], "Earley": [972.7626459143969], "Boyer": [15363.636363636364], "RayTrace": [2309.4688221709007]}, "summary": {"lowerIsBetter": false, "suite": 15292.222087551216, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 285.5636420000001, "unit": "score", "value": 285.5636420000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 693.4015049999999, "unit": "score", "value": 693.4015049999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 216.44755244755225, "unit": "score", "value": 216.44755244755225}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.55768731268734, "unit": "score", "value": 38.55768731268734}, "Splay": {"lowerIsBetter": false, "filtered": 93.79614099999996, "unit": "score", "value": 93.79614099999996}, "RegExp": {"lowerIsBetter": false, "filtered": 25.14300640709708, "unit": "score", "value": 25.14300640709708}, "Richards": {"lowerIsBetter": false, "filtered": 178.80462999999992, "unit": "score", "value": 178.80462999999992}, "Earley": {"lowerIsBetter": false, "filtered": 685.1239639999999, "unit": "score", "value": 685.1239639999999}, "Boyer": {"lowerIsBetter": false, "filtered": 43.37924852071008, "unit": "score", "value": 43.37924852071008}, "RayTrace": {"lowerIsBetter": false, "filtered": 320.4152370000001, "unit": "score", "value": 320.4152370000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1447657096, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115210907", "branch": "Mozilla-Inbound", "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2"}}] 23:18:36 INFO - RETURN: dromaeo_css: 5589.54 23:18:36 INFO - RETURN: kraken: 1828.30 23:18:36 INFO - RETURN: v8_7: 15292.22 23:18:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15292.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1828.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5589.54"}}} 23:18:36 INFO - Return code: 0 23:18:36 INFO - # TBPL SUCCESS # 23:18:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:18:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:18:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:18:36 INFO - 2015-11-15 23:18:36.245 screenresolution[1937:21850] starting screenresolution argv=screenresolution get 23:18:36 INFO - 2015-11-15 23:18:36.250 screenresolution[1937:21850] Display 0: 1600x1200x32@60 23:18:36 INFO - 2015-11-15 23:18:36.257 screenresolution[1938:21853] starting screenresolution argv=screenresolution list 23:18:36 INFO - Available Modes on Display 0 23:18:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:18:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:18:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:18:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:18:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:18:36 INFO - Intel HD Graphics 3000: 23:18:36 INFO - Chipset Model: Intel HD Graphics 3000 23:18:36 INFO - Type: GPU 23:18:36 INFO - Bus: Built-In 23:18:36 INFO - VRAM (Total): 512 MB 23:18:36 INFO - VRAM (Dynamic, Max): 10 23:18:36 INFO - Vendor: Intel (0x8086) 23:18:36 INFO - Device ID: 0x0116 23:18:36 INFO - Revision ID: 0x0009 23:18:36 INFO - Displays: 23:18:36 INFO - Display: 23:18:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:18:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:18:36 INFO - Display Serial Number: 1600x1200 60 23:18:36 INFO - Main Display: Yes 23:18:36 INFO - Mirror: Off 23:18:36 INFO - Online: Yes 23:18:36 INFO - Rotation: Supported 23:18:36 INFO - Return code: 0 23:18:36 INFO - Running post-action listener: _resource_record_post_action 23:18:36 INFO - Running post-run listener: _resource_record_post_run 23:18:37 INFO - Total resource usage - Wall time: 1263s; CPU: 30.0%; Read bytes: 675840; Write bytes: 684660736; Read time: 49; Write time: 55437 23:18:37 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 336574976; Write bytes: 333696000; Read time: 36744; Write time: 4307 23:18:37 INFO - run-tests - Wall time: 1220s; CPU: 30.0%; Read bytes: 675840; Write bytes: 339423232; Read time: 49; Write time: 50335 23:18:37 INFO - Running post-run listener: _upload_blobber_files 23:18:37 INFO - Blob upload gear active. 23:18:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:18:37 INFO - Copying logs to upload dir... 23:18:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1320.385845 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-15 23:18:37.720862) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 23:18:37.724088) ========= 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.hfTL40YFsd/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.MDH2ZOVo7f/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010970 build_url: 'https://queue.taskcluster.net/v1/task/mOYplzfFSJ6GBerQ78TcGQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 23:18:37.752740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 23:18:37.753076) ========= 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.hfTL40YFsd/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.MDH2ZOVo7f/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005931 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 23:18:37.802969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 23:18:37.803283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 23:18:37.803797) ========= ========= Total master_lag: 0.29 =========