builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0066 starttime: 1447613652.3 results: success (0) buildid: 20151115091233 builduid: 256638c12b1c45efa64d9bbfc75c3d4c revision: 7cd2d806bd069c0260ff73f023ac85f892b863bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:12.295936) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:12.296349) ========= ========= Started set props: basedir (results: 0, elapsed: 5 secs) (at 2015-11-15 10:54:12.296684) ========= 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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.007114 basedir: '/builds/slave/test' ========= master_lag: 5.60 ========= ========= Finished set props: basedir (results: 0, elapsed: 5 secs) (at 2015-11-15 10:54:17.906348) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 14 secs) (at 2015-11-15 10:54:17.906683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 14 secs) (at 2015-11-15 10:54:32.826972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:32.827419) ========= 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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.005978 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:32.914267) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:32.914565) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:32.914941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-15 10:54:32.915225) ========= 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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:54:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-11-15 10:54:33 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.232183 ========= master_lag: 0.90 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-15 10:54:34.047848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:34.048134) ========= 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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.022291 ========= master_lag: 0.65 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:34.720979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:34.721288) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7cd2d806bd069c0260ff73f023ac85f892b863bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7cd2d806bd069c0260ff73f023ac85f892b863bf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YC7BvSZPyw/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.bwgvfdeKUT/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:54:34,937 truncating revision to first 12 chars 2015-11-15 10:54:34,937 Setting DEBUG logging. 2015-11-15 10:54:34,937 attempt 1/10 2015-11-15 10:54:34,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7cd2d806bd06?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 10:54:35,195 unpacking tar archive at: mozilla-central-7cd2d806bd06/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566232 ========= master_lag: 0.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:35.636738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:35.637030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:35.708176) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:35.708590) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 10:54:35.709064) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 11 secs) (at 2015-11-15 10:54:35.709404) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YC7BvSZPyw/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.bwgvfdeKUT/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:54:35 INFO - MultiFileLogger online at 20151115 10:54:35 in /builds/slave/test 10:54:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:54:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:54:35 INFO - {'append_to_log': False, 10:54:35 INFO - 'base_work_dir': '/builds/slave/test', 10:54:35 INFO - 'blob_upload_branch': 'Firefox', 10:54:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:54:35 INFO - 'branch': 'Firefox', 10:54:35 INFO - 'buildbot_json_path': 'buildprops.json', 10:54:35 INFO - 'config_files': ('talos/mac_config.py',), 10:54:35 INFO - 'default_actions': ('clobber', 10:54:35 INFO - 'read-buildbot-config', 10:54:35 INFO - 'download-and-extract', 10:54:35 INFO - 'populate-webroot', 10:54:35 INFO - 'create-virtualenv', 10:54:35 INFO - 'install', 10:54:35 INFO - 'run-tests'), 10:54:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:54:35 INFO - 'download_minidump_stackwalk': True, 10:54:35 INFO - 'download_symbols': 'ondemand', 10:54:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:54:35 INFO - 'tooltool.py': '/tools/tooltool.py', 10:54:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:54:35 INFO - '/tools/misc-python/virtualenv.py')}, 10:54:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:54:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:54:35 INFO - 'installer_path': 'installer.exe', 10:54:35 INFO - 'log_level': 'info', 10:54:35 INFO - 'log_name': 'talos', 10:54:35 INFO - 'log_to_console': True, 10:54:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:54:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:54:35 INFO - 'opt_config_files': (), 10:54:35 INFO - 'pip_index': False, 10:54:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:54:35 INFO - 'cmd': ('bash', 10:54:35 INFO - '-c', 10:54:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:54:35 INFO - 'enabled': True, 10:54:35 INFO - 'halt_on_failure': False, 10:54:35 INFO - 'name': 'check_screen_resolution'},), 10:54:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:54:35 INFO - 'cmd': ('bash', 10:54:35 INFO - '-c', 10:54:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:54:35 INFO - 'enabled': True, 10:54:35 INFO - 'halt_on_failure': False, 10:54:35 INFO - 'name': 'check_screen_resolution'},), 10:54:35 INFO - 'run_cmd_checks_enabled': True, 10:54:35 INFO - 'sps_profile': False, 10:54:35 INFO - 'sps_profile_interval': 0, 10:54:35 INFO - 'suite': 'dromaeojs', 10:54:35 INFO - 'system_bits': '64', 10:54:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:54:35 INFO - 'title': 't-yosemite-r5-0066', 10:54:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:54:35 INFO - 'use_talos_json': True, 10:54:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:54:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:54:35 INFO - 'work_dir': 'build'} 10:54:35 INFO - ##### 10:54:35 INFO - ##### Running clobber step. 10:54:35 INFO - ##### 10:54:35 INFO - Running pre-action listener: _resource_record_pre_action 10:54:35 INFO - Running main action method: clobber 10:54:35 INFO - rmtree: /builds/slave/test/build 10:54:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:54:38 INFO - Running post-action listener: _resource_record_post_action 10:54:38 INFO - ##### 10:54:38 INFO - ##### Running read-buildbot-config step. 10:54:38 INFO - ##### 10:54:38 INFO - Running pre-action listener: _resource_record_pre_action 10:54:38 INFO - Running main action method: read_buildbot_config 10:54:38 INFO - Using buildbot properties: 10:54:38 INFO - { 10:54:38 INFO - "properties": { 10:54:38 INFO - "buildnumber": 605, 10:54:38 INFO - "product": "firefox", 10:54:38 INFO - "script_repo_revision": "production", 10:54:38 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 10:54:38 INFO - "repository": "", 10:54:38 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 10:54:38 INFO - "buildid": "20151115091233", 10:54:38 INFO - "slavename": "t-yosemite-r5-0066", 10:54:38 INFO - "pgo_build": "False", 10:54:38 INFO - "basedir": "/builds/slave/test", 10:54:38 INFO - "project": "", 10:54:38 INFO - "platform": "yosemite", 10:54:38 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:54:38 INFO - "slavebuilddir": "test", 10:54:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:54:38 INFO - "branch": "mozilla-central", 10:54:38 INFO - "repo_path": "mozilla-central", 10:54:38 INFO - "stage_platform": "macosx64", 10:54:38 INFO - "builduid": "256638c12b1c45efa64d9bbfc75c3d4c", 10:54:38 INFO - "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf" 10:54:38 INFO - }, 10:54:38 INFO - "sourcestamp": { 10:54:38 INFO - "repository": "", 10:54:38 INFO - "hasPatch": false, 10:54:38 INFO - "project": "", 10:54:38 INFO - "branch": "mozilla-central-macosx64-talos", 10:54:38 INFO - "changes": [ 10:54:38 INFO - { 10:54:38 INFO - "category": null, 10:54:38 INFO - "files": [ 10:54:38 INFO - { 10:54:38 INFO - "url": null, 10:54:38 INFO - "name": "https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 10:54:38 INFO - } 10:54:38 INFO - ], 10:54:38 INFO - "repository": "", 10:54:38 INFO - "rev": "7cd2d806bd069c0260ff73f023ac85f892b863bf", 10:54:38 INFO - "who": "philringnalda@gmail.com", 10:54:38 INFO - "when": 1447613294, 10:54:38 INFO - "number": 6663783, 10:54:38 INFO - "comments": "Merge f-t and m-i to m-c, a=merge", 10:54:38 INFO - "project": "", 10:54:38 INFO - "at": "Sun 15 Nov 2015 10:48:14", 10:54:38 INFO - "branch": "mozilla-central-macosx64-talos", 10:54:38 INFO - "revlink": "", 10:54:38 INFO - "properties": [ 10:54:38 INFO - [ 10:54:38 INFO - "buildid", 10:54:38 INFO - "20151115091233", 10:54:38 INFO - "Change" 10:54:38 INFO - ], 10:54:38 INFO - [ 10:54:38 INFO - "builduid", 10:54:38 INFO - "256638c12b1c45efa64d9bbfc75c3d4c", 10:54:38 INFO - "Change" 10:54:38 INFO - ], 10:54:38 INFO - [ 10:54:38 INFO - "pgo_build", 10:54:38 INFO - "False", 10:54:38 INFO - "Change" 10:54:38 INFO - ] 10:54:38 INFO - ], 10:54:38 INFO - "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf" 10:54:38 INFO - } 10:54:38 INFO - ], 10:54:38 INFO - "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf" 10:54:38 INFO - } 10:54:38 INFO - } 10:54:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 10:54:38 INFO - Running post-action listener: _resource_record_post_action 10:54:38 INFO - ##### 10:54:38 INFO - ##### Running download-and-extract step. 10:54:38 INFO - ##### 10:54:38 INFO - Running pre-action listener: _resource_record_pre_action 10:54:38 INFO - Running main action method: download_and_extract 10:54:38 INFO - mkdir: /builds/slave/test/build/tests 10:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:38 INFO - https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/test_packages.json 10:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/test_packages.json 10:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:54:38 INFO - Downloaded 1149 bytes. 10:54:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:54:38 INFO - Using the following test package requirements: 10:54:38 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:54:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:54:38 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 10:54:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:54:38 INFO - u'jsshell-mac.zip'], 10:54:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:54:38 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 10:54:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:54:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:54:38 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 10:54:38 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:54:38 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 10:54:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:54:38 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 10:54:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:54:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:54:38 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 10:54:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:38 INFO - https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:54:40 INFO - Downloaded 17464114 bytes. 10:54:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 10:54:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:54:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:54:45 INFO - Return code: 0 10:54:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:45 INFO - https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:54:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:54:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:54:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:54:46 INFO - Downloaded 17464114 bytes. 10:54:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 10:54:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:54:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:54:53 INFO - Return code: 0 10:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:53 INFO - https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:54:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:54:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:54:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:54:54 INFO - Downloaded 11131693 bytes. 10:54:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 10:54:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:54:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 10:54:54 INFO - Return code: 0 10:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:54 INFO - https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:54:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:54:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:54:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 10:54:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 10:54:59 INFO - Downloaded 108673671 bytes. 10:54:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:54:59 INFO - mkdir: /builds/slave/test/properties 10:54:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:54:59 INFO - Writing to file /builds/slave/test/properties/build_url 10:54:59 INFO - Contents: 10:54:59 INFO - build_url:https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:54:59 INFO - Running post-action listener: _resource_record_post_action 10:54:59 INFO - Running post-action listener: set_extra_try_arguments 10:54:59 INFO - ##### 10:54:59 INFO - ##### Running populate-webroot step. 10:54:59 INFO - ##### 10:54:59 INFO - Running pre-action listener: _resource_record_pre_action 10:54:59 INFO - Running main action method: populate_webroot 10:54:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:54:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:54:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:54:59 INFO - '../fennec_ids.txt'], 10:54:59 INFO - 'tests': ['tcheck2']}, 10:54:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:54:59 INFO - '--tppagecycles', 10:54:59 INFO - '7'], 10:54:59 INFO - 'tests': ['tsvgm']}}, 10:54:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:54:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:54:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:54:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:54:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:59 INFO - 'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:59 INFO - 'tests': ['damp', 'tps']}, 10:54:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:59 INFO - 'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['damp', 'tps']}, 10:54:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:54:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:54:59 INFO - 'other': {'tests': ['a11yr', 10:54:59 INFO - 'ts_paint', 10:54:59 INFO - 'tpaint', 10:54:59 INFO - 'sessionrestore', 10:54:59 INFO - 'sessionrestore_no_auto_restore']}, 10:54:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['a11yr', 10:54:59 INFO - 'ts_paint', 10:54:59 INFO - 'tpaint', 10:54:59 INFO - 'sessionrestore', 10:54:59 INFO - 'sessionrestore_no_auto_restore']}, 10:54:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['a11yr', 10:54:59 INFO - 'ts_paint', 10:54:59 INFO - 'tpaint', 10:54:59 INFO - 'sessionrestore', 10:54:59 INFO - 'sessionrestore_no_auto_restore']}, 10:54:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['a11yr', 10:54:59 INFO - 'ts_paint', 10:54:59 INFO - 'tpaint', 10:54:59 INFO - 'sessionrestore', 10:54:59 INFO - 'sessionrestore_no_auto_restore']}, 10:54:59 INFO - 'other_l64': {'tests': ['a11yr', 10:54:59 INFO - 'ts_paint', 10:54:59 INFO - 'tpaint', 10:54:59 INFO - 'sessionrestore', 10:54:59 INFO - 'sessionrestore_no_auto_restore']}, 10:54:59 INFO - 'other_nol64': {'tests': ['a11yr', 10:54:59 INFO - 'ts_paint', 10:54:59 INFO - 'tpaint', 10:54:59 INFO - 'sessionrestore', 10:54:59 INFO - 'sessionrestore_no_auto_restore']}, 10:54:59 INFO - 'svgr': {'tests': ['tsvgx', 10:54:59 INFO - 'tsvgr_opacity', 10:54:59 INFO - 'tart', 10:54:59 INFO - 'tscrollx', 10:54:59 INFO - 'cart']}, 10:54:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['tsvgx', 10:54:59 INFO - 'tsvgr_opacity', 10:54:59 INFO - 'tart', 10:54:59 INFO - 'tscrollx', 10:54:59 INFO - 'cart']}, 10:54:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:59 INFO - 'tests': ['tp5o']}, 10:54:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:59 INFO - 'talos_options': ['--e10s'], 10:54:59 INFO - 'tests': ['tp5o']}, 10:54:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:59 INFO - 'talos_options': ['--xperf_path', 10:54:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:59 INFO - 'tests': ['tp5n']}, 10:54:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:59 INFO - 'talos_options': ['--e10s', 10:54:59 INFO - '--xperf_path', 10:54:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:59 INFO - 'tests': ['tp5n']}}, 10:54:59 INFO - 'talos.zip': {'path': '', 10:54:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:54:59 INFO - Running post-action listener: _resource_record_post_action 10:54:59 INFO - ##### 10:54:59 INFO - ##### Running create-virtualenv step. 10:54:59 INFO - ##### 10:54:59 INFO - Running pre-action listener: _resource_record_pre_action 10:54:59 INFO - Running main action method: create_virtualenv 10:54:59 INFO - Creating virtualenv /builds/slave/test/build/venv 10:54:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:54:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:54:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:54:59 INFO - Using real prefix '/tools/python27' 10:54:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:55:00 INFO - Installing distribute.............................................................................................................................................................................................done. 10:55:04 INFO - Installing pip.................done. 10:55:04 INFO - Return code: 0 10:55:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108838490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108815228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed7ae105b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875b9f0>, '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 0x1084bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874f8c8>, '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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:55:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YC7BvSZPyw/Render', 10:55:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:04 INFO - 'HOME': '/Users/cltbld', 10:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:04 INFO - 'LOGNAME': 'cltbld', 10:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:04 INFO - 'MOZ_NO_REMOTE': '1', 10:55:04 INFO - 'NO_EM_RESTART': '1', 10:55:04 INFO - 'PAGER': '/bin/cat', 10:55:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:04 INFO - 'PWD': '/builds/slave/test', 10:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:04 INFO - 'SHELL': '/bin/bash', 10:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bwgvfdeKUT/Listeners', 10:55:04 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 10:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:04 INFO - 'USER': 'cltbld', 10:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:04 INFO - 'XPC_FLAGS': '0x0', 10:55:04 INFO - 'XPC_SERVICE_NAME': '0', 10:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 10:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:55:05 INFO - Cleaning up... 10:55:05 INFO - Return code: 0 10:55:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:05 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 0x108838490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108815228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed7ae105b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875b9f0>, '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 0x1084bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874f8c8>, '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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YC7BvSZPyw/Render', 10:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:05 INFO - 'HOME': '/Users/cltbld', 10:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:05 INFO - 'LOGNAME': 'cltbld', 10:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:05 INFO - 'MOZ_NO_REMOTE': '1', 10:55:05 INFO - 'NO_EM_RESTART': '1', 10:55:05 INFO - 'PAGER': '/bin/cat', 10:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:05 INFO - 'PWD': '/builds/slave/test', 10:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:05 INFO - 'SHELL': '/bin/bash', 10:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bwgvfdeKUT/Listeners', 10:55:05 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 10:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:05 INFO - 'USER': 'cltbld', 10:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:05 INFO - 'XPC_FLAGS': '0x0', 10:55:05 INFO - 'XPC_SERVICE_NAME': '0', 10:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 10:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:05 INFO - Downloading/unpacking psutil>=0.7.1 10:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:55:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:55:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:08 INFO - Installing collected packages: psutil 10:55:08 INFO - Running setup.py install for psutil 10:55:08 INFO - building 'psutil._psutil_osx' extension 10:55:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:55:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:55:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:55:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:55:09 INFO - building 'psutil._psutil_posix' extension 10:55:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:55:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:55:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:55:09 INFO - ^ 10:55:09 INFO - 1 warning generated. 10:55:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:55:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:09 INFO - Successfully installed psutil 10:55:09 INFO - Cleaning up... 10:55:09 INFO - Return code: 0 10:55:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:09 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 0x108838490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108815228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed7ae105b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875b9f0>, '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 0x1084bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874f8c8>, '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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:55:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YC7BvSZPyw/Render', 10:55:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:09 INFO - 'HOME': '/Users/cltbld', 10:55:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:09 INFO - 'LOGNAME': 'cltbld', 10:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:09 INFO - 'MOZ_NO_REMOTE': '1', 10:55:09 INFO - 'NO_EM_RESTART': '1', 10:55:09 INFO - 'PAGER': '/bin/cat', 10:55:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:09 INFO - 'PWD': '/builds/slave/test', 10:55:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:09 INFO - 'SHELL': '/bin/bash', 10:55:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bwgvfdeKUT/Listeners', 10:55:09 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 10:55:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:09 INFO - 'USER': 'cltbld', 10:55:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:09 INFO - 'XPC_FLAGS': '0x0', 10:55:09 INFO - 'XPC_SERVICE_NAME': '0', 10:55:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 10:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:55:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:55:13 INFO - Installing collected packages: mozsystemmonitor 10:55:13 INFO - Running setup.py install for mozsystemmonitor 10:55:13 INFO - Successfully installed mozsystemmonitor 10:55:13 INFO - Cleaning up... 10:55:13 INFO - Return code: 0 10:55:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108838490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108815228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed7ae105b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875b9f0>, '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 0x1084bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874f8c8>, '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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:55:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YC7BvSZPyw/Render', 10:55:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:13 INFO - 'HOME': '/Users/cltbld', 10:55:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:13 INFO - 'LOGNAME': 'cltbld', 10:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:13 INFO - 'MOZ_NO_REMOTE': '1', 10:55:13 INFO - 'NO_EM_RESTART': '1', 10:55:13 INFO - 'PAGER': '/bin/cat', 10:55:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:13 INFO - 'PWD': '/builds/slave/test', 10:55:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:13 INFO - 'SHELL': '/bin/bash', 10:55:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bwgvfdeKUT/Listeners', 10:55:13 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 10:55:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:13 INFO - 'USER': 'cltbld', 10:55:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:13 INFO - 'XPC_FLAGS': '0x0', 10:55:13 INFO - 'XPC_SERVICE_NAME': '0', 10:55:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 10:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:55:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:55:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:55:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:18 INFO - Downloading docopt-0.6.1.tar.gz 10:55:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:55:18 INFO - Installing collected packages: blobuploader, requests, docopt 10:55:18 INFO - Running setup.py install for blobuploader 10:55:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:55:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:55:18 INFO - Running setup.py install for requests 10:55:19 INFO - Running setup.py install for docopt 10:55:19 INFO - Successfully installed blobuploader requests docopt 10:55:19 INFO - Cleaning up... 10:55:19 INFO - Return code: 0 10:55:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:19 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 0x108838490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108815228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed7ae105b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875b9f0>, '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 0x1084bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874f8c8>, '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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YC7BvSZPyw/Render', 10:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:19 INFO - 'HOME': '/Users/cltbld', 10:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:19 INFO - 'LOGNAME': 'cltbld', 10:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:19 INFO - 'MOZ_NO_REMOTE': '1', 10:55:19 INFO - 'NO_EM_RESTART': '1', 10:55:19 INFO - 'PAGER': '/bin/cat', 10:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:19 INFO - 'PWD': '/builds/slave/test', 10:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:19 INFO - 'SHELL': '/bin/bash', 10:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bwgvfdeKUT/Listeners', 10:55:19 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 10:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:19 INFO - 'USER': 'cltbld', 10:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:19 INFO - 'XPC_FLAGS': '0x0', 10:55:19 INFO - 'XPC_SERVICE_NAME': '0', 10:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 10:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:20 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-rtMT7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:20 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-kicLrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:20 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-TCiZ38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:20 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-0fERgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:20 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-PXC2Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:20 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-queyqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:20 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-Oa6chq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:21 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-bLNHvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:21 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-1bjpzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:21 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-i2aXs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:21 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-2BS5GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:21 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-OTV9MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:21 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-X7qOWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:22 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-exoFQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:22 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-fcgRMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:22 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-sIPxbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:22 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-IT7DhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:55:22 INFO - Running setup.py install for manifestparser 10:55:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:55:22 INFO - Running setup.py install for mozcrash 10:55:23 INFO - Running setup.py install for mozdebug 10:55:23 INFO - Running setup.py install for mozdevice 10:55:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:55:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:55:23 INFO - Running setup.py install for mozfile 10:55:23 INFO - Running setup.py install for mozhttpd 10:55:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:55:23 INFO - Running setup.py install for mozinfo 10:55:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:55:24 INFO - Running setup.py install for mozInstall 10:55:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:55:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:55:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:55:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:55:24 INFO - Running setup.py install for mozleak 10:55:24 INFO - Running setup.py install for mozlog 10:55:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:55:24 INFO - Running setup.py install for moznetwork 10:55:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:55:25 INFO - Running setup.py install for mozprocess 10:55:25 INFO - Running setup.py install for mozprofile 10:55:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:55:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:55:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:55:25 INFO - Running setup.py install for mozrunner 10:55:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:55:25 INFO - Running setup.py install for mozscreenshot 10:55:25 INFO - Running setup.py install for moztest 10:55:26 INFO - Running setup.py install for mozversion 10:55:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:55:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:55:26 INFO - Cleaning up... 10:55:26 INFO - Return code: 0 10:55:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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 0x108838490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108815228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed7ae105b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875b9f0>, '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 0x1084bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874f8c8>, '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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:55: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 10:55: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 10:55:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YC7BvSZPyw/Render', 10:55:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:26 INFO - 'HOME': '/Users/cltbld', 10:55:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:26 INFO - 'LOGNAME': 'cltbld', 10:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:26 INFO - 'MOZ_NO_REMOTE': '1', 10:55:26 INFO - 'NO_EM_RESTART': '1', 10:55:26 INFO - 'PAGER': '/bin/cat', 10:55:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:26 INFO - 'PWD': '/builds/slave/test', 10:55:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:26 INFO - 'SHELL': '/bin/bash', 10:55:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bwgvfdeKUT/Listeners', 10:55:26 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 10:55:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:26 INFO - 'USER': 'cltbld', 10:55:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:26 INFO - 'XPC_FLAGS': '0x0', 10:55:26 INFO - 'XPC_SERVICE_NAME': '0', 10:55:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 10:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:26 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-xXFMce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:26 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-w4o4Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55: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)) 10:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:27 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-AvkfjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55: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)) 10:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:27 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-HoV5OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55: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)) 10:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:27 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-Mg7xA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55: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)) 10:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:27 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-Wg1vUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55: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)) 10:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:27 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-0D8t6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:27 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-TBfqJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55: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)) 10:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:28 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-6O3sNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55: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)) 10:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:28 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-zkR4iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55: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)) 10:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:28 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-nO9vVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55: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)) 10:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:28 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-J4dyK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55: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)) 10:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:28 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-xtbVab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55: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)) 10:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:28 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-cvVTUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:28 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-hYSqGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55: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)) 10:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:29 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-8VsBTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55: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)) 10:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:29 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-_FkThp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55:32 INFO - Downloading blessings-1.5.1.tar.gz 10:55: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 10:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:55:32 INFO - Installing collected packages: blessings 10:55:32 INFO - Running setup.py install for blessings 10:55:32 INFO - Successfully installed blessings 10:55:32 INFO - Cleaning up... 10:55:32 INFO - Return code: 0 10:55:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:33 INFO - Reading from file tmpfile_stdout 10:55:33 INFO - Current package versions: 10:55:33 INFO - blessings == 1.5.1 10:55:33 INFO - blobuploader == 1.2.4 10:55:33 INFO - docopt == 0.6.1 10:55:33 INFO - manifestparser == 1.1 10:55:33 INFO - mozInstall == 1.12 10:55:33 INFO - mozcrash == 0.16 10:55:33 INFO - mozdebug == 0.1 10:55:33 INFO - mozdevice == 0.47 10:55:33 INFO - mozfile == 1.2 10:55:33 INFO - mozhttpd == 0.7 10:55:33 INFO - mozinfo == 0.9 10:55:33 INFO - mozleak == 0.1 10:55:33 INFO - mozlog == 3.0 10:55:33 INFO - moznetwork == 0.27 10:55:33 INFO - mozprocess == 0.22 10:55:33 INFO - mozprofile == 0.27 10:55:33 INFO - mozrunner == 6.11 10:55:33 INFO - mozscreenshot == 0.1 10:55:33 INFO - mozsystemmonitor == 0.0 10:55:33 INFO - moztest == 0.7 10:55:33 INFO - mozversion == 1.4 10:55:33 INFO - psutil == 3.1.1 10:55:33 INFO - requests == 1.2.3 10:55:33 INFO - wsgiref == 0.1.2 10:55:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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 0x108838490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108815228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed7ae105b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875b9f0>, '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 0x1084bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874f8c8>, '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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 10:55: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 10:55: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 10:55:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YC7BvSZPyw/Render', 10:55:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:33 INFO - 'HOME': '/Users/cltbld', 10:55:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:33 INFO - 'LOGNAME': 'cltbld', 10:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:33 INFO - 'MOZ_NO_REMOTE': '1', 10:55:33 INFO - 'NO_EM_RESTART': '1', 10:55:33 INFO - 'PAGER': '/bin/cat', 10:55:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:33 INFO - 'PWD': '/builds/slave/test', 10:55:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:33 INFO - 'SHELL': '/bin/bash', 10:55:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bwgvfdeKUT/Listeners', 10:55:33 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 10:55:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:33 INFO - 'USER': 'cltbld', 10:55:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:33 INFO - 'XPC_FLAGS': '0x0', 10:55:33 INFO - 'XPC_SERVICE_NAME': '0', 10:55:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 10:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55: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)) 10:55:33 INFO - Cleaning up... 10:55:33 INFO - Return code: 0 10:55:33 INFO - Running post-action listener: _resource_record_post_action 10:55:33 INFO - Running post-action listener: _start_resource_monitoring 10:55:33 INFO - Starting resource monitoring. 10:55:33 INFO - ##### 10:55:33 INFO - ##### Running install step. 10:55:33 INFO - ##### 10:55:33 INFO - Running pre-action listener: _resource_record_pre_action 10:55:33 INFO - Running main action method: install 10:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:33 INFO - Reading from file tmpfile_stdout 10:55:33 INFO - Detecting whether we're running mozinstall >=1.0... 10:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:55:34 INFO - Reading from file tmpfile_stdout 10:55:34 INFO - Output received: 10:55:34 INFO - Usage: mozinstall [options] installer 10:55:34 INFO - Options: 10:55:34 INFO - -h, --help show this help message and exit 10:55:34 INFO - -d DEST, --destination=DEST 10:55:34 INFO - Directory to install application into. [default: 10:55:34 INFO - "/builds/slave/test"] 10:55:34 INFO - --app=APP Application being installed. [default: firefox] 10:55:34 INFO - mkdir: /builds/slave/test/build/application 10:55:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:56:19 INFO - Reading from file tmpfile_stdout 10:56:19 INFO - Output received: 10:56:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:56:19 INFO - Running post-action listener: _resource_record_post_action 10:56:19 INFO - ##### 10:56:19 INFO - ##### Running run-tests step. 10:56:19 INFO - ##### 10:56:19 INFO - Running pre-action listener: _resource_record_pre_action 10:56:19 INFO - Running main action method: run_tests 10:56:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:56:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:56:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:56:19 INFO - 2015-11-15 10:56:19.814 screenresolution[1925:11979] starting screenresolution argv=screenresolution get 10:56:19 INFO - 2015-11-15 10:56:19.818 screenresolution[1925:11979] Display 0: 1600x1200x32@60 10:56:19 INFO - 2015-11-15 10:56:19.826 screenresolution[1926:11981] starting screenresolution argv=screenresolution list 10:56:19 INFO - Available Modes on Display 0 10:56:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:56:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:56:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:56:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:56:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:56:20 INFO - Intel HD Graphics 3000: 10:56:20 INFO - Chipset Model: Intel HD Graphics 3000 10:56:20 INFO - Type: GPU 10:56:20 INFO - Bus: Built-In 10:56:20 INFO - VRAM (Total): 512 MB 10:56:20 INFO - VRAM (Dynamic, Max): 10 10:56:20 INFO - Vendor: Intel (0x8086) 10:56:20 INFO - Device ID: 0x0116 10:56:20 INFO - Revision ID: 0x0009 10:56:20 INFO - Displays: 10:56:20 INFO - Display: 10:56:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:56:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:56:20 INFO - Display Serial Number: 1600x1200 60 10:56:20 INFO - Main Display: Yes 10:56:20 INFO - Mirror: Off 10:56:20 INFO - Online: Yes 10:56:20 INFO - Rotation: Supported 10:56:20 INFO - Return code: 0 10:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:56:20 INFO - Python 2.7.3 10:56:20 INFO - Return code: 0 10:56:20 INFO - grabbing minidump binary from tooltool 10:56: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')]} 10:56:20 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 0x10875b9f0>, '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 0x1084bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10874f8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:56:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:56:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:56:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:56:20 INFO - Return code: 0 10:56:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:56:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:56:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:56:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:56:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0066', '--webServer', 'localhost'] in /builds/slave/test/build 10:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0066 --webServer localhost 10:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YC7BvSZPyw/Render', 10:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:20 INFO - 'HOME': '/Users/cltbld', 10:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:20 INFO - 'LOGNAME': 'cltbld', 10:56:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:56:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:20 INFO - 'MOZ_NO_REMOTE': '1', 10:56:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:56:20 INFO - 'NO_EM_RESTART': '1', 10:56:20 INFO - 'PAGER': '/bin/cat', 10:56:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:20 INFO - 'PWD': '/builds/slave/test', 10:56:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:20 INFO - 'SHELL': '/bin/bash', 10:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bwgvfdeKUT/Listeners', 10:56:20 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 10:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:20 INFO - 'USER': 'cltbld', 10:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:20 INFO - 'XPC_FLAGS': '0x0', 10:56:20 INFO - 'XPC_SERVICE_NAME': '0', 10:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 10:56:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0066', '--webServer', 'localhost'] with output_timeout 3600 10:56:20 INFO - mozversion INFO | application_buildid: 20151115091233 10:56:20 INFO - mozversion INFO | application_changeset: 7cd2d806bd069c0260ff73f023ac85f892b863bf 10:56:20 INFO - mozversion INFO | application_display_name: Nightly 10:56:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:56:20 INFO - mozversion INFO | application_name: Firefox 10:56:20 INFO - mozversion INFO | application_remotingname: firefox 10:56:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 10:56:20 INFO - mozversion INFO | application_vendor: Mozilla 10:56:20 INFO - mozversion INFO | application_version: 45.0a1 10:56:20 INFO - mozversion INFO | platform_buildid: 20151115091233 10:56:20 INFO - mozversion INFO | platform_changeset: 7cd2d806bd069c0260ff73f023ac85f892b863bf 10:56:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 10:56:20 INFO - mozversion INFO | platform_version: 45.0a1 10:56:20 INFO - 2015-11-15 10:56:20,594 DEBUG : using testdate: 1447613780 10:56:20 INFO - 2015-11-15 10:56:20,594 DEBUG : actual date: 1447613780 10:56:20 INFO - 2015-11-15 10:56:20,653 INFO : starting webserver on 'localhost:49584' 10:56:20 INFO - 2015-11-15 10:56:20,655 INFO : Starting test suite t-yosemite-r5-0066 10:56:20 INFO - 2015-11-15 10:56:20,655 INFO : Starting test dromaeo_css 10:56:20 INFO - 2015-11-15 10:56:20,655 DEBUG : operating with platform_type : mac_ 10:56:20 INFO - 2015-11-15 10:56:20,656 INFO : Initialising browser for dromaeo_css test... 10:56:20 INFO - 2015-11-15 10:56:20,696 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpQLQAxO/profile http://localhost:49584/getInfo.html 10:56:24 INFO - 2015-11-15 10:56:24,633 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:56:24 INFO - 2015-11-15 10:56:24,633 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:56:24 INFO - 2015-11-15 10:56:24,634 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:56:24 INFO - 2015-11-15 10:56:24,634 DEBUG : BROWSER_OUTPUT: __metrics 10:56:24 INFO - 2015-11-15 10:56:24,654 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:56:25 INFO - 2015-11-15 10:56:25,495 INFO : Browser initialized. 10:56:25 INFO - 2015-11-15 10:56:25,495 INFO : Running cycle 1/1 for dromaeo_css test... 10:56:25 INFO - 2015-11-15 10:56:25,495 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpQLQAxO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:56:37 INFO - 2015-11-15 10:56:37,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 229715968 10:56:37 INFO - 2015-11-15 10:56:37,943 DEBUG : BROWSER_OUTPUT: 10:57:28 INFO - 2015-11-15 10:57:28,931 DEBUG : BROWSER_OUTPUT: 1447613848926 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:59:40 INFO - 2015-11-15 10:59:40,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49584/tests/dromaeo/cssquery-ext.html) 10:59:41 INFO - 2015-11-15 10:59:41,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 327974912 10:59:41 INFO - 2015-11-15 10:59:41,375 DEBUG : BROWSER_OUTPUT: 11:02:44 INFO - 2015-11-15 11:02:44,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/dromaeo/cssquery-ext.html (next: http://localhost:49584/tests/dromaeo/cssquery-jquery.html) 11:02:45 INFO - 2015-11-15 11:02:45,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 356585472 11:02:45 INFO - 2015-11-15 11:02:45,084 DEBUG : BROWSER_OUTPUT: 11:05:47 INFO - 2015-11-15 11:05:47,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49584/tests/dromaeo/cssquery-mootools.html) 11:05:48 INFO - 2015-11-15 11:05:48,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 328364032 11:05:48 INFO - 2015-11-15 11:05:48,133 DEBUG : BROWSER_OUTPUT: 11:08:50 INFO - 2015-11-15 11:08:50,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49584/tests/dromaeo/cssquery-prototype.html) 11:08:51 INFO - 2015-11-15 11:08:51,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 315916288 11:08:51 INFO - 2015-11-15 11:08:51,043 DEBUG : BROWSER_OUTPUT: 11:11:54 INFO - 2015-11-15 11:11:54,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49584/tests/dromaeo/cssquery-yui.html) 11:11:55 INFO - 2015-11-15 11:11:55,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 320540672 11:11:55 INFO - 2015-11-15 11:11:55,017 DEBUG : BROWSER_OUTPUT: 11:14:57 INFO - 2015-11-15 11:14:57,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/dromaeo/cssquery-yui.html (next: http://localhost:49584/tests/dromaeo/cssquery-dojo.html) 11:14:58 INFO - 2015-11-15 11:14:58,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 366952448 11:14:58 INFO - 2015-11-15 11:14:58,184 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,184 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:14:58 INFO - 2015-11-15 11:14:58,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:14:58 INFO - 2015-11-15 11:14:58,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:14:58 INFO - 2015-11-15 11:14:58,184 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:14:58 INFO - 2015-11-15 11:14:58,186 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2386.200622791365;2387.450886296152;2390.653355263488;2497.7127630322507;2542.8474291542507;3968.365061590146;4017.718759686823;4064.5122585289732;4087.6116768906945;4192.727472714271;3999.2601368746728;4083.203775263825;4143.585641435855;4157.9584204157945;4175.248455278056;3691.8154092295413;3728.552573691161;3823.751456155355;3841.9423708644254;3849.018500282424;3777.848886044555;3858;3887.7667339959553;3907.0427745202464;3934.2721596504593;3606.549181352344;3684.299983003221;3700.8149592520267;3751.0809851586264;3869.941950870739;3749.512563366772;3808.2383523295453;3867.748596341257;3888.9611103888883;3906.785126818024;3803.9619603804163;3809.9809500952597;3836.3861782114727;3896.1428485733095;3902.2780785554764;3951.5060617422823;3997.300472417315;4183.477065366829;4241.957580424187;4258.382534532476;4336.913261734748;4361.563843615645;4438.045820148651;4498.8875278117985;4500.347449619787;4432.556744325541;4470.41884555009;4493.955060449386;4551.385562948993;4554.977225113887;3884.3784994401044;3922.7254092213843;4125.958740412558;4161.271777438936;4191.538930717618;4353.82584696615;4574.222382195035;4620;4627.907441851212;4649;4230.132822771325;4284.507281662586;4312.892177695583;4427.247367947457;4445;4253.680973926967;4349.652027837828;4384.188925048876;4510.143072816154;4569.063342014945;4212.957870421318;4326.459192600925;4417.160739459492;4443.111377724404;4468.910621787546;4237.512686041145;4260.637845783143;4310.80601372939;4457.531959144308;4490.663200259994;3176.8093914365213;3206.7755257132244;3250.1874531367157;3294.5552350432863;3359.3449277391164;2983.3138378173144;3049.7407720343576;3057.92355191122;3058.663547009827;3120.1575574595186;4001.579834117376;4008.4788977432745;4028.133951200506;4180.561041090703;4187.371894215892;4327;4341.044970106572;4368.5194628590825;4449.1101779644205;4505.391772110723;3927.057506198492;3983.462232598562;4037.8990525237105;4135.958640413617;4165.021220013295;3802.068493219179;3823.407371857311;3849.345611246095;3880.689544836406;3882.514685664292;4355.956440435555;4488.730676159441;4512.842050528216;4539.636829053734;4573.268277075652;4236.110416812504;4328.848490302824;4382.539833317455;4420.403245561936;4431.601155895984;4423.049044455457;4423.380726698329;4492.752898590478;4600.723956562617;4692.41344831896;4234.428352172417;4281.250781113355;4301.892452688708;4308.633766129914;4383.320585309282;4344.8044837983;4393.121375724932;4394.077243778842;4516.774161291988;4517.661175411923;4188.287991041591;4213.936800886527;4246;4345.717528360773;4401.361802538678;4203.6847236458;4226.36604509326;4292.699511034198;4352.6735494837385;4373.037931655031;4010.438538604539;4148.419221308959;4151.543330233611;4196.9370459442525;4242.469691288589;4303.720258183208;4325.740455572675;4331.112122014916;4394.758288294174;4430.091831174666;3982.8008599570485;4060.5736397679;4112.09533902541;4258.190943720683;4359.128174365203 11:14:58 INFO - 2015-11-15 11:14:58,189 DEBUG : BROWSER_OUTPUT: |1;ext.html;422.12409250804586;424.07339962182635;427.47847625896395;427.84383699949524;448.12615399970065;22754.88622556887;24501.509969800594;29458.116256512338;29526.852365738167;30322.69677303232;31346.373072538594;31590.842045789796;32125.51811722826;32586.511202331923;32660.836695816546;6369.36306369364;6967.268436814137;7013.789586312419;7060;7251.456140789435;6184.350643182469;6232.7506899724185;8236.299914507274;8403.95798021009;8794.51630160341;8306;8313.210245026712;8413.411061225717;8421.957890210571;8439.95780021099;6299.779507717208;6490.870182596369;8149.388795840306;8306.916930830705;8404.495730256203;6241.063840423927;8197.303229225523;8436.873446898302;8525.403221774479;8604.311655067642;28728.42543149146;29362.265943351373;29563;29756.55365169524;30151.849240753876;2138.9465263368384;2347.636116401943;2350.82368822339;2463.2979600813683;2486.9803380614044;20782.168713251453;20793.064312105842;20838;20928.686069708965;21145.3656390307;1782.117851663422;1785.8392744652913;1813.4559632110313;1832.569346203641;1907.2085084689836;206332;206470;211600;213328;213715;38974.61025389766;41395.58604413917;41721.374179387334;43483.78258108752;43819;38068.238635227695;45310.32034519485;45623.77188114038;47203.5279647206;47602;10365.429901355497;10734.946325268324;10793;10799.83800242997;10800.729981750519;8018.198180181935;8045.15525869787;8088.83822323562;8174.264316211569;8338;13697.383617737225;13799.89600831931;14073.437062517385;14115.647108822362;14140.434382624786;6305.464035557029;6437.613743175424;6482.740690372427;6563.573367731177;6583.30875258091;762.3862790453738;786.288408989865;795.2524626850742;808.2846680687517;822.0956947357859;21127;21145.25991590287;21155.471113221985;21178.78821211768;22066.558668826532;797.9321757650548;810.5541951926534;839.8362319347791;880.700561808988;907.9785241603197;11041.889581104248;11101.278416902875;11232.49453774582;11261.887381126247;11395.487203075882;335958;343984;348472;349168;349813;37711.62288377081;38248;39451.21097578033;39576.60423395729;39580.20839583192;977.6040703515088;1026.2610920137488;1035.2287545778443;1037.699067270483;1046.2205656785743;20609.79390206079;20802.79197208069;21148.47128821792;21373.89313053425;21655.242066527597;36912.44631330478;36955.44566831554;37295.81352093222;37334.439983400815;38384.616153838106;170008;223284;224256;224677;226811;29721.10836674903;31819.681803181673;32500.83749581237;33012.50481242735;33101.33797323992;33217.33565328632;34648.13379665528;35687;36133.27733445369;36622.8168859154;26693.733062669126;28508.57237141486;28593.571096433156;29017;30089;28874.27814304659;28918.7108128916;29541.704582953895;29857.25356866096;29954.850225749604;29304.560431593116;29543.704562954954;29673.406531869674;30122;30130;25158.24525264245;25237.495250095264;25778.226653199683;27022.72977270281;28111.578326324714;18782.624347513247;19280.903595481934;19332.4200273992;19394.849657340175;19483 11:14:58 INFO - 2015-11-15 11:14:58,190 DEBUG : BROWSER_OUTPUT: |2;jquery.html;252.59332474715694;258.65211290813863;259.74415201026983;262.6362487954183;263.2996230028125;10801.891981080187;11246.662600121988;13315.933420332909;13687.931560342196;13925.512607058756;9600.903990960089;11402.828957565622;13363.33183340834;13519.256440895746;13712.040157188976;3102.224443889028;3306.966930330702;3361.697447229749;3400.996705971732;3406.9659303406897;2608.47830433914;2669.3059804450886;3234.56333394991;3279.6884295991845;3381.306832099414;2703.229579569823;3492.231709024011;3629.8185090745355;3719.8698045568412;3748.2878253131817;3530.7351948603828;3606.242689035306;3679.5768486623847;3694.7598406103516;3728.7949162796035;3042.3306872488015;3071.8617662205256;3084.8611812468266;3094.4275309067893;3173.650898401174;9619;9918.107370336704;10070.1440377568;10141.2394070445;10347.5343609537;1455.9563213103518;1487.6504021555033;1548.8296287408375;1584.9683006339924;1588.3487770014353;7010.92989070113;7201.315874991919;7322.853542929165;7550.131734850507;7574.35617972473;1142.034980441534;1190.0717440396504;1194.1044216837372;1221.3343727668441;1224.5346768228105;42934.785326073485;45233;45301;45447.99999999967;46141.30788038182;4790.520947905182;4916.803327866845;4948.851534453972;4999.550040496373;5138.100832354397;5601.719914004283;5658.321001479767;5667.319921609351;5897.823065308047;5912.46787789101;3758.511393518825;3930.21395720857;3935.704822138351;3994.800259986989;4005.5393629732953;3992.2414741199077;4000.439938408625;4010.9598904010586;4127.071408932966;4221.451211342567;2214.3246309875644;2230.609643312414;2240.193530329113;2261.197274967396;2307.746147923727;774.082711986298;777.1684297801298;787.6494959742975;792.0772300270236;856.6145234644434;290.7499550386666;317.3446832291311;322.5033448489347;324.9658785827501;325.0395082531115;8153.836923261501;8813.206811387006;8813.735587932373;9116.1339672731;9127.315451341176;337.67077099827964;339.20287324786557;344.38011579157416;347.2256867186139;353.4274475349898;3767.679747221462;4759.738214398241;4862.222044472867;4869.22092465211;4914.385701787277;410682;416494;421293;426266;429181;35405;49102.26346604804;49294.50705492899;52080;52466.990965948426;353.9557555305587;365.2949806872761;369.69130775802506;369.87054530914503;382.39963257685724;7856.25365590268;8186.83626327482;8339.683725563442;8372.204640559137;8673;25027.499450011263;25501.61747573825;26368.472630546898;26783.732162678123;27202;35101.47347789734;35655.28689426249;36026.8198659005;36109;36396.090097747765;4470.731756094645;4664.720116792868;4694.812207511662;4710.788014539423;4763.7856296467435;8244.175582441709;8809.163129502687;8863.645454182019;8864.429315498433;8904.332175086765;7588.241175882367;7594.6202689866395;7686.46194766361;7700.460967732205;7712.113106992768;7184.748533801292;7365.889511657437;7390.96304518474;7411.444141689502;7771.269790500478;7570.621468926642;7670.578118203553;7843.176466470938;7853.882191767242;7924.762257132295;4541.205289074464;4567.109413664303;4626.306054091779;4740.525947405232;4808.2547205183255;7575.886361704469;7624.161342252459;7683.9231607683205;7745.148033716399;7996.760097197093 11:14:58 INFO - 2015-11-15 11:14:58,194 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1018.8522664213684;1045.6862941117665;1061.739873730936;1078.8921107889212;1190.3036723516743;5154.201098829682;5606.579506537011;5751.827445176641;5758.5393168546525;5870.26621672291;5889;5955.821325360246;5962.6124301920345;6041.426064523875;6081.331053584113;1706.709859323918;1734.9739753903702;1736.1145815634022;1776.0498133498581;1779.074881061847;1694.5509439998348;1700.6768713944373;1721.8278172182745;1765.9757340742403;1766.7703198584165;1719.3294615100122;1734.9132543372843;1743.2068408873931;1749.3527394863918;1749.4664127441126;1629.7310943694276;1654.0075954427248;1675.748637704354;1693.9830601693948;1717.8110407855127;1691.4080071974834;1706.7695861058721;1713.374618264337;1773.2463702926204;1785.1342099081935;5298.470152984709;5885.470307672287;5940.108983652443;5942.673152976585;5981.790637327673;3340.0313908966373;3440.088376580208;3664.798436086014;3749.2314075614436;3761.849526018956;2200.9559808803892;2274.1699279762765;2305.4351683837567;2387.307680772591;2407.2056221447056;735.1949615171433;745.3738859358111;751.143696186348;762.9351505122071;765.1697907770076;7804.180561041123;7954.7613571592365;8004.319632831216;8042.839143217161;8133.59332033396;3317.6848199421015;3422.760406771502;3523.0487768302414;3629;3663.249033948034;7106.502544821917;7112.893306600405;7119.857602847914;7199.928000719926;7221.061262035902;3811.790351530637;3885.4171874218528;3925.685945124383;4004.099077707551;4020.7386519876113;3439.5012723155;3467.7919324840086;3495.3358861816682;3598.9100272493397;3647.544056992876;2795.4409118176445;2802.467531169071;2802.9299267518068;2807.185916084313;2837.233946834343;905.8233644439402;913.9497327647043;921.1847514949318;931.0735817861272;941.7786820097272;939.3800091939287;1001.3090967232587;1002.4937406609761;1036.7200855769051;1060.5386656804314;5425.26758887553;5527.751251193706;5598.804041858515;5695.373508914016;5716.542676585863;371.7100661484047;372.32794805376017;376.38649002126357;382.80094350937355;383.9692824574083;4343.478782546114;4349.608535231781;4466.798994045211;4507.706999045052;4566.13243483737;6685.465162786965;6785.5250132490255;6882.829918913697;7033.507654464139;7146.32109949554;7017.087778588751;7046.1192350956135;7304.5252058616015;7344.742933997284;7348.522346047596;5577.888442231133;5595.524380427709;5659.122835960433;5681.806820567727;5795.9420405796245;5275.155975044128;5507.779688812403;5515.365732940763;5642.887142257214;5690.687012214368;5938.2280303560265;6200.7519699213335;6254.093156492192;6377.74489020434;6514.51141164424;5806.854828629318;6450.516211284266;6628.469722422098;6750.86498270022;6778.932210678027;5341.813036543857;5364.088105022078;5398.136298192428;5423.728813559227;5454.972725136349;5745.683987380734;5778.075507918713;5809.680467574324;5863.20846685692;5946.821595352147;5308.840734777963;5338.599605029561;5403.918941215964;5527.391986881359;5572.888542229214;4826.565609095198;5175.715335656575;5404.702741349263;5507.449255074621;5516.172574113915;5262.710550919736;5322;5382.058139825436;5430.104032834696;5520.420355862737;4812.109759694467;4866.391701037371;5023.246513023076;5031.094403007493;5074.873128171826;4866.124097662313;4940.777665005012;5030.396352437585;5035.4712755161645;5134.306868572844 11:14:58 INFO - 2015-11-15 11:14:58,197 DEBUG : BROWSER_OUTPUT: |4;prototype.html;218.1090246343685;227.66192204576203;229.10192047175073;230.4262386657224;239.2559141071268;4627.143978364005;4634.58288754012;4748.76256187191;4824.469308376076;4872.147374209512;4643.117807616551;4676.39206903103;4708.176069187895;4784.521547845214;4807.663463557552;3349.531065650811;3489.842957066938;3501.369753444379;3607.855685772579;3611.8916432506935;3474.5656792900886;3502.807345595991;3622.6739593436587;3663.2307215484648;3669.119411341272;3370.359631669975;3492.1618811485187;3510.3856825055514;3556.92886142277;3556.982215088934;3395.558577384949;3449.9827500862584;3489.249811290559;3538.646135386454;3602.873899413508;2901.10065879578;2946.7347938685407;3100.1629560018896;3100.5194194899827;3101.5347697845277;4416.757078360689;4517.954820451819;4633.351330813689;4648.3259927310355;4717.646176536773;3870.7290489665734;3904.9804750976064;4015.7791321477307;4020.135670830756;4027;4842.685225460334;4917.901641967176;4951.950480495185;4983.501649835024;5074.13739664258;3203.9679603203904;3208.903732888017;3219.613646362428;3303.80297102429;3372.6627337266077;5079.111155547801;5147.7607240849975;5149.150390185652;5217.243499692523;5226.5818734501145;3248.6588908164777;3256.8697252110123;3383.086566626997;3408.8466019028706;3428.5542879425516;3314.5691060162026;3318.854995026712;3340.6158291796755;3491.581010278732;3502.842372093262;3958.2281455116554;3979.9403008954887;3989.940150897739;4022.818973146157;4047.655949244347;4934.235193545006;4960.131976904099;4972.627052971042;4983.202687569971;5036.093503169464;1149.6263714292888;1162.8255761635821;1169.0881112731913;1220.383706228349;1224.0391292835081;747.7495039161832;763.564768082199;768.1972338905857;781.7224885165798;784.9097353804272;4652.046330502307;4701.623870090384;4743.288506724019;4766.618670506351;4824.155772739827;5074.3657042869645;5074.441811400743;5095.490450954949;5194.584433245332;5226.555742761831;4648.65135114861;4655.185342565038;4853.466118726938;4861.392325959255;4882.389701287339;2660.9467810644064;2692.9326766830986;2747.8076534642382;2784.359597292634;2806.7052959439375;5199.532042116228;5224.138017227115;5225.425203227642;5293.126634105406;5346.518813306821;5162.6128040397125;5209.619450845529;5326.866828329323;5338.065838478328;5378.946210537844;5036.521530454601;5227.790888364423;5276.65701729394;5298.417174110845;5390.137577987503;5057.848264552069;5218.843434696965;5282.97358513205;5292.470752924831;5317.1226747586215;5014.52362025607;5015.598752099896;5122;5196.4283928767045;5218.634695571273;5132.615053871049;5260.605454590845;5373.086575282289;5385.892282154413;5417.6478528895495;3329.8002119871917;3367.7642565020215;3383.6108847482856;3385.644507326695;3434.10713214561;5088.084144853814;5132.358455193101;5167.689938603696;5232;5310.309659744208;4943.555080042814;4949.925751113664;5037.874053148701;5110.463401342954;5161.587073034223;4878.438979517401;4936.8765780855765;4997.525235102659;5119.564836988898;5150.562202212854;4836.975815121043;4856.417229932431;4965.006998600222;5036.370453693288;5037.748112594429;4951.672713824641;5019.774110164978;5024.095662780588;5113.8977220454635;5141.0232055909255;4800.207965685623;4810.975945120252;4873.244647079709;5036.06832735945;5048.444671086104 11:14:58 INFO - 2015-11-15 11:14:58,198 DEBUG : BROWSER_OUTPUT: |5;yui.html;513.3659929986463;518.9818356357525;554.7669978608984;566.3119310038304;605.0863196573174;9353.906460935388;9355.578998945046;9440.291978101635;9696.515174241285;9754.122129008389;9571.617135314596;9673.564689588968;9923.404595724262;9929.453880036595;10162.39025658461;672.4015626092769;677.9186497620292;689.524228282486;697.4490152779298;714.9428045756327;667.8230268978724;673;693.836948317145;694.0456871801273;695.3151146121066;678.4843518925627;706.7597017014214;719.3202423709597;720.8702433561957;728.9963550182268;698.8218004408868;701.5790525684599;705.9364657180853;706.9505134640577;724.3770357492579;520.6017396691534;521.1999580643694;526.3157894736827;533.722464318556;540.5270388410141;9508.952455237748;9586.66446674363;9674.371165874196;9712.02879712023;9827.754306142333;7453.739119130859;7511.887321690179;7716.611010018194;8104.878426823543;8287.792805179859;6901.482388820858;7270;7460.328570428687;7464.925350746477;7708.537487750753;2194.626913424722;2242.5178586603797;2339.298210536849;2339.941501462477;2381.9995601847268;30383.93656222044;30735;31017.689823101708;34074.829625851715;35893.282134357425;4785.665003449794;5103.97448012765;5225.6603320784025;5331.626786124934;5409.918851217235;9068.8639670405;9145.90854091464;9159.450432974043;9390.483523406278;9503.144716975505;4565.863024109282;4567.177907976529;4860.684055536379;4957.132501812169;4991.051700176955;2748.4228312054693;2820.9858950705116;2864.8281103133463;2870.282429392652;2973.3458639099363;2032.6849338352579;2067.855250132506;2088.102116090096;2158.330917415606;2160.4382860456394;302.45859910759935;307.1905528931282;309.3796937141018;309.6516419028593;324.3512974051896;359.73199966025476;361.9692326152254;395.72892568590606;415.23596582288735;478.5573344656179;5812.360640329561;6094.728060227871;6120;6182.412670796267;6243.500519958392;417.74526448125937;440.6474820143872;449.3304975586418;464.6561544457077;472.1053603421497;2668.59971004347;2754.0911499205213;2778.6804517480346;2809.9438011240068;2824.4209936962875;43790.34314485285;45715.54284457179;45768.313475297895;45829.54170458319;46037.7698111514;38465;38625.22749544994;38814.80592597075;38846.223075538896;38943.805280973414;31572.526412103838;32047.35905281928;32912;35264.471032934525;36288.4556731644;6165.167702360124;6337.2395312562785;6449.322821103717;6495.805125846232;6621.768238111643;26088.478230435663;27137.59293610558;27306.726932730417;27470.313242169104;27505.587416189173;31359.84320078385;35182.47226291659;35496;36238.8188059058;37132.814335928146;5359.276497672764;5526.50261476469;5615.129654903497;5675.8864822704145;5851.297844258716;8508.659653614033;8538.701145460127;8595.226429621363;8693.261072808882;8799.604017819342;7969.402294827795;8104.716334928249;8167.959160204161;8366.748997530083;8390.202930721573;7732.342750866239;7970.0374531835205;8224.83550329002;8241.79395515117;8692.217700406994;7971.362291016821;8053;8211.71259005932;8247.298979586802;8389.161083891562;6705.262421133574;6826.385625293748;6871.793846184622;7059.6558355503985;7305.926940730525;6115.449609535163;6456.806295811133;6518.087467754423;7171.605561694157;7238.8914166288605 11:14:58 INFO - 2015-11-15 11:14:58,199 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:14:58 INFO - 2015-11-15 11:14:58,199 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:14:58 INFO - 2015-11-15 11:14:58,199 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1035 11:14:58 INFO - 2015-11-15 11:14:58,199 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:14:58 INFO - 2015-11-15 11:14:58,200 DEBUG : BROWSER_OUTPUT: __startTimestamp1447614898181__endTimestamp 11:14:58 INFO - 2015-11-15 11:14:58,200 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,200 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:14:58 INFO - 2015-11-15 11:14:58,200 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:14:58 INFO - 2015-11-15 11:14:58,200 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,200 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4087.42 Median:4212.96 stddev:456.07 (10.8%) stddev-sans-first:437.51 11:14:58 INFO - 2015-11-15 11:14:58,202 DEBUG : BROWSER_OUTPUT: Values: 2386.2 2387.5 2390.7 2497.7 2542.8 3968.4 4017.7 4064.5 4087.6 4192.7 3999.3 4083.2 4143.6 4158.0 4175.2 3691.8 3728.6 3823.8 3841.9 3849.0 3777.8 3858.0 3887.8 3907.0 3934.3 3606.5 3684.3 3700.8 3751.1 3869.9 3749.5 3808.2 3867.7 3889.0 3906.8 3804.0 3810.0 3836.4 3896.1 3902.3 3951.5 3997.3 4183.5 4242.0 4258.4 4336.9 4361.6 4438.0 4498.9 4500.3 4432.6 4470.4 4494.0 4551.4 4555.0 3884.4 3922.7 4126.0 4161.3 4191.5 4353.8 4574.2 4620.0 4627.9 4649.0 4230.1 4284.5 4312.9 4427.2 4445.0 4253.7 4349.7 4384.2 4510.1 4569.1 4213.0 4326.5 4417.2 4443.1 4468.9 4237.5 4260.6 4310.8 4457.5 4490.7 3176.8 3206.8 3250.2 3294.6 3359.3 2983.3 3049.7 3057.9 3058.7 3120.2 4001.6 4008.5 4028.1 4180.6 4187.4 4327.0 4341.0 4368.5 4449.1 4505.4 3927.1 3983.5 4037.9 4136.0 4165.0 3802.1 3823.4 3849.3 3880.7 3882.5 4356.0 4488.7 4512.8 4539.6 4573.3 4236.1 4328.8 4382.5 4420.4 4431.6 4423.0 4423.4 4492.8 4600.7 4692.4 4234.4 4281.3 4301.9 4308.6 4383.3 4344.8 4393.1 4394.1 4516.8 4517.7 4188.3 4213.9 4246.0 4345.7 4401.4 4203.7 4226.4 4292.7 4352.7 4373.0 4010.4 4148.4 4151.5 4196.9 4242.5 4303.7 4325.7 4331.1 4394.8 4430.1 3982.8 4060.6 4112.1 4258.2 4359.1 11:14:58 INFO - 2015-11-15 11:14:58,202 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,202 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38374.62 Median:31468.61 stddev:69762.30 (221.7%) stddev-sans-first:69899.81 11:14:58 INFO - 2015-11-15 11:14:58,204 DEBUG : BROWSER_OUTPUT: Values: 422.1 424.1 427.5 427.8 448.1 22754.9 24501.5 29458.1 29526.9 30322.7 31346.4 31590.8 32125.5 32586.5 32660.8 6369.4 6967.3 7013.8 7060.0 7251.5 6184.4 6232.8 8236.3 8404.0 8794.5 8306.0 8313.2 8413.4 8422.0 8440.0 6299.8 6490.9 8149.4 8306.9 8404.5 6241.1 8197.3 8436.9 8525.4 8604.3 28728.4 29362.3 29563.0 29756.6 30151.8 2138.9 2347.6 2350.8 2463.3 2487.0 20782.2 20793.1 20838.0 20928.7 21145.4 1782.1 1785.8 1813.5 1832.6 1907.2 206332.0 206470.0 211600.0 213328.0 213715.0 38974.6 41395.6 41721.4 43483.8 43819.0 38068.2 45310.3 45623.8 47203.5 47602.0 10365.4 10734.9 10793.0 10799.8 10800.7 8018.2 8045.2 8088.8 8174.3 8338.0 13697.4 13799.9 14073.4 14115.6 14140.4 6305.5 6437.6 6482.7 6563.6 6583.3 762.4 786.3 795.3 808.3 822.1 21127.0 21145.3 21155.5 21178.8 22066.6 797.9 810.6 839.8 880.7 908.0 11041.9 11101.3 11232.5 11261.9 11395.5 335958.0 343984.0 348472.0 349168.0 349813.0 37711.6 38248.0 39451.2 39576.6 39580.2 977.6 1026.3 1035.2 1037.7 1046.2 20609.8 20802.8 21148.5 21373.9 21655.2 36912.4 36955.4 37295.8 37334.4 38384.6 170008.0 223284.0 224256.0 224677.0 226811.0 29721.1 31819.7 32500.8 33012.5 33101.3 33217.3 34648.1 35687.0 36133.3 36622.8 26693.7 28508.6 28593.6 29017.0 30089.0 28874.3 28918.7 29541.7 29857.3 29954.9 29304.6 29543.7 29673.4 30122.0 30130.0 25158.2 25237.5 25778.2 27022.7 28111.6 18782.6 19280.9 19332.4 19394.8 19483.0 11:14:58 INFO - 2015-11-15 11:14:58,204 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,205 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20290.02 Median:4008.25 stddev:68857.12 (1717.9%) stddev-sans-first:69033.85 11:14:58 INFO - 2015-11-15 11:14:58,206 DEBUG : BROWSER_OUTPUT: Values: 252.6 258.7 259.7 262.6 263.3 10801.9 11246.7 13315.9 13687.9 13925.5 9600.9 11402.8 13363.3 13519.3 13712.0 3102.2 3307.0 3361.7 3401.0 3407.0 2608.5 2669.3 3234.6 3279.7 3381.3 2703.2 3492.2 3629.8 3719.9 3748.3 3530.7 3606.2 3679.6 3694.8 3728.8 3042.3 3071.9 3084.9 3094.4 3173.7 9619.0 9918.1 10070.1 10141.2 10347.5 1456.0 1487.7 1548.8 1585.0 1588.3 7010.9 7201.3 7322.9 7550.1 7574.4 1142.0 1190.1 1194.1 1221.3 1224.5 42934.8 45233.0 45301.0 45448.0 46141.3 4790.5 4916.8 4948.9 4999.6 5138.1 5601.7 5658.3 5667.3 5897.8 5912.5 3758.5 3930.2 3935.7 3994.8 4005.5 3992.2 4000.4 4011.0 4127.1 4221.5 2214.3 2230.6 2240.2 2261.2 2307.7 774.1 777.2 787.6 792.1 856.6 290.7 317.3 322.5 325.0 325.0 8153.8 8813.2 8813.7 9116.1 9127.3 337.7 339.2 344.4 347.2 353.4 3767.7 4759.7 4862.2 4869.2 4914.4 410682.0 416494.0 421293.0 426266.0 429181.0 35405.0 49102.3 49294.5 52080.0 52467.0 354.0 365.3 369.7 369.9 382.4 7856.3 8186.8 8339.7 8372.2 8673.0 25027.5 25501.6 26368.5 26783.7 27202.0 35101.5 35655.3 36026.8 36109.0 36396.1 4470.7 4664.7 4694.8 4710.8 4763.8 8244.2 8809.2 8863.6 8864.4 8904.3 7588.2 7594.6 7686.5 7700.5 7712.1 7184.7 7365.9 7391.0 7411.4 7771.3 7570.6 7670.6 7843.2 7853.9 7924.8 4541.2 4567.1 4626.3 4740.5 4808.3 7575.9 7624.2 7683.9 7745.1 7996.8 11:14:58 INFO - 2015-11-15 11:14:58,206 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,206 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4177.45 Median:5315.42 stddev:2161.52 (40.7%) stddev-sans-first:2154.54 11:14:58 INFO - 2015-11-15 11:14:58,208 DEBUG : BROWSER_OUTPUT: Values: 1018.9 1045.7 1061.7 1078.9 1190.3 5154.2 5606.6 5751.8 5758.5 5870.3 5889.0 5955.8 5962.6 6041.4 6081.3 1706.7 1735.0 1736.1 1776.0 1779.1 1694.6 1700.7 1721.8 1766.0 1766.8 1719.3 1734.9 1743.2 1749.4 1749.5 1629.7 1654.0 1675.7 1694.0 1717.8 1691.4 1706.8 1713.4 1773.2 1785.1 5298.5 5885.5 5940.1 5942.7 5981.8 3340.0 3440.1 3664.8 3749.2 3761.8 2201.0 2274.2 2305.4 2387.3 2407.2 735.2 745.4 751.1 762.9 765.2 7804.2 7954.8 8004.3 8042.8 8133.6 3317.7 3422.8 3523.0 3629.0 3663.2 7106.5 7112.9 7119.9 7199.9 7221.1 3811.8 3885.4 3925.7 4004.1 4020.7 3439.5 3467.8 3495.3 3598.9 3647.5 2795.4 2802.5 2802.9 2807.2 2837.2 905.8 913.9 921.2 931.1 941.8 939.4 1001.3 1002.5 1036.7 1060.5 5425.3 5527.8 5598.8 5695.4 5716.5 371.7 372.3 376.4 382.8 384.0 4343.5 4349.6 4466.8 4507.7 4566.1 6685.5 6785.5 6882.8 7033.5 7146.3 7017.1 7046.1 7304.5 7344.7 7348.5 5577.9 5595.5 5659.1 5681.8 5795.9 5275.2 5507.8 5515.4 5642.9 5690.7 5938.2 6200.8 6254.1 6377.7 6514.5 5806.9 6450.5 6628.5 6750.9 6778.9 5341.8 5364.1 5398.1 5423.7 5455.0 5745.7 5778.1 5809.7 5863.2 5946.8 5308.8 5338.6 5403.9 5527.4 5572.9 4826.6 5175.7 5404.7 5507.4 5516.2 5262.7 5322.0 5382.1 5430.1 5520.4 4812.1 4866.4 5023.2 5031.1 5074.9 4866.1 4940.8 5030.4 5035.5 5134.3 11:14:58 INFO - 2015-11-15 11:14:58,208 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,208 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4133.10 Median:4817.57 stddev:1294.97 (26.9%) stddev-sans-first:1264.82 11:14:58 INFO - 2015-11-15 11:14:58,208 DEBUG : BROWSER_OUTPUT: Values: 218.1 227.7 229.1 230.4 239.3 4627.1 4634.6 4748.8 4824.5 4872.1 4643.1 4676.4 4708.2 4784.5 4807.7 3349.5 3489.8 3501.4 3607.9 3611.9 3474.6 3502.8 3622.7 3663.2 3669.1 3370.4 3492.2 3510.4 3556.9 3557.0 3395.6 3450.0 3489.2 3538.6 3602.9 2901.1 2946.7 3100.2 3100.5 3101.5 4416.8 4518.0 4633.4 4648.3 4717.6 3870.7 3905.0 4015.8 4020.1 4027.0 4842.7 4917.9 4952.0 4983.5 5074.1 3204.0 3208.9 3219.6 3303.8 3372.7 5079.1 5147.8 5149.2 5217.2 5226.6 3248.7 3256.9 3383.1 3408.8 3428.6 3314.6 3318.9 3340.6 3491.6 3502.8 3958.2 3979.9 3989.9 4022.8 4047.7 4934.2 4960.1 4972.6 4983.2 5036.1 1149.6 1162.8 1169.1 1220.4 1224.0 747.7 763.6 768.2 781.7 784.9 4652.0 4701.6 4743.3 4766.6 4824.2 5074.4 5074.4 5095.5 5194.6 5226.6 4648.7 4655.2 4853.5 4861.4 4882.4 2660.9 2692.9 2747.8 2784.4 2806.7 5199.5 5224.1 5225.4 5293.1 5346.5 5162.6 5209.6 5326.9 5338.1 5378.9 5036.5 5227.8 5276.7 5298.4 5390.1 5057.8 5218.8 5283.0 5292.5 5317.1 5014.5 5015.6 5122.0 5196.4 5218.6 5132.6 5260.6 5373.1 5385.9 5417.6 3329.8 3367.8 3383.6 3385.6 3434.1 5088.1 5132.4 5167.7 5232.0 5310.3 4943.6 4949.9 5037.9 5110.5 5161.6 4878.4 4936.9 4997.5 5119.6 5150.6 4837.0 4856.4 4965.0 5036.4 5037.7 4951.7 5019.8 5024.1 5113.9 5141.0 4800.2 4811.0 4873.2 5036.1 5048.4 11:14:58 INFO - 2015-11-15 11:14:58,209 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,210 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:9883.60 Median:3228.19 stddev:12105.72 (375.0%) stddev-sans-first:12119.23 11:14:58 INFO - 2015-11-15 11:14:58,210 DEBUG : BROWSER_OUTPUT: Values: 513.4 519.0 554.8 566.3 605.1 9353.9 9355.6 9440.3 9696.5 9754.1 9571.6 9673.6 9923.4 9929.5 10162.4 672.4 677.9 689.5 697.4 714.9 667.8 673.0 693.8 694.0 695.3 678.5 706.8 719.3 720.9 729.0 698.8 701.6 705.9 707.0 724.4 520.6 521.2 526.3 533.7 540.5 9509.0 9586.7 9674.4 9712.0 9827.8 7453.7 7511.9 7716.6 8104.9 8287.8 6901.5 7270.0 7460.3 7464.9 7708.5 2194.6 2242.5 2339.3 2339.9 2382.0 30383.9 30735.0 31017.7 34074.8 35893.3 4785.7 5104.0 5225.7 5331.6 5409.9 9068.9 9145.9 9159.5 9390.5 9503.1 4565.9 4567.2 4860.7 4957.1 4991.1 2748.4 2821.0 2864.8 2870.3 2973.3 2032.7 2067.9 2088.1 2158.3 2160.4 302.5 307.2 309.4 309.7 324.4 359.7 362.0 395.7 415.2 478.6 5812.4 6094.7 6120.0 6182.4 6243.5 417.7 440.6 449.3 464.7 472.1 2668.6 2754.1 2778.7 2809.9 2824.4 43790.3 45715.5 45768.3 45829.5 46037.8 38465.0 38625.2 38814.8 38846.2 38943.8 31572.5 32047.4 32912.0 35264.5 36288.5 6165.2 6337.2 6449.3 6495.8 6621.8 26088.5 27137.6 27306.7 27470.3 27505.6 31359.8 35182.5 35496.0 36238.8 37132.8 5359.3 5526.5 5615.1 5675.9 5851.3 8508.7 8538.7 8595.2 8693.3 8799.6 7969.4 8104.7 8168.0 8366.7 8390.2 7732.3 7970.0 8224.8 8241.8 8692.2 7971.4 8053.0 8211.7 8247.3 8389.2 6705.3 6826.4 6871.8 7059.7 7305.9 6115.4 6456.8 6518.1 7171.6 7238.9 11:14:58 INFO - 2015-11-15 11:14:58,211 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:14:58 INFO - 2015-11-15 11:14:58,212 DEBUG : BROWSER_OUTPUT: 11:14:58 INFO - 2015-11-15 11:14:58,724 INFO : Browser exited with error code: 0 11:14:58 INFO - 2015-11-15 11:14:58,760 INFO : Completed test dromaeo_css (00:18:38) 11:14:58 INFO - 2015-11-15 11:14:58,760 INFO : Starting test kraken 11:14:58 INFO - 2015-11-15 11:14:58,760 DEBUG : operating with platform_type : mac_ 11:14:58 INFO - 2015-11-15 11:14:58,760 INFO : Initialising browser for kraken test... 11:14:58 INFO - 2015-11-15 11:14:58,781 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmptxryWw/profile http://localhost:49584/getInfo.html 11:15:01 INFO - 2015-11-15 11:15:01,555 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:15:01 INFO - 2015-11-15 11:15:01,555 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:15:01 INFO - 2015-11-15 11:15:01,556 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:15:01 INFO - 2015-11-15 11:15:01,556 DEBUG : BROWSER_OUTPUT: __metrics 11:15:01 INFO - 2015-11-15 11:15:01,572 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:15:02 INFO - 2015-11-15 11:15:02,450 INFO : Browser initialized. 11:15:02 INFO - 2015-11-15 11:15:02,450 INFO : Running cycle 1/1 for kraken test... 11:15:02 INFO - 2015-11-15 11:15:02,450 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmptxryWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:15:14 INFO - 2015-11-15 11:15:14,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 229670912 11:15:14 INFO - 2015-11-15 11:15:14,754 DEBUG : BROWSER_OUTPUT: 11:15:17 INFO - 2015-11-15 11:15:17,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49584/tests/kraken/driver.html?testName=audio-beat-detection) 11:15:18 INFO - 2015-11-15 11:15:18,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 286425088 11:15:18 INFO - 2015-11-15 11:15:18,487 DEBUG : BROWSER_OUTPUT: 11:15:21 INFO - 2015-11-15 11:15:21,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49584/tests/kraken/driver.html?testName=audio-dft) 11:15:22 INFO - 2015-11-15 11:15:22,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 299446272 11:15:22 INFO - 2015-11-15 11:15:22,423 DEBUG : BROWSER_OUTPUT: 11:15:26 INFO - 2015-11-15 11:15:26,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49584/tests/kraken/driver.html?testName=audio-fft) 11:15:26 INFO - 2015-11-15 11:15:26,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 281260032 11:15:26 INFO - 2015-11-15 11:15:26,657 DEBUG : BROWSER_OUTPUT: 11:15:29 INFO - 2015-11-15 11:15:29,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49584/tests/kraken/driver.html?testName=audio-oscillator) 11:15:29 INFO - 2015-11-15 11:15:29,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 284037120 11:15:29 INFO - 2015-11-15 11:15:29,680 DEBUG : BROWSER_OUTPUT: 11:15:32 INFO - 2015-11-15 11:15:32,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49584/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:15:32 INFO - 2015-11-15 11:15:32,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 284151808 11:15:32 INFO - 2015-11-15 11:15:32,934 DEBUG : BROWSER_OUTPUT: 11:15:36 INFO - 2015-11-15 11:15:36,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49584/tests/kraken/driver.html?testName=imaging-darkroom) 11:15:37 INFO - 2015-11-15 11:15:37,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 279756800 11:15:37 INFO - 2015-11-15 11:15:37,333 DEBUG : BROWSER_OUTPUT: 11:15:41 INFO - 2015-11-15 11:15:41,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49584/tests/kraken/driver.html?testName=imaging-desaturate) 11:15:41 INFO - 2015-11-15 11:15:41,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 280645632 11:15:41 INFO - 2015-11-15 11:15:41,925 DEBUG : BROWSER_OUTPUT: 11:15:45 INFO - 2015-11-15 11:15:45,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49584/tests/kraken/driver.html?testName=json-parse-financial) 11:15:46 INFO - 2015-11-15 11:15:46,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 282292224 11:15:46 INFO - 2015-11-15 11:15:46,077 DEBUG : BROWSER_OUTPUT: 11:15:47 INFO - 2015-11-15 11:15:47,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49584/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:15:48 INFO - 2015-11-15 11:15:48,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 324562944 11:15:48 INFO - 2015-11-15 11:15:48,494 DEBUG : BROWSER_OUTPUT: 11:15:50 INFO - 2015-11-15 11:15:50,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49584/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:15:51 INFO - 2015-11-15 11:15:51,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 326565888 11:15:51 INFO - 2015-11-15 11:15:51,331 DEBUG : BROWSER_OUTPUT: 11:15:53 INFO - 2015-11-15 11:15:53,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49584/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:15:54 INFO - 2015-11-15 11:15:54,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 320118784 11:15:54 INFO - 2015-11-15 11:15:54,510 DEBUG : BROWSER_OUTPUT: 11:15:57 INFO - 2015-11-15 11:15:57,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:15:58 INFO - 2015-11-15 11:15:58,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 323252224 11:15:58 INFO - 2015-11-15 11:15:58,351 DEBUG : BROWSER_OUTPUT: 11:16:01 INFO - 2015-11-15 11:16:01,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:16:02 INFO - 2015-11-15 11:16:02,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 319062016 11:16:02 INFO - 2015-11-15 11:16:02,242 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49584/tests/kraken/driver.html?testName=ai-astar) 11:16:04 INFO - 2015-11-15 11:16:04,571 DEBUG : BROWSER_OUTPUT: 1447614964567 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:16:04 INFO - 2015-11-15 11:16:04,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 385961984 11:16:04 INFO - 2015-11-15 11:16:04,670 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,670 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:16:04 INFO - 2015-11-15 11:16:04,670 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:16:04 INFO - 2015-11-15 11:16:04,670 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:16:04 INFO - 2015-11-15 11:16:04,671 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:16:04 INFO - 2015-11-15 11:16:04,671 DEBUG : BROWSER_OUTPUT: |0;ai-astar;137;137;136;141;145;146;146;147;146;161 11:16:04 INFO - 2015-11-15 11:16:04,671 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;198;166;203;219;171;202;198;171;230;180 11:16:04 INFO - 2015-11-15 11:16:04,671 DEBUG : BROWSER_OUTPUT: |2;audio-dft;206;205;215;215;219;216;216;217;216;217 11:16:04 INFO - 2015-11-15 11:16:04,671 DEBUG : BROWSER_OUTPUT: |3;audio-fft;101;99;108;155;90;93;94;94;155;88 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;128;127;172;115;120;120;167;119;118;169 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;164;156;164;157;156;156;154;149;148 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;163;163;170;171;172;170;170;171;169;162 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;121;137;126;136;126;136;126;136;136;144 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;75;77;76;76;75;75;77;79;80 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;84;88;88;88;90;90;90;94;94;95 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;108;111;110;114;115;115;115;115;127;119 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;158;166;167;168;177;168;170;175;189;177 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;181;195;194;204;203;189;207;197;206;210 11:16:04 INFO - 2015-11-15 11:16:04,672 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;91;90;90;90;96;96;95;94;95;96 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1058 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: __startTimestamp1447614964663__endTimestamp 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:144.20 Median:146.00 stddev:7.32 (5.0%) stddev-sans-first:7.28 11:16:04 INFO - 2015-11-15 11:16:04,673 DEBUG : BROWSER_OUTPUT: Values: 137.0 137.0 136.0 141.0 145.0 146.0 146.0 147.0 146.0 161.0 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:193.80 Median:200.00 stddev:21.44 (10.7%) stddev-sans-first:22.68 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: Values: 198.0 166.0 203.0 219.0 171.0 202.0 198.0 171.0 230.0 180.0 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:214.20 Median:216.00 stddev:4.73 (2.2%) stddev-sans-first:3.98 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: Values: 206.0 205.0 215.0 215.0 219.0 216.0 216.0 217.0 216.0 217.0 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:107.70 Median:91.50 stddev:25.58 (28.0%) stddev-sans-first:27.01 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: Values: 101.0 99.0 108.0 155.0 90.0 93.0 94.0 94.0 155.0 88.0 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,674 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:135.50 Median:127.50 stddev:23.70 (18.6%) stddev-sans-first:24.98 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: Values: 128.0 127.0 172.0 115.0 120.0 120.0 167.0 119.0 118.0 169.0 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:155.30 Median:156.00 stddev:5.68 (3.6%) stddev-sans-first:5.55 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: Values: 149.0 164.0 156.0 164.0 157.0 156.0 156.0 154.0 149.0 148.0 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:168.10 Median:170.00 stddev:3.84 (2.3%) stddev-sans-first:3.61 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 170.0 171.0 172.0 170.0 170.0 171.0 169.0 162.0 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:132.40 Median:136.00 stddev:7.15 (5.3%) stddev-sans-first:6.28 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: Values: 121.0 137.0 126.0 136.0 126.0 136.0 126.0 136.0 136.0 144.0 11:16:04 INFO - 2015-11-15 11:16:04,675 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,676 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.10 Median:76.50 stddev:2.47 (3.2%) stddev-sans-first:1.80 11:16:04 INFO - 2015-11-15 11:16:04,676 DEBUG : BROWSER_OUTPUT: Values: 71.0 75.0 77.0 76.0 76.0 75.0 75.0 77.0 79.0 80.0 11:16:04 INFO - 2015-11-15 11:16:04,676 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,676 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:90.10 Median:90.00 stddev:3.41 (3.8%) stddev-sans-first:2.82 11:16:04 INFO - 2015-11-15 11:16:04,676 DEBUG : BROWSER_OUTPUT: Values: 84.0 88.0 88.0 88.0 90.0 90.0 90.0 94.0 94.0 95.0 11:16:04 INFO - 2015-11-15 11:16:04,676 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,676 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:114.90 Median:115.00 stddev:5.28 (4.6%) stddev-sans-first:4.97 11:16:04 INFO - 2015-11-15 11:16:04,676 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 110.0 114.0 115.0 115.0 115.0 115.0 127.0 119.0 11:16:04 INFO - 2015-11-15 11:16:04,677 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,677 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:171.50 Median:172.50 stddev:8.42 (4.9%) stddev-sans-first:7.38 11:16:04 INFO - 2015-11-15 11:16:04,677 DEBUG : BROWSER_OUTPUT: Values: 158.0 166.0 167.0 168.0 177.0 168.0 170.0 175.0 189.0 177.0 11:16:04 INFO - 2015-11-15 11:16:04,677 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,677 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.60 Median:203.50 stddev:9.08 (4.5%) stddev-sans-first:7.06 11:16:04 INFO - 2015-11-15 11:16:04,677 DEBUG : BROWSER_OUTPUT: Values: 181.0 195.0 194.0 204.0 203.0 189.0 207.0 197.0 206.0 210.0 11:16:04 INFO - 2015-11-15 11:16:04,677 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-11-15 11:16:04,678 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:93.30 Median:95.00 stddev:2.71 (2.9%) stddev-sans-first:2.74 11:16:04 INFO - 2015-11-15 11:16:04,678 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 90.0 90.0 96.0 96.0 95.0 94.0 95.0 96.0 11:16:04 INFO - 2015-11-15 11:16:04,678 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:16:04 INFO - 2015-11-15 11:16:04,678 DEBUG : BROWSER_OUTPUT: 11:16:05 INFO - 2015-11-15 11:16:05,404 INFO : Browser exited with error code: 0 11:16:05 INFO - 2015-11-15 11:16:05,466 INFO : Completed test kraken (00:01:06) 11:16:05 INFO - 2015-11-15 11:16:05,466 INFO : Starting test v8_7 11:16:05 INFO - 2015-11-15 11:16:05,467 DEBUG : operating with platform_type : mac_ 11:16:05 INFO - 2015-11-15 11:16:05,467 INFO : Initialising browser for v8_7 test... 11:16:05 INFO - 2015-11-15 11:16:05,489 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmppDezNW/profile http://localhost:49584/getInfo.html 11:16:08 INFO - 2015-11-15 11:16:08,253 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:16:08 INFO - 2015-11-15 11:16:08,253 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:16:08 INFO - 2015-11-15 11:16:08,254 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:16:08 INFO - 2015-11-15 11:16:08,254 DEBUG : BROWSER_OUTPUT: __metrics 11:16:08 INFO - 2015-11-15 11:16:08,275 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:09 INFO - 2015-11-15 11:16:09,163 INFO : Browser initialized. 11:16:09 INFO - 2015-11-15 11:16:09,163 INFO : Running cycle 1/1 for v8_7 test... 11:16:09 INFO - 2015-11-15 11:16:09,163 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmppDezNW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:16:21 INFO - 2015-11-15 11:16:21,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 228450304 11:16:21 INFO - 2015-11-15 11:16:21,473 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49584/tests/v8_7/run.html (next: http://localhost:49584/tests/v8_7/run.html) 11:16:44 INFO - 2015-11-15 11:16:44,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 626036736 11:16:44 INFO - 2015-11-15 11:16:44,532 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,533 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: |0;Richards;219.53896816684963 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;259.4706798131811 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: |2;Encrypt;413.0524576621231 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7700 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2566.6666666666665 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: |5;Earley;1097.694840834248 11:16:44 INFO - 2015-11-15 11:16:44,534 DEBUG : BROWSER_OUTPUT: |6;Boyer;17413.793103448275 11:16:44 INFO - 2015-11-15 11:16:44,535 DEBUG : BROWSER_OUTPUT: |7;RegExp;38961.53846153846 11:16:44 INFO - 2015-11-15 11:16:44,535 DEBUG : BROWSER_OUTPUT: |8;Splay;899.9106344950849 11:16:44 INFO - 2015-11-15 11:16:44,535 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7633.587786259542 11:16:44 INFO - 2015-11-15 11:16:44,535 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:16:44 INFO - 2015-11-15 11:16:44,535 DEBUG : BROWSER_OUTPUT: __startTimestamp1447615004532__endTimestamp 11:16:44 INFO - 2015-11-15 11:16:44,535 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,536 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:16:44 INFO - 2015-11-15 11:16:44,537 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:16:44 INFO - 2015-11-15 11:16:44,538 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,538 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:219.54 Median:219.54 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,538 DEBUG : BROWSER_OUTPUT: Values: 219.5 11:16:44 INFO - 2015-11-15 11:16:44,538 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,538 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:259.47 Median:259.47 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,538 DEBUG : BROWSER_OUTPUT: Values: 259.5 11:16:44 INFO - 2015-11-15 11:16:44,538 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,539 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:413.05 Median:413.05 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,539 DEBUG : BROWSER_OUTPUT: Values: 413.1 11:16:44 INFO - 2015-11-15 11:16:44,539 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,539 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7700.00 Median:7700.00 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,539 DEBUG : BROWSER_OUTPUT: Values: 7700.0 11:16:44 INFO - 2015-11-15 11:16:44,539 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,539 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2566.67 Median:2566.67 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,540 DEBUG : BROWSER_OUTPUT: Values: 2566.7 11:16:44 INFO - 2015-11-15 11:16:44,540 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,540 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1097.69 Median:1097.69 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,540 DEBUG : BROWSER_OUTPUT: Values: 1097.7 11:16:44 INFO - 2015-11-15 11:16:44,540 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,540 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:17413.79 Median:17413.79 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,540 DEBUG : BROWSER_OUTPUT: Values: 17413.8 11:16:44 INFO - 2015-11-15 11:16:44,541 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,541 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:38961.54 Median:38961.54 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,541 DEBUG : BROWSER_OUTPUT: Values: 38961.5 11:16:44 INFO - 2015-11-15 11:16:44,541 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,541 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:899.91 Median:899.91 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,541 DEBUG : BROWSER_OUTPUT: Values: 899.9 11:16:44 INFO - 2015-11-15 11:16:44,541 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-11-15 11:16:44,542 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7633.59 Median:7633.59 stddev:0.00 (0.0%) 11:16:44 INFO - 2015-11-15 11:16:44,542 DEBUG : BROWSER_OUTPUT: Values: 7633.6 11:16:44 INFO - 2015-11-15 11:16:44,542 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:16:44 INFO - 2015-11-15 11:16:44,542 DEBUG : BROWSER_OUTPUT: 11:16:45 INFO - 2015-11-15 11:16:45,336 INFO : Browser exited with error code: 0 11:16:45 INFO - 2015-11-15 11:16:45,362 INFO : Completed test v8_7 (00:00:39) 11:16:45 INFO - 2015-11-15 11:16:45,386 INFO : Completed test suite (00:20:24) 11:16:45 INFO - 2015-11-15 11:16:45,387 DEBUG : Working with test: dromaeo_css 11:16:45 INFO - 2015-11-15 11:16:45,387 DEBUG : Generating results file: dromaeo_css 11:16:45 INFO - 2015-11-15 11:16:45,388 DEBUG : Working with test: kraken 11:16:45 INFO - 2015-11-15 11:16:45,388 DEBUG : Generating results file: kraken 11:16:45 INFO - 2015-11-15 11:16:45,389 INFO : javascript benchmark 11:16:45 INFO - 2015-11-15 11:16:45,389 DEBUG : Working with test: v8_7 11:16:45 INFO - 2015-11-15 11:16:45,389 DEBUG : Generating results file: v8_7 11:16:45 INFO - 2015-11-15 11:16:45,389 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:45 INFO - 2015-11-15 11:16:45,443 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 11:16:45 INFO - 2015-11-15 11:16:45,444 DEBUG : process_Request line: dromaeo_css 5018.10 graph.html#tests=[[72,1,55]] 11:16:45 INFO - 2015-11-15 11:16:45,444 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:45 INFO - 2015-11-15 11:16:45,499 DEBUG : process_Request line: kraken 1995.70 graph.html#tests=[[232,1,55]] 11:16:45 INFO - 2015-11-15 11:16:45,499 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:45 INFO - 2015-11-15 11:16:45,528 DEBUG : process_Request line: v8_7 13886.08 graph.html#tests=[[230,1,55]] 11:16:45 INFO - 2015-11-15 11:16:45,529 INFO : javascript benchmark 11:16:45 INFO - 2015-11-15 11:16:45,532 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [252.59332474715694, 258.65211290813863, 259.74415201026983, 262.6362487954183, 263.2996230028125, 10801.891981080187, 11246.662600121988, 13315.933420332909, 13687.931560342196, 13925.512607058756, 9600.903990960089, 11402.828957565622, 13363.33183340834, 13519.256440895746, 13712.040157188976, 3102.224443889028, 3306.966930330702, 3361.697447229749, 3400.996705971732, 3406.9659303406897, 2608.47830433914, 2669.3059804450886, 3234.56333394991, 3279.6884295991845, 3381.306832099414, 2703.229579569823, 3492.231709024011, 3629.8185090745355, 3719.8698045568412, 3748.2878253131817, 3530.7351948603828, 3606.242689035306, 3679.5768486623847, 3694.7598406103516, 3728.7949162796035, 3042.3306872488015, 3071.8617662205256, 3084.8611812468266, 3094.4275309067893, 3173.650898401174, 9619.0, 9918.107370336704, 10070.1440377568, 10141.2394070445, 10347.5343609537, 1455.9563213103518, 1487.6504021555033, 1548.8296287408375, 1584.9683006339924, 1588.3487770014353, 7010.92989070113, 7201.315874991919, 7322.853542929165, 7550.131734850507, 7574.35617972473, 1142.034980441534, 1190.0717440396504, 1194.1044216837372, 1221.3343727668441, 1224.5346768228105, 42934.785326073485, 45233.0, 45301.0, 45447.99999999967, 46141.30788038182, 4790.520947905182, 4916.803327866845, 4948.851534453972, 4999.550040496373, 5138.100832354397, 5601.719914004283, 5658.321001479767, 5667.319921609351, 5897.823065308047, 5912.46787789101, 3758.511393518825, 3930.21395720857, 3935.704822138351, 3994.800259986989, 4005.5393629732953, 3992.2414741199077, 4000.439938408625, 4010.9598904010586, 4127.071408932966, 4221.451211342567, 2214.3246309875644, 2230.609643312414, 2240.193530329113, 2261.197274967396, 2307.746147923727, 774.082711986298, 777.1684297801298, 787.6494959742975, 792.0772300270236, 856.6145234644434, 290.7499550386666, 317.3446832291311, 322.5033448489347, 324.9658785827501, 325.0395082531115, 8153.836923261501, 8813.206811387006, 8813.735587932373, 9116.1339672731, 9127.315451341176, 337.67077099827964, 339.20287324786557, 344.38011579157416, 347.2256867186139, 353.4274475349898, 3767.679747221462, 4759.738214398241, 4862.222044472867, 4869.22092465211, 4914.385701787277, 410682.0, 416494.0, 421293.0, 426266.0, 429181.0, 35405.0, 49102.26346604804, 49294.50705492899, 52080.0, 52466.990965948426, 353.9557555305587, 365.2949806872761, 369.69130775802506, 369.87054530914503, 382.39963257685724, 7856.25365590268, 8186.83626327482, 8339.683725563442, 8372.204640559137, 8673.0, 25027.499450011263, 25501.61747573825, 26368.472630546898, 26783.732162678123, 27202.0, 35101.47347789734, 35655.28689426249, 36026.8198659005, 36109.0, 36396.090097747765, 4470.731756094645, 4664.720116792868, 4694.812207511662, 4710.788014539423, 4763.7856296467435, 8244.175582441709, 8809.163129502687, 8863.645454182019, 8864.429315498433, 8904.332175086765, 7588.241175882367, 7594.6202689866395, 7686.46194766361, 7700.460967732205, 7712.113106992768, 7184.748533801292, 7365.889511657437, 7390.96304518474, 7411.444141689502, 7771.269790500478, 7570.621468926642, 7670.578118203553, 7843.176466470938, 7853.882191767242, 7924.762257132295, 4541.205289074464, 4567.109413664303, 4626.306054091779, 4740.525947405232, 4808.2547205183255, 7575.886361704469, 7624.161342252459, 7683.9231607683205, 7745.148033716399, 7996.760097197093], "dojo.html": [2386.200622791365, 2387.450886296152, 2390.653355263488, 2497.7127630322507, 2542.8474291542507, 3968.365061590146, 4017.718759686823, 4064.5122585289732, 4087.6116768906945, 4192.727472714271, 3999.2601368746728, 4083.203775263825, 4143.585641435855, 4157.9584204157945, 4175.248455278056, 3691.8154092295413, 3728.552573691161, 3823.751456155355, 3841.9423708644254, 3849.018500282424, 3777.848886044555, 3858.0, 3887.7667339959553, 3907.0427745202464, 3934.2721596504593, 3606.549181352344, 3684.299983003221, 3700.8149592520267, 3751.0809851586264, 3869.941950870739, 3749.512563366772, 3808.2383523295453, 3867.748596341257, 3888.9611103888883, 3906.785126818024, 3803.9619603804163, 3809.9809500952597, 3836.3861782114727, 3896.1428485733095, 3902.2780785554764, 3951.5060617422823, 3997.300472417315, 4183.477065366829, 4241.957580424187, 4258.382534532476, 4336.913261734748, 4361.563843615645, 4438.045820148651, 4498.8875278117985, 4500.347449619787, 4432.556744325541, 4470.41884555009, 4493.955060449386, 4551.385562948993, 4554.977225113887, 3884.3784994401044, 3922.7254092213843, 4125.958740412558, 4161.271777438936, 4191.538930717618, 4353.82584696615, 4574.222382195035, 4620.0, 4627.907441851212, 4649.0, 4230.132822771325, 4284.507281662586, 4312.892177695583, 4427.247367947457, 4445.0, 4253.680973926967, 4349.652027837828, 4384.188925048876, 4510.143072816154, 4569.063342014945, 4212.957870421318, 4326.459192600925, 4417.160739459492, 4443.111377724404, 4468.910621787546, 4237.512686041145, 4260.637845783143, 4310.80601372939, 4457.531959144308, 4490.663200259994, 3176.8093914365213, 3206.7755257132244, 3250.1874531367157, 3294.5552350432863, 3359.3449277391164, 2983.3138378173144, 3049.7407720343576, 3057.92355191122, 3058.663547009827, 3120.1575574595186, 4001.579834117376, 4008.4788977432745, 4028.133951200506, 4180.561041090703, 4187.371894215892, 4327.0, 4341.044970106572, 4368.5194628590825, 4449.1101779644205, 4505.391772110723, 3927.057506198492, 3983.462232598562, 4037.8990525237105, 4135.958640413617, 4165.021220013295, 3802.068493219179, 3823.407371857311, 3849.345611246095, 3880.689544836406, 3882.514685664292, 4355.956440435555, 4488.730676159441, 4512.842050528216, 4539.636829053734, 4573.268277075652, 4236.110416812504, 4328.848490302824, 4382.539833317455, 4420.403245561936, 4431.601155895984, 4423.049044455457, 4423.380726698329, 4492.752898590478, 4600.723956562617, 4692.41344831896, 4234.428352172417, 4281.250781113355, 4301.892452688708, 4308.633766129914, 4383.320585309282, 4344.8044837983, 4393.121375724932, 4394.077243778842, 4516.774161291988, 4517.661175411923, 4188.287991041591, 4213.936800886527, 4246.0, 4345.717528360773, 4401.361802538678, 4203.6847236458, 4226.36604509326, 4292.699511034198, 4352.6735494837385, 4373.037931655031, 4010.438538604539, 4148.419221308959, 4151.543330233611, 4196.9370459442525, 4242.469691288589, 4303.720258183208, 4325.740455572675, 4331.112122014916, 4394.758288294174, 4430.091831174666, 3982.8008599570485, 4060.5736397679, 4112.09533902541, 4258.190943720683, 4359.128174365203], "mootools.html": [1018.8522664213684, 1045.6862941117665, 1061.739873730936, 1078.8921107889212, 1190.3036723516743, 5154.201098829682, 5606.579506537011, 5751.827445176641, 5758.5393168546525, 5870.26621672291, 5889.0, 5955.821325360246, 5962.6124301920345, 6041.426064523875, 6081.331053584113, 1706.709859323918, 1734.9739753903702, 1736.1145815634022, 1776.0498133498581, 1779.074881061847, 1694.5509439998348, 1700.6768713944373, 1721.8278172182745, 1765.9757340742403, 1766.7703198584165, 1719.3294615100122, 1734.9132543372843, 1743.2068408873931, 1749.3527394863918, 1749.4664127441126, 1629.7310943694276, 1654.0075954427248, 1675.748637704354, 1693.9830601693948, 1717.8110407855127, 1691.4080071974834, 1706.7695861058721, 1713.374618264337, 1773.2463702926204, 1785.1342099081935, 5298.470152984709, 5885.470307672287, 5940.108983652443, 5942.673152976585, 5981.790637327673, 3340.0313908966373, 3440.088376580208, 3664.798436086014, 3749.2314075614436, 3761.849526018956, 2200.9559808803892, 2274.1699279762765, 2305.4351683837567, 2387.307680772591, 2407.2056221447056, 735.1949615171433, 745.3738859358111, 751.143696186348, 762.9351505122071, 765.1697907770076, 7804.180561041123, 7954.7613571592365, 8004.319632831216, 8042.839143217161, 8133.59332033396, 3317.6848199421015, 3422.760406771502, 3523.0487768302414, 3629.0, 3663.249033948034, 7106.502544821917, 7112.893306600405, 7119.857602847914, 7199.928000719926, 7221.061262035902, 3811.790351530637, 3885.4171874218528, 3925.685945124383, 4004.099077707551, 4020.7386519876113, 3439.5012723155, 3467.7919324840086, 3495.3358861816682, 3598.9100272493397, 3647.544056992876, 2795.4409118176445, 2802.467531169071, 2802.9299267518068, 2807.185916084313, 2837.233946834343, 905.8233644439402, 913.9497327647043, 921.1847514949318, 931.0735817861272, 941.7786820097272, 939.3800091939287, 1001.3090967232587, 1002.4937406609761, 1036.7200855769051, 1060.5386656804314, 5425.26758887553, 5527.751251193706, 5598.804041858515, 5695.373508914016, 5716.542676585863, 371.7100661484047, 372.32794805376017, 376.38649002126357, 382.80094350937355, 383.9692824574083, 4343.478782546114, 4349.608535231781, 4466.798994045211, 4507.706999045052, 4566.13243483737, 6685.465162786965, 6785.5250132490255, 6882.829918913697, 7033.507654464139, 7146.32109949554, 7017.087778588751, 7046.1192350956135, 7304.5252058616015, 7344.742933997284, 7348.522346047596, 5577.888442231133, 5595.524380427709, 5659.122835960433, 5681.806820567727, 5795.9420405796245, 5275.155975044128, 5507.779688812403, 5515.365732940763, 5642.887142257214, 5690.687012214368, 5938.2280303560265, 6200.7519699213335, 6254.093156492192, 6377.74489020434, 6514.51141164424, 5806.854828629318, 6450.516211284266, 6628.469722422098, 6750.86498270022, 6778.932210678027, 5341.813036543857, 5364.088105022078, 5398.136298192428, 5423.728813559227, 5454.972725136349, 5745.683987380734, 5778.075507918713, 5809.680467574324, 5863.20846685692, 5946.821595352147, 5308.840734777963, 5338.599605029561, 5403.918941215964, 5527.391986881359, 5572.888542229214, 4826.565609095198, 5175.715335656575, 5404.702741349263, 5507.449255074621, 5516.172574113915, 5262.710550919736, 5322.0, 5382.058139825436, 5430.104032834696, 5520.420355862737, 4812.109759694467, 4866.391701037371, 5023.246513023076, 5031.094403007493, 5074.873128171826, 4866.124097662313, 4940.777665005012, 5030.396352437585, 5035.4712755161645, 5134.306868572844], "ext.html": [422.12409250804586, 424.07339962182635, 427.47847625896395, 427.84383699949524, 448.12615399970065, 22754.88622556887, 24501.509969800594, 29458.116256512338, 29526.852365738167, 30322.69677303232, 31346.373072538594, 31590.842045789796, 32125.51811722826, 32586.511202331923, 32660.836695816546, 6369.36306369364, 6967.268436814137, 7013.789586312419, 7060.0, 7251.456140789435, 6184.350643182469, 6232.7506899724185, 8236.299914507274, 8403.95798021009, 8794.51630160341, 8306.0, 8313.210245026712, 8413.411061225717, 8421.957890210571, 8439.95780021099, 6299.779507717208, 6490.870182596369, 8149.388795840306, 8306.916930830705, 8404.495730256203, 6241.063840423927, 8197.303229225523, 8436.873446898302, 8525.403221774479, 8604.311655067642, 28728.42543149146, 29362.265943351373, 29563.0, 29756.55365169524, 30151.849240753876, 2138.9465263368384, 2347.636116401943, 2350.82368822339, 2463.2979600813683, 2486.9803380614044, 20782.168713251453, 20793.064312105842, 20838.0, 20928.686069708965, 21145.3656390307, 1782.117851663422, 1785.8392744652913, 1813.4559632110313, 1832.569346203641, 1907.2085084689836, 206332.0, 206470.0, 211600.0, 213328.0, 213715.0, 38974.61025389766, 41395.58604413917, 41721.374179387334, 43483.78258108752, 43819.0, 38068.238635227695, 45310.32034519485, 45623.77188114038, 47203.5279647206, 47602.0, 10365.429901355497, 10734.946325268324, 10793.0, 10799.83800242997, 10800.729981750519, 8018.198180181935, 8045.15525869787, 8088.83822323562, 8174.264316211569, 8338.0, 13697.383617737225, 13799.89600831931, 14073.437062517385, 14115.647108822362, 14140.434382624786, 6305.464035557029, 6437.613743175424, 6482.740690372427, 6563.573367731177, 6583.30875258091, 762.3862790453738, 786.288408989865, 795.2524626850742, 808.2846680687517, 822.0956947357859, 21127.0, 21145.25991590287, 21155.471113221985, 21178.78821211768, 22066.558668826532, 797.9321757650548, 810.5541951926534, 839.8362319347791, 880.700561808988, 907.9785241603197, 11041.889581104248, 11101.278416902875, 11232.49453774582, 11261.887381126247, 11395.487203075882, 335958.0, 343984.0, 348472.0, 349168.0, 349813.0, 37711.62288377081, 38248.0, 39451.21097578033, 39576.60423395729, 39580.20839583192, 977.6040703515088, 1026.2610920137488, 1035.2287545778443, 1037.699067270483, 1046.2205656785743, 20609.79390206079, 20802.79197208069, 21148.47128821792, 21373.89313053425, 21655.242066527597, 36912.44631330478, 36955.44566831554, 37295.81352093222, 37334.439983400815, 38384.616153838106, 170008.0, 223284.0, 224256.0, 224677.0, 226811.0, 29721.10836674903, 31819.681803181673, 32500.83749581237, 33012.50481242735, 33101.33797323992, 33217.33565328632, 34648.13379665528, 35687.0, 36133.27733445369, 36622.8168859154, 26693.733062669126, 28508.57237141486, 28593.571096433156, 29017.0, 30089.0, 28874.27814304659, 28918.7108128916, 29541.704582953895, 29857.25356866096, 29954.850225749604, 29304.560431593116, 29543.704562954954, 29673.406531869674, 30122.0, 30130.0, 25158.24525264245, 25237.495250095264, 25778.226653199683, 27022.72977270281, 28111.578326324714, 18782.624347513247, 19280.903595481934, 19332.4200273992, 19394.849657340175, 19483.0], "prototype.html": [218.1090246343685, 227.66192204576203, 229.10192047175073, 230.4262386657224, 239.2559141071268, 4627.143978364005, 4634.58288754012, 4748.76256187191, 4824.469308376076, 4872.147374209512, 4643.117807616551, 4676.39206903103, 4708.176069187895, 4784.521547845214, 4807.663463557552, 3349.531065650811, 3489.842957066938, 3501.369753444379, 3607.855685772579, 3611.8916432506935, 3474.5656792900886, 3502.807345595991, 3622.6739593436587, 3663.2307215484648, 3669.119411341272, 3370.359631669975, 3492.1618811485187, 3510.3856825055514, 3556.92886142277, 3556.982215088934, 3395.558577384949, 3449.9827500862584, 3489.249811290559, 3538.646135386454, 3602.873899413508, 2901.10065879578, 2946.7347938685407, 3100.1629560018896, 3100.5194194899827, 3101.5347697845277, 4416.757078360689, 4517.954820451819, 4633.351330813689, 4648.3259927310355, 4717.646176536773, 3870.7290489665734, 3904.9804750976064, 4015.7791321477307, 4020.135670830756, 4027.0, 4842.685225460334, 4917.901641967176, 4951.950480495185, 4983.501649835024, 5074.13739664258, 3203.9679603203904, 3208.903732888017, 3219.613646362428, 3303.80297102429, 3372.6627337266077, 5079.111155547801, 5147.7607240849975, 5149.150390185652, 5217.243499692523, 5226.5818734501145, 3248.6588908164777, 3256.8697252110123, 3383.086566626997, 3408.8466019028706, 3428.5542879425516, 3314.5691060162026, 3318.854995026712, 3340.6158291796755, 3491.581010278732, 3502.842372093262, 3958.2281455116554, 3979.9403008954887, 3989.940150897739, 4022.818973146157, 4047.655949244347, 4934.235193545006, 4960.131976904099, 4972.627052971042, 4983.202687569971, 5036.093503169464, 1149.6263714292888, 1162.8255761635821, 1169.0881112731913, 1220.383706228349, 1224.0391292835081, 747.7495039161832, 763.564768082199, 768.1972338905857, 781.7224885165798, 784.9097353804272, 4652.046330502307, 4701.623870090384, 4743.288506724019, 4766.618670506351, 4824.155772739827, 5074.3657042869645, 5074.441811400743, 5095.490450954949, 5194.584433245332, 5226.555742761831, 4648.65135114861, 4655.185342565038, 4853.466118726938, 4861.392325959255, 4882.389701287339, 2660.9467810644064, 2692.9326766830986, 2747.8076534642382, 2784.359597292634, 2806.7052959439375, 5199.532042116228, 5224.138017227115, 5225.425203227642, 5293.126634105406, 5346.518813306821, 5162.6128040397125, 5209.619450845529, 5326.866828329323, 5338.065838478328, 5378.946210537844, 5036.521530454601, 5227.790888364423, 5276.65701729394, 5298.417174110845, 5390.137577987503, 5057.848264552069, 5218.843434696965, 5282.97358513205, 5292.470752924831, 5317.1226747586215, 5014.52362025607, 5015.598752099896, 5122.0, 5196.4283928767045, 5218.634695571273, 5132.615053871049, 5260.605454590845, 5373.086575282289, 5385.892282154413, 5417.6478528895495, 3329.8002119871917, 3367.7642565020215, 3383.6108847482856, 3385.644507326695, 3434.10713214561, 5088.084144853814, 5132.358455193101, 5167.689938603696, 5232.0, 5310.309659744208, 4943.555080042814, 4949.925751113664, 5037.874053148701, 5110.463401342954, 5161.587073034223, 4878.438979517401, 4936.8765780855765, 4997.525235102659, 5119.564836988898, 5150.562202212854, 4836.975815121043, 4856.417229932431, 4965.006998600222, 5036.370453693288, 5037.748112594429, 4951.672713824641, 5019.774110164978, 5024.095662780588, 5113.8977220454635, 5141.0232055909255, 4800.207965685623, 4810.975945120252, 4873.244647079709, 5036.06832735945, 5048.444671086104], "yui.html": [513.3659929986463, 518.9818356357525, 554.7669978608984, 566.3119310038304, 605.0863196573174, 9353.906460935388, 9355.578998945046, 9440.291978101635, 9696.515174241285, 9754.122129008389, 9571.617135314596, 9673.564689588968, 9923.404595724262, 9929.453880036595, 10162.39025658461, 672.4015626092769, 677.9186497620292, 689.524228282486, 697.4490152779298, 714.9428045756327, 667.8230268978724, 673.0, 693.836948317145, 694.0456871801273, 695.3151146121066, 678.4843518925627, 706.7597017014214, 719.3202423709597, 720.8702433561957, 728.9963550182268, 698.8218004408868, 701.5790525684599, 705.9364657180853, 706.9505134640577, 724.3770357492579, 520.6017396691534, 521.1999580643694, 526.3157894736827, 533.722464318556, 540.5270388410141, 9508.952455237748, 9586.66446674363, 9674.371165874196, 9712.02879712023, 9827.754306142333, 7453.739119130859, 7511.887321690179, 7716.611010018194, 8104.878426823543, 8287.792805179859, 6901.482388820858, 7270.0, 7460.328570428687, 7464.925350746477, 7708.537487750753, 2194.626913424722, 2242.5178586603797, 2339.298210536849, 2339.941501462477, 2381.9995601847268, 30383.93656222044, 30735.0, 31017.689823101708, 34074.829625851715, 35893.282134357425, 4785.665003449794, 5103.97448012765, 5225.6603320784025, 5331.626786124934, 5409.918851217235, 9068.8639670405, 9145.90854091464, 9159.450432974043, 9390.483523406278, 9503.144716975505, 4565.863024109282, 4567.177907976529, 4860.684055536379, 4957.132501812169, 4991.051700176955, 2748.4228312054693, 2820.9858950705116, 2864.8281103133463, 2870.282429392652, 2973.3458639099363, 2032.6849338352579, 2067.855250132506, 2088.102116090096, 2158.330917415606, 2160.4382860456394, 302.45859910759935, 307.1905528931282, 309.3796937141018, 309.6516419028593, 324.3512974051896, 359.73199966025476, 361.9692326152254, 395.72892568590606, 415.23596582288735, 478.5573344656179, 5812.360640329561, 6094.728060227871, 6120.0, 6182.412670796267, 6243.500519958392, 417.74526448125937, 440.6474820143872, 449.3304975586418, 464.6561544457077, 472.1053603421497, 2668.59971004347, 2754.0911499205213, 2778.6804517480346, 2809.9438011240068, 2824.4209936962875, 43790.34314485285, 45715.54284457179, 45768.313475297895, 45829.54170458319, 46037.7698111514, 38465.0, 38625.22749544994, 38814.80592597075, 38846.223075538896, 38943.805280973414, 31572.526412103838, 32047.35905281928, 32912.0, 35264.471032934525, 36288.4556731644, 6165.167702360124, 6337.2395312562785, 6449.322821103717, 6495.805125846232, 6621.768238111643, 26088.478230435663, 27137.59293610558, 27306.726932730417, 27470.313242169104, 27505.587416189173, 31359.84320078385, 35182.47226291659, 35496.0, 36238.8188059058, 37132.814335928146, 5359.276497672764, 5526.50261476469, 5615.129654903497, 5675.8864822704145, 5851.297844258716, 8508.659653614033, 8538.701145460127, 8595.226429621363, 8693.261072808882, 8799.604017819342, 7969.402294827795, 8104.716334928249, 8167.959160204161, 8366.748997530083, 8390.202930721573, 7732.342750866239, 7970.0374531835205, 8224.83550329002, 8241.79395515117, 8692.217700406994, 7971.362291016821, 8053.0, 8211.71259005932, 8247.298979586802, 8389.161083891562, 6705.262421133574, 6826.385625293748, 6871.793846184622, 7059.6558355503985, 7305.926940730525, 6115.449609535163, 6456.806295811133, 6518.087467754423, 7171.605561694157, 7238.8914166288605]}, "summary": {"lowerIsBetter": false, "suite": 5018.097728222797, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 4985.347673762448, "unit": "ms", "value": 4985.347673762448}, "dojo.html": {"lowerIsBetter": false, "filtered": 4058.1663924772643, "unit": "ms", "value": 4058.1663924772643}, "mootools.html": {"lowerIsBetter": false, "filtered": 3376.0151935640533, "unit": "ms", "value": 3376.0151935640533}, "ext.html": {"lowerIsBetter": false, "filtered": 14348.584574206385, "unit": "ms", "value": 14348.584574206385}, "prototype.html": {"lowerIsBetter": false, "filtered": 3694.310506864841, "unit": "ms", "value": 3694.310506864841}, "yui.html": {"lowerIsBetter": false, "filtered": 4409.737599883713, "unit": "ms", "value": 4409.737599883713}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0066"}, "testrun": {"date": 1447613780, "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": "20151115091233", "branch": "Firefox", "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf"}}, {"talos_counters": {}, "results": {"audio-dft": [206.0, 205.0, 215.0, 215.0, 219.0, 216.0, 216.0, 217.0, 216.0, 217.0], "ai-astar": [137.0, 137.0, 136.0, 141.0, 145.0, 146.0, 146.0, 147.0, 146.0, 161.0], "imaging-gaussian-blur": [149.0, 164.0, 156.0, 164.0, 157.0, 156.0, 156.0, 154.0, 149.0, 148.0], "audio-beat-detection": [198.0, 166.0, 203.0, 219.0, 171.0, 202.0, 198.0, 171.0, 230.0, 180.0], "json-stringify-tinderbox": [84.0, 88.0, 88.0, 88.0, 90.0, 90.0, 90.0, 94.0, 94.0, 95.0], "stanford-crypto-pbkdf2": [181.0, 195.0, 194.0, 204.0, 203.0, 189.0, 207.0, 197.0, 206.0, 210.0], "json-parse-financial": [71.0, 75.0, 77.0, 76.0, 76.0, 75.0, 75.0, 77.0, 79.0, 80.0], "stanford-crypto-sha256-iterative": [91.0, 90.0, 90.0, 90.0, 96.0, 96.0, 95.0, 94.0, 95.0, 96.0], "audio-fft": [101.0, 99.0, 108.0, 155.0, 90.0, 93.0, 94.0, 94.0, 155.0, 88.0], "imaging-darkroom": [163.0, 163.0, 170.0, 171.0, 172.0, 170.0, 170.0, 171.0, 169.0, 162.0], "stanford-crypto-ccm": [158.0, 166.0, 167.0, 168.0, 177.0, 168.0, 170.0, 175.0, 189.0, 177.0], "audio-oscillator": [128.0, 127.0, 172.0, 115.0, 120.0, 120.0, 167.0, 119.0, 118.0, 169.0], "stanford-crypto-aes": [108.0, 111.0, 110.0, 114.0, 115.0, 115.0, 115.0, 115.0, 127.0, 119.0], "imaging-desaturate": [121.0, 137.0, 126.0, 136.0, 126.0, 136.0, 126.0, 136.0, 136.0, 144.0]}, "summary": {"lowerIsBetter": true, "suite": 1995.6999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 107.7, "unit": "ms", "value": 107.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 198.6, "unit": "ms", "value": 198.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 193.8, "unit": "ms", "value": 193.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 171.5, "unit": "ms", "value": 171.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 168.1, "unit": "ms", "value": 168.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 76.1, "unit": "ms", "value": 76.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 135.5, "unit": "ms", "value": 135.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 144.2, "unit": "ms", "value": 144.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 214.2, "unit": "ms", "value": 214.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 93.3, "unit": "ms", "value": 93.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 90.1, "unit": "ms", "value": 90.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 155.3, "unit": "ms", "value": 155.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 114.9, "unit": "ms", "value": 114.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 132.4, "unit": "ms", "value": 132.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0066"}, "testrun": {"date": 1447613780, "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": "20151115091233", "branch": "Firefox", "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf"}}, {"talos_counters": {}, "results": {"DeltaBlue": [259.4706798131811], "Encrypt": [413.0524576621231], "NavierStokes": [7633.587786259542], "Decrypt": [7700.0], "Splay": [899.9106344950849], "Richards": [219.53896816684963], "RegExp": [38961.53846153846], "Earley": [1097.694840834248], "Boyer": [17413.793103448275], "RayTrace": [2566.6666666666665]}, "summary": {"lowerIsBetter": false, "suite": 13886.075210014278, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 254.81877199999994, "unit": "score", "value": 254.81877199999994}, "Encrypt": {"lowerIsBetter": false, "filtered": 644.4242009999999, "unit": "score", "value": 644.4242009999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 194.404, "unit": "score", "value": 194.404}, "Decrypt": {"lowerIsBetter": false, "filtered": 34.568961038961056, "unit": "score", "value": 34.568961038961056}, "Splay": {"lowerIsBetter": false, "filtered": 90.5545471698113, "unit": "score", "value": 90.5545471698113}, "RegExp": {"lowerIsBetter": false, "filtered": 23.381648568608078, "unit": "score", "value": 23.381648568608078}, "Richards": {"lowerIsBetter": false, "filtered": 160.80061000000003, "unit": "score", "value": 160.80061000000003}, "Earley": {"lowerIsBetter": false, "filtered": 607.1477930000003, "unit": "score", "value": 607.1477930000003}, "Boyer": {"lowerIsBetter": false, "filtered": 38.2721326732673, "unit": "score", "value": 38.2721326732673}, "RayTrace": {"lowerIsBetter": false, "filtered": 288.30740259740264, "unit": "score", "value": 288.30740259740264}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0066"}, "testrun": {"date": 1447613780, "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": "20151115091233", "branch": "Firefox", "revision": "7cd2d806bd069c0260ff73f023ac85f892b863bf"}}] 11:16:45 INFO - RETURN: dromaeo_css: 5018.10 11:16:45 INFO - RETURN: kraken: 1995.70 11:16:45 INFO - RETURN: v8_7: 13886.08 11:16:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "13886.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1995.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5018.10"}}} 11:16:45 INFO - Return code: 0 11:16:45 INFO - # TBPL SUCCESS # 11:16:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:16:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:16:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:16:45 INFO - 2015-11-15 11:16:45.643 screenresolution[1953:14091] starting screenresolution argv=screenresolution get 11:16:45 INFO - 2015-11-15 11:16:45.647 screenresolution[1953:14091] Display 0: 1600x1200x32@60 11:16:45 INFO - 2015-11-15 11:16:45.655 screenresolution[1954:14093] starting screenresolution argv=screenresolution list 11:16:45 INFO - Available Modes on Display 0 11:16:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:16:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:16:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:16:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:16:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:16:45 INFO - Intel HD Graphics 3000: 11:16:45 INFO - Chipset Model: Intel HD Graphics 3000 11:16:45 INFO - Type: GPU 11:16:45 INFO - Bus: Built-In 11:16:45 INFO - VRAM (Total): 512 MB 11:16:45 INFO - VRAM (Dynamic, Max): 10 11:16:45 INFO - Vendor: Intel (0x8086) 11:16:45 INFO - Device ID: 0x0116 11:16:45 INFO - Revision ID: 0x0009 11:16:45 INFO - Displays: 11:16:45 INFO - Display: 11:16:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:16:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:16:45 INFO - Display Serial Number: 1600x1200 60 11:16:45 INFO - Main Display: Yes 11:16:45 INFO - Mirror: Off 11:16:45 INFO - Online: Yes 11:16:45 INFO - Rotation: Supported 11:16:45 INFO - Return code: 0 11:16:45 INFO - Running post-action listener: _resource_record_post_action 11:16:45 INFO - Running post-run listener: _resource_record_post_run 11:16:47 INFO - Total resource usage - Wall time: 1272s; CPU: 30.0%; Read bytes: 4739072; Write bytes: 691560448; Read time: 1517; Write time: 56635 11:16:47 INFO - install - Wall time: 46s; CPU: 30.0%; Read bytes: 342049280; Write bytes: 344041472; Read time: 41131; Write time: 7261 11:16:47 INFO - run-tests - Wall time: 1226s; CPU: 30.0%; Read bytes: 4734976; Write bytes: 345929728; Read time: 1487; Write time: 49332 11:16:47 INFO - Running post-run listener: _upload_blobber_files 11:16:47 INFO - Blob upload gear active. 11:16:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:16:47 INFO - Copying logs to upload dir... 11:16:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1331.408507 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 11 secs) (at 2015-11-15 11:16:47.155893) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:16:47.159031) ========= 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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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/JD7ncMUoQhqnGs3SRW83ZA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011597 build_url: 'https://queue.taskcluster.net/v1/task/JD7ncMUoQhqnGs3SRW83ZA/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 11:16:47.188200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:16:47.188513) ========= 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.YC7BvSZPyw/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.bwgvfdeKUT/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.006394 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:16:47.241329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 11:16:47.242099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 11:16:47.242964) ========= ========= Total master_lag: 7.69 =========