builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0056 starttime: 1447656325.46 results: success (0) buildid: 20151115213439 builduid: a17be6eb4b144d4babbfcf7a2d25462e revision: 25836f531c30e3119d41d69b71e8c4daccb85f85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.458317) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.458743) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.459128) ========= 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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners TMPDIR=/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/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.006353 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.568125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.568435) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.650505) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.650927) ========= 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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners TMPDIR=/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/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.005681 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.711547) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.711858) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.712537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.712823) ========= 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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners TMPDIR=/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-15 22:45:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.2M=0.001s 2015-11-15 22:45:25 (16.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220175 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.962115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:25.962478) ========= 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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners TMPDIR=/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/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.022820 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:26.013764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:26.014143) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 25836f531c30e3119d41d69b71e8c4daccb85f85 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 25836f531c30e3119d41d69b71e8c4daccb85f85 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p4ReIkM2ec/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.7FqNc4KFh6/Listeners TMPDIR=/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-15 22:45:26,098 truncating revision to first 12 chars 2015-11-15 22:45:26,098 Setting DEBUG logging. 2015-11-15 22:45:26,098 attempt 1/10 2015-11-15 22:45:26,098 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/25836f531c30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 22:45:26,353 unpacking tar archive at: mozilla-inbound-25836f531c30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:26.646771) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:26.647181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:26.674648) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:26.675035) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 22:45:26.675620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 41 secs) (at 2015-11-15 22:45:26.676061) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p4ReIkM2ec/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.7FqNc4KFh6/Listeners TMPDIR=/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 22:45:26 INFO - MultiFileLogger online at 20151115 22:45:26 in /builds/slave/test 22:45:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:45:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:45:26 INFO - {'append_to_log': False, 22:45:26 INFO - 'base_work_dir': '/builds/slave/test', 22:45:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:45:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:45:26 INFO - 'branch': 'Mozilla-Inbound', 22:45:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:45:26 INFO - 'config_files': ('talos/mac_config.py',), 22:45:26 INFO - 'default_actions': ('clobber', 22:45:26 INFO - 'read-buildbot-config', 22:45:26 INFO - 'download-and-extract', 22:45:26 INFO - 'populate-webroot', 22:45:26 INFO - 'create-virtualenv', 22:45:26 INFO - 'install', 22:45:26 INFO - 'run-tests'), 22:45:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:45:26 INFO - 'download_minidump_stackwalk': True, 22:45:26 INFO - 'download_symbols': 'ondemand', 22:45:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:45:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:45:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:45:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:45:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:45:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:45:26 INFO - 'installer_path': 'installer.exe', 22:45:26 INFO - 'log_level': 'info', 22:45:26 INFO - 'log_name': 'talos', 22:45:26 INFO - 'log_to_console': True, 22:45:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:45:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:45:26 INFO - 'opt_config_files': (), 22:45:26 INFO - 'pip_index': False, 22:45:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:45:26 INFO - 'cmd': ('bash', 22:45:26 INFO - '-c', 22:45:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:45:26 INFO - 'enabled': True, 22:45:26 INFO - 'halt_on_failure': False, 22:45:26 INFO - 'name': 'check_screen_resolution'},), 22:45:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:45:26 INFO - 'cmd': ('bash', 22:45:26 INFO - '-c', 22:45:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:45:26 INFO - 'enabled': True, 22:45:26 INFO - 'halt_on_failure': False, 22:45:26 INFO - 'name': 'check_screen_resolution'},), 22:45:26 INFO - 'run_cmd_checks_enabled': True, 22:45:26 INFO - 'sps_profile': False, 22:45:26 INFO - 'sps_profile_interval': 0, 22:45:26 INFO - 'suite': 'dromaeojs', 22:45:26 INFO - 'system_bits': '64', 22:45:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:45:26 INFO - 'title': 't-yosemite-r5-0056', 22:45:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:45:26 INFO - 'use_talos_json': True, 22:45:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:45:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:45:26 INFO - 'work_dir': 'build'} 22:45:26 INFO - ##### 22:45:26 INFO - ##### Running clobber step. 22:45:26 INFO - ##### 22:45:26 INFO - Running pre-action listener: _resource_record_pre_action 22:45:26 INFO - Running main action method: clobber 22:45:26 INFO - rmtree: /builds/slave/test/build 22:45:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:45:29 INFO - Running post-action listener: _resource_record_post_action 22:45:29 INFO - ##### 22:45:29 INFO - ##### Running read-buildbot-config step. 22:45:29 INFO - ##### 22:45:29 INFO - Running pre-action listener: _resource_record_pre_action 22:45:29 INFO - Running main action method: read_buildbot_config 22:45:29 INFO - Using buildbot properties: 22:45:29 INFO - { 22:45:29 INFO - "properties": { 22:45:29 INFO - "buildnumber": 3296, 22:45:29 INFO - "product": "firefox", 22:45:29 INFO - "script_repo_revision": "production", 22:45:29 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 22:45:29 INFO - "repository": "", 22:45:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 22:45:29 INFO - "buildid": "20151115213439", 22:45:29 INFO - "slavename": "t-yosemite-r5-0056", 22:45:29 INFO - "pgo_build": "False", 22:45:29 INFO - "basedir": "/builds/slave/test", 22:45:29 INFO - "project": "", 22:45:29 INFO - "platform": "yosemite", 22:45:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:45:29 INFO - "slavebuilddir": "test", 22:45:29 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 22:45:29 INFO - "branch": "mozilla-inbound", 22:45:29 INFO - "repo_path": "integration/mozilla-inbound", 22:45:29 INFO - "stage_platform": "macosx64", 22:45:29 INFO - "builduid": "a17be6eb4b144d4babbfcf7a2d25462e", 22:45:29 INFO - "revision": "25836f531c30e3119d41d69b71e8c4daccb85f85" 22:45:29 INFO - }, 22:45:29 INFO - "sourcestamp": { 22:45:29 INFO - "repository": "", 22:45:29 INFO - "hasPatch": false, 22:45:29 INFO - "project": "", 22:45:29 INFO - "branch": "mozilla-inbound-macosx64-talos", 22:45:29 INFO - "changes": [ 22:45:29 INFO - { 22:45:29 INFO - "category": null, 22:45:29 INFO - "files": [ 22:45:29 INFO - { 22:45:29 INFO - "url": null, 22:45:29 INFO - "name": "https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 22:45:29 INFO - } 22:45:29 INFO - ], 22:45:29 INFO - "repository": "", 22:45:29 INFO - "rev": "25836f531c30e3119d41d69b71e8c4daccb85f85", 22:45:29 INFO - "who": "nnethercote@mozilla.com", 22:45:29 INFO - "when": 1447656315, 22:45:29 INFO - "number": 6664993, 22:45:29 INFO - "comments": "Bug 1224482 (part 7) - Make GetScaledScreenBounds() return a CSSIntRect. r=kats.\n\nAlso changes mOriginalBounds to a CSSIntRect*.", 22:45:29 INFO - "project": "", 22:45:29 INFO - "at": "Sun 15 Nov 2015 22:45:15", 22:45:29 INFO - "branch": "mozilla-inbound-macosx64-talos", 22:45:29 INFO - "revlink": "", 22:45:29 INFO - "properties": [ 22:45:29 INFO - [ 22:45:29 INFO - "buildid", 22:45:29 INFO - "20151115213439", 22:45:29 INFO - "Change" 22:45:29 INFO - ], 22:45:29 INFO - [ 22:45:29 INFO - "builduid", 22:45:29 INFO - "a17be6eb4b144d4babbfcf7a2d25462e", 22:45:29 INFO - "Change" 22:45:29 INFO - ], 22:45:29 INFO - [ 22:45:29 INFO - "pgo_build", 22:45:29 INFO - "False", 22:45:29 INFO - "Change" 22:45:29 INFO - ] 22:45:29 INFO - ], 22:45:29 INFO - "revision": "25836f531c30e3119d41d69b71e8c4daccb85f85" 22:45:29 INFO - } 22:45:29 INFO - ], 22:45:29 INFO - "revision": "25836f531c30e3119d41d69b71e8c4daccb85f85" 22:45:29 INFO - } 22:45:29 INFO - } 22:45:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 22:45:29 INFO - Running post-action listener: _resource_record_post_action 22:45:29 INFO - ##### 22:45:29 INFO - ##### Running download-and-extract step. 22:45:29 INFO - ##### 22:45:29 INFO - Running pre-action listener: _resource_record_pre_action 22:45:29 INFO - Running main action method: download_and_extract 22:45:29 INFO - mkdir: /builds/slave/test/build/tests 22:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:45:29 INFO - https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/test_packages.json 22:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/test_packages.json 22:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:45:36 INFO - Downloaded 1149 bytes. 22:45:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:45:36 INFO - Using the following test package requirements: 22:45:36 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:45:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:45:36 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 22:45:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:45:36 INFO - u'jsshell-mac.zip'], 22:45:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:45:36 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 22:45:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:45:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:45:36 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 22:45:36 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:45:36 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 22:45:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:45:36 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 22:45:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:45:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:45:36 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 22:45:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:45:36 INFO - https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:45:40 INFO - Downloaded 17464021 bytes. 22:45: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 22:45:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:45:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:45:53 INFO - Return code: 0 22:45:53 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:45: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')]} 22:45:53 INFO - https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:45:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:45:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:45:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:45:56 INFO - Downloaded 17464021 bytes. 22:45:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 22:45:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:45:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:46:09 INFO - Return code: 0 22:46: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')]} 22:46:09 INFO - https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:46:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:46:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:46:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:46:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:46:10 INFO - Downloaded 11131693 bytes. 22:46:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 22:46:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:46:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:46:13 INFO - Return code: 0 22:46: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')]} 22:46:13 INFO - https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:46:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:46:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:46:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 22:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 22:46:21 INFO - Downloaded 108777536 bytes. 22:46:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:46:21 INFO - mkdir: /builds/slave/test/properties 22:46:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:46:21 INFO - Writing to file /builds/slave/test/properties/build_url 22:46:21 INFO - Contents: 22:46:21 INFO - build_url:https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:46:21 INFO - Running post-action listener: _resource_record_post_action 22:46:21 INFO - Running post-action listener: set_extra_try_arguments 22:46:21 INFO - ##### 22:46:21 INFO - ##### Running populate-webroot step. 22:46:21 INFO - ##### 22:46:21 INFO - Running pre-action listener: _resource_record_pre_action 22:46:21 INFO - Running main action method: populate_webroot 22:46:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:46:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:46:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:46:21 INFO - '../fennec_ids.txt'], 22:46:21 INFO - 'tests': ['tcheck2']}, 22:46:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:46:21 INFO - '--tppagecycles', 22:46:21 INFO - '7'], 22:46:21 INFO - 'tests': ['tsvgm']}}, 22:46:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:46:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:46:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:46:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:46:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:21 INFO - 'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:21 INFO - 'tests': ['damp', 'tps']}, 22:46:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:21 INFO - 'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['damp', 'tps']}, 22:46:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:46:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:46:21 INFO - 'other': {'tests': ['a11yr', 22:46:21 INFO - 'ts_paint', 22:46:21 INFO - 'tpaint', 22:46:21 INFO - 'sessionrestore', 22:46:21 INFO - 'sessionrestore_no_auto_restore']}, 22:46:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['a11yr', 22:46:21 INFO - 'ts_paint', 22:46:21 INFO - 'tpaint', 22:46:21 INFO - 'sessionrestore', 22:46:21 INFO - 'sessionrestore_no_auto_restore']}, 22:46:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['a11yr', 22:46:21 INFO - 'ts_paint', 22:46:21 INFO - 'tpaint', 22:46:21 INFO - 'sessionrestore', 22:46:21 INFO - 'sessionrestore_no_auto_restore']}, 22:46:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['a11yr', 22:46:21 INFO - 'ts_paint', 22:46:21 INFO - 'tpaint', 22:46:21 INFO - 'sessionrestore', 22:46:21 INFO - 'sessionrestore_no_auto_restore']}, 22:46:21 INFO - 'other_l64': {'tests': ['a11yr', 22:46:21 INFO - 'ts_paint', 22:46:21 INFO - 'tpaint', 22:46:21 INFO - 'sessionrestore', 22:46:21 INFO - 'sessionrestore_no_auto_restore']}, 22:46:21 INFO - 'other_nol64': {'tests': ['a11yr', 22:46:21 INFO - 'ts_paint', 22:46:21 INFO - 'tpaint', 22:46:21 INFO - 'sessionrestore', 22:46:21 INFO - 'sessionrestore_no_auto_restore']}, 22:46:21 INFO - 'svgr': {'tests': ['tsvgx', 22:46:21 INFO - 'tsvgr_opacity', 22:46:21 INFO - 'tart', 22:46:21 INFO - 'tscrollx', 22:46:21 INFO - 'cart']}, 22:46:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['tsvgx', 22:46:21 INFO - 'tsvgr_opacity', 22:46:21 INFO - 'tart', 22:46:21 INFO - 'tscrollx', 22:46:21 INFO - 'cart']}, 22:46:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:21 INFO - 'tests': ['tp5o']}, 22:46:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:21 INFO - 'talos_options': ['--e10s'], 22:46:21 INFO - 'tests': ['tp5o']}, 22:46:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:21 INFO - 'talos_options': ['--xperf_path', 22:46:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:21 INFO - 'tests': ['tp5n']}, 22:46:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:21 INFO - 'talos_options': ['--e10s', 22:46:21 INFO - '--xperf_path', 22:46:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:21 INFO - 'tests': ['tp5n']}}, 22:46:21 INFO - 'talos.zip': {'path': '', 22:46:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:46:21 INFO - Running post-action listener: _resource_record_post_action 22:46:21 INFO - ##### 22:46:21 INFO - ##### Running create-virtualenv step. 22:46:21 INFO - ##### 22:46:21 INFO - Running pre-action listener: _resource_record_pre_action 22:46:21 INFO - Running main action method: create_virtualenv 22:46:21 INFO - Creating virtualenv /builds/slave/test/build/venv 22:46:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:46:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:46:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:46:22 INFO - Using real prefix '/tools/python27' 22:46:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:46:23 INFO - Installing distribute.............................................................................................................................................................................................done. 22:46:27 INFO - Installing pip.................done. 22:46:27 INFO - Return code: 0 22:46:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103094490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103071228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c9d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fb79f0>, '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 0x102d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fab8c8>, '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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p4ReIkM2ec/Render', 22:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:27 INFO - 'HOME': '/Users/cltbld', 22:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:27 INFO - 'LOGNAME': 'cltbld', 22:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:27 INFO - 'MOZ_NO_REMOTE': '1', 22:46:27 INFO - 'NO_EM_RESTART': '1', 22:46:27 INFO - 'PAGER': '/bin/cat', 22:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:27 INFO - 'PWD': '/builds/slave/test', 22:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:27 INFO - 'SHELL': '/bin/bash', 22:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FqNc4KFh6/Listeners', 22:46:27 INFO - 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', 22:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:27 INFO - 'USER': 'cltbld', 22:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:27 INFO - 'XPC_FLAGS': '0x0', 22:46:27 INFO - 'XPC_SERVICE_NAME': '0', 22:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:46:28 INFO - Cleaning up... 22:46:28 INFO - Return code: 0 22:46:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x103094490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103071228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c9d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fb79f0>, '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 0x102d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fab8c8>, '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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p4ReIkM2ec/Render', 22:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:28 INFO - 'HOME': '/Users/cltbld', 22:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:28 INFO - 'LOGNAME': 'cltbld', 22:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:28 INFO - 'MOZ_NO_REMOTE': '1', 22:46:28 INFO - 'NO_EM_RESTART': '1', 22:46:28 INFO - 'PAGER': '/bin/cat', 22:46:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:28 INFO - 'PWD': '/builds/slave/test', 22:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:28 INFO - 'SHELL': '/bin/bash', 22:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FqNc4KFh6/Listeners', 22:46:28 INFO - 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', 22:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:28 INFO - 'USER': 'cltbld', 22:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:28 INFO - 'XPC_FLAGS': '0x0', 22:46:28 INFO - 'XPC_SERVICE_NAME': '0', 22:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:28 INFO - Downloading/unpacking psutil>=0.7.1 22:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:31 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:46:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:46:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:31 INFO - Installing collected packages: psutil 22:46:31 INFO - Running setup.py install for psutil 22:46:31 INFO - building 'psutil._psutil_osx' extension 22:46:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 22:46:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:46:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:46:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 22:46:32 INFO - building 'psutil._psutil_posix' extension 22:46:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 22:46:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:46:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:46:32 INFO - ^ 22:46:32 INFO - 1 warning generated. 22:46:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 22:46:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:32 INFO - Successfully installed psutil 22:46:32 INFO - Cleaning up... 22:46:32 INFO - Return code: 0 22:46:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103094490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103071228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c9d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fb79f0>, '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 0x102d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fab8c8>, '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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:46:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:46:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p4ReIkM2ec/Render', 22:46:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:32 INFO - 'HOME': '/Users/cltbld', 22:46:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:32 INFO - 'LOGNAME': 'cltbld', 22:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:32 INFO - 'MOZ_NO_REMOTE': '1', 22:46:32 INFO - 'NO_EM_RESTART': '1', 22:46:32 INFO - 'PAGER': '/bin/cat', 22:46:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:32 INFO - 'PWD': '/builds/slave/test', 22:46:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:32 INFO - 'SHELL': '/bin/bash', 22:46:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FqNc4KFh6/Listeners', 22:46:32 INFO - 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', 22:46:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:32 INFO - 'USER': 'cltbld', 22:46:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:32 INFO - 'XPC_FLAGS': '0x0', 22:46:32 INFO - 'XPC_SERVICE_NAME': '0', 22:46:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:46:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:46:36 INFO - Installing collected packages: mozsystemmonitor 22:46:36 INFO - Running setup.py install for mozsystemmonitor 22:46:36 INFO - Successfully installed mozsystemmonitor 22:46:36 INFO - Cleaning up... 22:46:36 INFO - Return code: 0 22:46:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:36 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 0x103094490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103071228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c9d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fb79f0>, '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 0x102d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fab8c8>, '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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:46:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:46:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p4ReIkM2ec/Render', 22:46:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:36 INFO - 'HOME': '/Users/cltbld', 22:46:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:36 INFO - 'LOGNAME': 'cltbld', 22:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:36 INFO - 'MOZ_NO_REMOTE': '1', 22:46:36 INFO - 'NO_EM_RESTART': '1', 22:46:36 INFO - 'PAGER': '/bin/cat', 22:46:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:36 INFO - 'PWD': '/builds/slave/test', 22:46:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:36 INFO - 'SHELL': '/bin/bash', 22:46:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FqNc4KFh6/Listeners', 22:46:36 INFO - 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', 22:46:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:36 INFO - 'USER': 'cltbld', 22:46:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:36 INFO - 'XPC_FLAGS': '0x0', 22:46:36 INFO - 'XPC_SERVICE_NAME': '0', 22:46:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:36 INFO - Downloading/unpacking blobuploader==1.2.4 22:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:39 INFO - Downloading blobuploader-1.2.4.tar.gz 22:46:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:46:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:46:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:40 INFO - Downloading docopt-0.6.1.tar.gz 22:46:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:46:41 INFO - Installing collected packages: blobuploader, requests, docopt 22:46:41 INFO - Running setup.py install for blobuploader 22:46:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:46:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:46:41 INFO - Running setup.py install for requests 22:46:42 INFO - Running setup.py install for docopt 22:46:42 INFO - Successfully installed blobuploader requests docopt 22:46:42 INFO - Cleaning up... 22:46:42 INFO - Return code: 0 22:46:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:42 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 0x103094490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103071228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c9d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fb79f0>, '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 0x102d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fab8c8>, '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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p4ReIkM2ec/Render', 22:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:42 INFO - 'HOME': '/Users/cltbld', 22:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:42 INFO - 'LOGNAME': 'cltbld', 22:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:42 INFO - 'MOZ_NO_REMOTE': '1', 22:46:42 INFO - 'NO_EM_RESTART': '1', 22:46:42 INFO - 'PAGER': '/bin/cat', 22:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:42 INFO - 'PWD': '/builds/slave/test', 22:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:42 INFO - 'SHELL': '/bin/bash', 22:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FqNc4KFh6/Listeners', 22:46:42 INFO - 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', 22:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:42 INFO - 'USER': 'cltbld', 22:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:42 INFO - 'XPC_FLAGS': '0x0', 22:46:42 INFO - 'XPC_SERVICE_NAME': '0', 22:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:46:42 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-wEQdoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:46:42 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-Yi034A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:46:42 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-P3KwQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:46:43 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-TFNLUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:46:43 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-rwUu4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:46:43 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-n1GZHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:46:43 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-qiDxOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:46:43 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-05Rizm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:46:43 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-TPNWei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:46:43 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-cUUZLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:46:44 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-jQaP2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:46:44 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-iIRREu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:46:44 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-WcEYjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:46:44 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-w1mX6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:44 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-1Cfy9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:46:44 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-RBbohe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:46:44 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-MrWul7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:46:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:46:45 INFO - Running setup.py install for manifestparser 22:46:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:46:45 INFO - Running setup.py install for mozcrash 22:46:45 INFO - Running setup.py install for mozdebug 22:46:45 INFO - Running setup.py install for mozdevice 22:46:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:46:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:46:45 INFO - Running setup.py install for mozfile 22:46:46 INFO - Running setup.py install for mozhttpd 22:46:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:46:46 INFO - Running setup.py install for mozinfo 22:46:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:46:46 INFO - Running setup.py install for mozInstall 22:46:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:46:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:46:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:46:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:46:46 INFO - Running setup.py install for mozleak 22:46:46 INFO - Running setup.py install for mozlog 22:46:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:46:47 INFO - Running setup.py install for moznetwork 22:46:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:46:47 INFO - Running setup.py install for mozprocess 22:46:47 INFO - Running setup.py install for mozprofile 22:46:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:46:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:46:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:46:47 INFO - Running setup.py install for mozrunner 22:46:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:46:47 INFO - Running setup.py install for mozscreenshot 22:46:48 INFO - Running setup.py install for moztest 22:46:48 INFO - Running setup.py install for mozversion 22:46:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:46:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:46:48 INFO - Cleaning up... 22:46:48 INFO - Return code: 0 22:46:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x103094490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103071228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c9d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fb79f0>, '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 0x102d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fab8c8>, '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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:46:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p4ReIkM2ec/Render', 22:46:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:48 INFO - 'HOME': '/Users/cltbld', 22:46:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:48 INFO - 'LOGNAME': 'cltbld', 22:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:48 INFO - 'MOZ_NO_REMOTE': '1', 22:46:48 INFO - 'NO_EM_RESTART': '1', 22:46:48 INFO - 'PAGER': '/bin/cat', 22:46:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:48 INFO - 'PWD': '/builds/slave/test', 22:46:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:48 INFO - 'SHELL': '/bin/bash', 22:46:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FqNc4KFh6/Listeners', 22:46:48 INFO - 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', 22:46:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:48 INFO - 'USER': 'cltbld', 22:46:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:48 INFO - 'XPC_FLAGS': '0x0', 22:46:48 INFO - 'XPC_SERVICE_NAME': '0', 22:46:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:46:48 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-bCQBDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:46:49 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-B__q9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:46:49 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-wGqOpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:46:49 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-TDbAtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:46:49 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-j7UJn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:46:49 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-L7ICyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:46:49 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-VU4TmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:46:49 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-kqcWsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:46:50 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-GBFKtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:46:50 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-sQJTU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:46:50 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-2_VAJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:46:50 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-1e6A8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:46:50 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-5lSy_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:46:50 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-0hzDdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:51 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-7lFXFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:46:51 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-zOJbmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:46:51 INFO - Running setup.py (path:/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/pip-HXzjrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:54 INFO - Downloading blessings-1.5.1.tar.gz 22:46:54 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:46:54 INFO - Installing collected packages: blessings 22:46:54 INFO - Running setup.py install for blessings 22:46:54 INFO - Successfully installed blessings 22:46:54 INFO - Cleaning up... 22:46:54 INFO - Return code: 0 22:46:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:46:54 INFO - Reading from file tmpfile_stdout 22:46:54 INFO - Current package versions: 22:46:54 INFO - blessings == 1.5.1 22:46:54 INFO - blobuploader == 1.2.4 22:46:54 INFO - docopt == 0.6.1 22:46:54 INFO - manifestparser == 1.1 22:46:54 INFO - mozInstall == 1.12 22:46:54 INFO - mozcrash == 0.16 22:46:54 INFO - mozdebug == 0.1 22:46:54 INFO - mozdevice == 0.47 22:46:54 INFO - mozfile == 1.2 22:46:54 INFO - mozhttpd == 0.7 22:46:54 INFO - mozinfo == 0.9 22:46:54 INFO - mozleak == 0.1 22:46:54 INFO - mozlog == 3.0 22:46:54 INFO - moznetwork == 0.27 22:46:54 INFO - mozprocess == 0.22 22:46:54 INFO - mozprofile == 0.27 22:46:54 INFO - mozrunner == 6.11 22:46:54 INFO - mozscreenshot == 0.1 22:46:54 INFO - mozsystemmonitor == 0.0 22:46:54 INFO - moztest == 0.7 22:46:54 INFO - mozversion == 1.4 22:46:54 INFO - psutil == 3.1.1 22:46:54 INFO - requests == 1.2.3 22:46:54 INFO - wsgiref == 0.1.2 22:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:55 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 0x103094490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103071228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c9d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fb79f0>, '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 0x102d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fab8c8>, '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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:46:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:46:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p4ReIkM2ec/Render', 22:46:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:55 INFO - 'HOME': '/Users/cltbld', 22:46:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:55 INFO - 'LOGNAME': 'cltbld', 22:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:55 INFO - 'MOZ_NO_REMOTE': '1', 22:46:55 INFO - 'NO_EM_RESTART': '1', 22:46:55 INFO - 'PAGER': '/bin/cat', 22:46:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:55 INFO - 'PWD': '/builds/slave/test', 22:46:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:55 INFO - 'SHELL': '/bin/bash', 22:46:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FqNc4KFh6/Listeners', 22:46:55 INFO - 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', 22:46:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:55 INFO - 'USER': 'cltbld', 22:46:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:55 INFO - 'XPC_FLAGS': '0x0', 22:46:55 INFO - 'XPC_SERVICE_NAME': '0', 22:46:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:46:55 INFO - Cleaning up... 22:46:55 INFO - Return code: 0 22:46:55 INFO - Running post-action listener: _resource_record_post_action 22:46:55 INFO - Running post-action listener: _start_resource_monitoring 22:46:55 INFO - Starting resource monitoring. 22:46:55 INFO - ##### 22:46:55 INFO - ##### Running install step. 22:46:55 INFO - ##### 22:46:55 INFO - Running pre-action listener: _resource_record_pre_action 22:46:55 INFO - Running main action method: install 22:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:46:55 INFO - Reading from file tmpfile_stdout 22:46:55 INFO - Detecting whether we're running mozinstall >=1.0... 22:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:46:55 INFO - Reading from file tmpfile_stdout 22:46:55 INFO - Output received: 22:46:55 INFO - Usage: mozinstall [options] installer 22:46:55 INFO - Options: 22:46:55 INFO - -h, --help show this help message and exit 22:46:55 INFO - -d DEST, --destination=DEST 22:46:55 INFO - Directory to install application into. [default: 22:46:55 INFO - "/builds/slave/test"] 22:46:55 INFO - --app=APP Application being installed. [default: firefox] 22:46:55 INFO - mkdir: /builds/slave/test/build/application 22:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:47:43 INFO - Reading from file tmpfile_stdout 22:47:43 INFO - Output received: 22:47:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:47:43 INFO - Running post-action listener: _resource_record_post_action 22:47:43 INFO - ##### 22:47:43 INFO - ##### Running run-tests step. 22:47:43 INFO - ##### 22:47:43 INFO - Running pre-action listener: _resource_record_pre_action 22:47:43 INFO - Running main action method: run_tests 22:47:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:47:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:47:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:47:43 INFO - 2015-11-15 22:47:43.202 screenresolution[2006:17924] starting screenresolution argv=screenresolution get 22:47:43 INFO - 2015-11-15 22:47:43.206 screenresolution[2006:17924] Display 0: 1600x1200x32@60 22:47:43 INFO - 2015-11-15 22:47:43.213 screenresolution[2007:17926] starting screenresolution argv=screenresolution list 22:47:43 INFO - Available Modes on Display 0 22:47:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:47:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:47:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:47:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:47:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:47:43 INFO - Intel HD Graphics 3000: 22:47:43 INFO - Chipset Model: Intel HD Graphics 3000 22:47:43 INFO - Type: GPU 22:47:43 INFO - Bus: Built-In 22:47:43 INFO - VRAM (Total): 512 MB 22:47:43 INFO - VRAM (Dynamic, Max): 10 22:47:43 INFO - Vendor: Intel (0x8086) 22:47:43 INFO - Device ID: 0x0116 22:47:43 INFO - Revision ID: 0x0009 22:47:43 INFO - Displays: 22:47:43 INFO - Display: 22:47:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:47:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:47:43 INFO - Display Serial Number: 1600x1200 60 22:47:43 INFO - Main Display: Yes 22:47:43 INFO - Mirror: Off 22:47:43 INFO - Online: Yes 22:47:43 INFO - Rotation: Supported 22:47:43 INFO - Return code: 0 22:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:47:43 INFO - Python 2.7.3 22:47:43 INFO - Return code: 0 22:47:43 INFO - grabbing minidump binary from tooltool 22:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:43 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 0x102fb79f0>, '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 0x102d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102fab8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:47:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:47:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 22:47:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:47:43 INFO - Return code: 0 22:47:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:47:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:47:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:47:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:47:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0056', '--webServer', 'localhost'] in /builds/slave/test/build 22:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0056 --webServer localhost 22:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p4ReIkM2ec/Render', 22:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:47:43 INFO - 'HOME': '/Users/cltbld', 22:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:47:43 INFO - 'LOGNAME': 'cltbld', 22:47:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:47:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:43 INFO - 'MOZ_NO_REMOTE': '1', 22:47:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:47:43 INFO - 'NO_EM_RESTART': '1', 22:47:43 INFO - 'PAGER': '/bin/cat', 22:47:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:43 INFO - 'PWD': '/builds/slave/test', 22:47:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:47:43 INFO - 'SHELL': '/bin/bash', 22:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FqNc4KFh6/Listeners', 22:47:43 INFO - 'TMPDIR': '/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/', 22:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:47:43 INFO - 'USER': 'cltbld', 22:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:43 INFO - 'XPC_FLAGS': '0x0', 22:47:43 INFO - 'XPC_SERVICE_NAME': '0', 22:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:47:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0056', '--webServer', 'localhost'] with output_timeout 3600 22:47:43 INFO - mozversion INFO | application_buildid: 20151115213439 22:47:43 INFO - mozversion INFO | application_changeset: 25836f531c30e3119d41d69b71e8c4daccb85f85 22:47:43 INFO - mozversion INFO | application_display_name: Nightly 22:47:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:47:43 INFO - mozversion INFO | application_name: Firefox 22:47:43 INFO - mozversion INFO | application_remotingname: firefox 22:47:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:47:43 INFO - mozversion INFO | application_vendor: Mozilla 22:47:43 INFO - mozversion INFO | application_version: 45.0a1 22:47:43 INFO - mozversion INFO | platform_buildid: 20151115213439 22:47:43 INFO - mozversion INFO | platform_changeset: 25836f531c30e3119d41d69b71e8c4daccb85f85 22:47:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:47:43 INFO - mozversion INFO | platform_version: 45.0a1 22:47:43 INFO - 2015-11-15 22:47:43,914 DEBUG : using testdate: 1447656463 22:47:43 INFO - 2015-11-15 22:47:43,914 DEBUG : actual date: 1447656463 22:47:43 INFO - 2015-11-15 22:47:43,993 INFO : starting webserver on 'localhost:50256' 22:47:43 INFO - 2015-11-15 22:47:43,994 INFO : Starting test suite t-yosemite-r5-0056 22:47:43 INFO - 2015-11-15 22:47:43,994 INFO : Starting test dromaeo_css 22:47:43 INFO - 2015-11-15 22:47:43,994 DEBUG : operating with platform_type : mac_ 22:47:43 INFO - 2015-11-15 22:47:43,995 INFO : Initialising browser for dromaeo_css test... 22:47:44 INFO - 2015-11-15 22:47:44,011 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/tmp_4hJ7o/profile http://localhost:50256/getInfo.html 22:47:47 INFO - 2015-11-15 22:47:47,275 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:47:47 INFO - 2015-11-15 22:47:47,276 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:47:47 INFO - 2015-11-15 22:47:47,277 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:47:47 INFO - 2015-11-15 22:47:47,277 DEBUG : BROWSER_OUTPUT: __metrics 22:47:47 INFO - 2015-11-15 22:47:47,295 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:47:48 INFO - 2015-11-15 22:47:48,159 INFO : Browser initialized. 22:47:48 INFO - 2015-11-15 22:47:48,159 INFO : Running cycle 1/1 for dromaeo_css test... 22:47:48 INFO - 2015-11-15 22:47:48,159 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/tmp_4hJ7o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:48:00 INFO - 2015-11-15 22:48:00,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 228265984 22:48:00 INFO - 2015-11-15 22:48:00,373 DEBUG : BROWSER_OUTPUT: 22:48:51 INFO - 2015-11-15 22:48:51,347 DEBUG : BROWSER_OUTPUT: 1447656531346 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] 22:51:01 INFO - 2015-11-15 22:51:01,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50256/tests/dromaeo/cssquery-ext.html) 22:51:03 INFO - 2015-11-15 22:51:03,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 423329792 22:51:03 INFO - 2015-11-15 22:51:03,792 DEBUG : BROWSER_OUTPUT: 22:54:07 INFO - 2015-11-15 22:54:07,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/dromaeo/cssquery-ext.html (next: http://localhost:50256/tests/dromaeo/cssquery-jquery.html) 22:54:07 INFO - 2015-11-15 22:54:07,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 363384832 22:54:07 INFO - 2015-11-15 22:54:07,652 DEBUG : BROWSER_OUTPUT: 22:57:10 INFO - 2015-11-15 22:57:10,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50256/tests/dromaeo/cssquery-mootools.html) 22:57:10 INFO - 2015-11-15 22:57:10,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 326758400 22:57:10 INFO - 2015-11-15 22:57:10,598 DEBUG : BROWSER_OUTPUT: 23:00:12 INFO - 2015-11-15 23:00:12,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50256/tests/dromaeo/cssquery-prototype.html) 23:00:13 INFO - 2015-11-15 23:00:13,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 317472768 23:00:13 INFO - 2015-11-15 23:00:13,400 DEBUG : BROWSER_OUTPUT: 23:03:16 INFO - 2015-11-15 23:03:16,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50256/tests/dromaeo/cssquery-yui.html) 23:03:17 INFO - 2015-11-15 23:03:17,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 317325312 23:03:17 INFO - 2015-11-15 23:03:17,281 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/dromaeo/cssquery-yui.html (next: http://localhost:50256/tests/dromaeo/cssquery-dojo.html) 23:06:20 INFO - 2015-11-15 23:06:20,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 363700224 23:06:20 INFO - 2015-11-15 23:06:20,392 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,393 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:06:20 INFO - 2015-11-15 23:06:20,393 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:06:20 INFO - 2015-11-15 23:06:20,393 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:06:20 INFO - 2015-11-15 23:06:20,394 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:06:20 INFO - 2015-11-15 23:06:20,395 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2518.5214809186255;2582.5222333868246;2586.249987503624;2614.673165854268;2629.0666813281287;4050.392441133831;4267.210566045276;4302.333138363555;4353.521112677607;4399.384086227927;4246.978765106178;4391.9121617567625;4412.536683648219;4484.148011877741;4537.4328208973875;3982.3030969580354;3989.9800500997453;4017.216642754664;4038.5759495253014;4124.773137477438;3797.4742947782393;3990.102226998931;4064.2887494688457;4120.855770048049;4171.186618609372;3850.0952276215066;3863.6715879150024;3944.3886197639413;4027.0536423940353;4059.1881623675235;3895.61043895611;3982.263281292941;3994.141259629194;4017.7589344639414;4068.2677118118727;3917.5103112110987;3960.0495880988356;3999.960000399988;4010.418489319062;4064.04494943688;4146.087860670647;4214.957850421487;4246.511651160125;4250.605055016349;4319.589638984291;4233.1322078973735;4367.737935723835;4380.145871555048;4496.078303947683;4577.22187228172;4670.1126785910565;4681.57865792077;4691.577758001797;4705.4588722296685;4757.976210118927;4030.717849750548;4346.065595896897;4356.629686476622;4356.8257269709175;4394.912101757979;4553.4991150973365;4651;4689;4731.881702957454;4814.181589129857;4474.865754027384;4530.388397566352;4538.410006699108;4539.886502837456;4645.047765208192;4505;4649.3026046093355;4705.670603057822;4706.552877476634;4760.119377915097;4464.55354464551;4501.279795232747;4523.683342166017;4564.201264778717;4575.359449677047;4496.842610508616;4508.278675411918;4545.704529205591;4579.015511665008;4623.260278355447;3487.4943133246043;3526.7354948378975;3530.805805680712;3604.8197590120913;3639.872604458831;3070.7696922730884;3188.2507610711464;3250.2686895448337;3251.1221970068423;3303.653116422789;4220.620144187038;4280.5505421930875;4305.763183024964;4314.482262128565;4347.891302717394;4616.099860527165;4634.21218392874;4649.139909116824;4701.412323459567;4732.455767586772;4171.645410140111;4182.330827067654;4239.618434340924;4297.699161058696;4372.344148377705;4001.579834117434;4044.4539987101953;4077.347624380085;4120.25835349634;4164.1879833432795;4559.658025648023;4657.254839225708;4670.906581868411;4731.810727570859;4750.168720473972;4518.186726389282;4584.312353146921;4606.88482787933;4641.953580464287;4737.455192652889;4683.180443422456;4691.7184968901975;4717.410323709536;4768.642351823558;4771.594414474808;4581.793819278208;4588.7476188808605;4640.048789997974;4640.93038604428;4665.836695715634;4416.536263692266;4506.977465112654;4510.639148868017;4556.17988762026;4689.765511724332;4485.05813779097;4501.887452813575;4523.276275795857;4552.590266875997;4581.106684196549;4455.866324010285;4492.326151077365;4498.415206023196;4558.566936141061;4571.497135315046;4383.890402739829;4424.004598965207;4428.446444194476;4434.933475997798;4435.3346997949275;4400.075984043387;4499.91000179988;4500.752458614807;4549.4768101667405;4555.1117532080925;4257.510386305491;4331.761753103609;4401.273789824643;4402.8679139625865;4501.752403617833 23:06:20 INFO - 2015-11-15 23:06:20,398 DEBUG : BROWSER_OUTPUT: |1;ext.html;446.6984785269944;459.79539105098223;463.6105671236161;473.16486401501345;487;24379;31480.370392592133;31752.99999999997;32226.35547289053;32331.353372932528;33817.32365352692;34043.659563404355;34377;34569.654303456955;34583.4812477813;6582.80251592453;6860.965695171517;7355.227701091375;7406.444516661245;7539.472236943416;6574.309697481767;8622.35332350073;8814.603342849587;8966.86549701755;8989.235914947238;8775.429597076201;8816.515091669955;8903.643854245822;8944.373893827435;8964.596593153292;6817.216020157695;6840;8675.522846243453;8820.691275805317;9004.999999999967;6666.966665166691;8421.49471031734;8663.220310172115;8823.602937867812;8837.779055523662;28748.13755587315;29245.415091698258;29631.703682963325;29743.553846692317;29762;2250.763669814662;2329.23135365329;2357.4695693468834;2748.1480740970364;2768.2387343480505;21570.56858862814;22068.558628827494;22542.887285563633;22795.658065129035;22988.88505557478;1812.238859678938;1843.4930394141584;1901.8858868467937;1930.845532357408;1939.1661585518223;217269;221039;221467;221759;222077;40792.18415631671;42592.14815703669;45942.540574593826;46112.53887461082;46373.536264637594;38548.6145138545;48973.08215342764;49358.75320623374;50299.74850125799;50383.74808126009;9398.483083430478;9628.951855240819;9727.902720972841;9825.950870245602;9830.655927042662;7071.575705457689;7128.750493732695;7144.749933752398;7265.709371625076;7266.164391094986;14751.77872331916;14839.40642374293;14879;15126.546203613909;15198;6956.79129626112;7196.64016799158;7223.530470519505;7355.080614923135;7384.298491643285;733.618518370455;742.6620887496176;750.4746677325894;806.2381049907898;936.6605753772035;22190.778092219192;22655.773442265698;23919.155456163502;24456.510869782862;24805.751942480707;831.243568352796;834.8854279536886;838.9278482149082;937.5031233446284;940.1538615246196;11282.435878206057;11407.867391640159;11512.481938312796;12124.211926224767;12521.436535355931;247432;251850;252925;253906;257778;42643;42757.358639620434;42911.35632965508;42926.78536607297;42934.35598465963;897.5243121145803;976.9609215631438;990.5493000684671;1065.8774240962077;1075.5482697267166;20796.89601552043;21193.78806211918;21532;22359.44101397478;22462.314808824765;33271.50092748659;34055.659443405246;34474.482882756274;35311.82344088263;35317.82341088381;184114;318355;327204;332203;333707;23443.531129376977;24297.149599763925;24300;24620.138295159584;24717.25848224556;31433.37133257368;31686.841565792023;31811.20471988219;31822.6817731829;32082.679173208904;26923.461530768884;27162.456750864476;27580.58629120605;27618.171454856387;28339.574906376834;26434.206973790817;26732.866335668197;26761.732382675924;27156.864215678794;27484.862575687792;27723.445531088862;28007;28188.85905570459;28253.43493130167;29020;21866.78133218711;23226.883865580563;23313.300600982;23579.41051473727;23745.762542374356;17871.374501892373;18041.66999920036;18424.723629145843;18646.627067458303;19490.512737181685 23:06:20 INFO - 2015-11-15 23:06:20,399 DEBUG : BROWSER_OUTPUT: |2;jquery.html;268.1406093470427;268.57967281204924;269.09315606406403;274.88180082564514;281.64794007490644;13579.253141077237;13756.58730238092;14278.571642850706;14348.35432405543;15221.619459513518;11115.944420277887;11334.149938754585;11833.940830295836;11853.466594003268;14809.333579988926;4254.723442976205;4497.955020449803;4505.43682039745;4547.454305483347;4557.475890272612;3675.044488433013;3821.388577827548;4444.933326000112;4484.372187893698;4518.70628409154;2688.8386696798257;2776.47247023066;2827.9293017674618;3768.6608205261523;3815.5039844820135;3871.05159235989;3874.089588946595;3908.687305015606;3923.7449565778134;3944.9408258876283;3272.280098378377;3287.112479630486;3322.285708572644;3330.4504756715114;3334.583177102862;9976.850347244797;10419.426931518763;10438.060574548252;10644.042036216777;10651.414172220524;1459.9489017884323;1516.5071351810595;1568.725473042213;1585.9762103568455;1626.6990606737672;7594.468387212897;7654.846903061907;7819.139894611588;7895.171007044235;7972.242636949481;1235.6416639174718;1269.320913311374;1274.3628185907046;1290.8192853000494;1301.4338762638188;42539.574604253874;43909.56090439087;44381.33427998583;44459.333110003376;44779.32831007505;5059.342285502861;5096.337476128154;5114.565261952701;5123.974380128076;5165.74171291434;5840.240768700127;5856.795012174553;5861.41385861419;5912.940870591325;5973.193618861398;3861.3242682530445;3883.5533913599734;3912.374020156818;3920.0199950012498;3968.8015599220503;3852.056246219694;3893.9875632335797;3903.4925459690626;3938.5076865391825;3993.281209382339;2286.1655495743935;2312.838101332924;2336.404216924673;2338.216697406388;2384.1059602649007;809.688270016048;810.4003037752021;825.2984962781708;842.2840585502397;883.4566741454088;339.1639608365391;344.6708393484217;348.73321908739837;353.17533559139184;380.9238152369482;8721.345899057596;9200.723978280663;9450.291228157916;9536.761580960532;9590.58832936843;344.9758516903793;353.43274045157665;353.45214916879246;375.2588637441032;378.2567255343264;4526.298423744325;4879.4388645305535;5001.974990125026;5089.185730283137;5101.336826212569;421625;425681;430987.1407715547;434195;438951;52010.739946300026;53425.73287133539;55045;55899.720501397234;56842.715786420806;395.41083785159907;403.6468090420882;406.57309824683966;407.35434336576265;413.80551140964303;8603.956980215058;8613.48319100856;8780.648774048967;8835.823283534422;8840.425372350777;26936.32659183536;27342.863285683445;27362.31594210081;27519.862400687867;28246;37420.81289593535;37894.431583525715;38135.42796858105;38207.23585528218;38533;4595.241785105421;4899.485554016919;4980.302757614009;4980.651354405157;5028.64799464034;9227.86158207614;9260.675876344296;9281.907180928105;9302;9415.858762118436;7827.569483678225;7934.880976785237;7999.640016199169;8109.432339736162;8200.917990820015;7712.845743084995;7766.262205090507;7798.298153166243;7912.0901096374655;8057.597120143852;8123.7156699515235;8376.87434688468;8391.202835730595;8479.024912134937;8593.52735599548;4922.237053256751;4926.950730492793;4934.309196712535;5018.84943451697;5025.949740502694;7844.882326764989;7981.122076571689;8109.148539403278;8189.877151842608;8358.916410835815 23:06:20 INFO - 2015-11-15 23:06:20,403 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1261.1361217565973;1361.652778541472;1428.7856821476778;1446.2696338349133;1511.4860947277923;5667.149927510875;6216.782412615565;6242.438180563749;6505.479561635069;6552.984287435455;6339.302676705559;6415.486761059115;6436.903446448296;6527.445167160785;6569.24453687826;1786.8302511261409;1790.8567314614832;1812.474382429094;1815.0108191035852;1819.8908065516046;1807.6023274879506;1838.1360760442572;1854.8701590888643;1861.4601765487992;1888.4712280561464;1767.6464707058576;1780.4302623160593;1781.8218178182142;1813.9637207255846;1823.6170404215131;1722.4832550234942;1766.9558261043449;1775.7336399540109;1792.9103544822706;1807.0693592799719;1776.6979613465742;1782.5454509100225;1787.2314904591021;1796.8203179682057;1825.1421831739062;5596.076647353182;6333.334999824998;6365.140706004677;6401.231852177769;6424.421802037839;3586.5158203642436;3717.20080182762;3760.097576581628;3795;3890.435886796427;2301.3326135420707;2336.824738144646;2363.314638754759;2403.579373609611;2405.9639105413435;688.8553403785211;703.0438603499236;704.376626685382;705.0693085127633;729.1578227147653;8293.709720159766;8361.289290410323;8390.496570205807;8489.278411335044;8498.320134389234;3479.6694314040124;3541.7874927503917;3604.0809593553477;3611.3860643690637;3693.095191678056;7410.147832999166;7441.739539116105;7496.512726672858;7557.5465472071855;7615.16233214346;4002.659773919191;4024.2555127301544;4025.3961905714377;4038.1721747042375;4050.7772072536295;3616.620254873253;3620.0587847159927;3635.163912300186;3692.2061756721896;3693.4275187346007;2908;2958.1717119206655;2979.642442906865;2989.2676294308035;3004.7596192304563;951.1392190068;974.7904200596905;975.7804493988938;989.3717489394287;991.3556188477403;783.6512751825383;799.5962039170182;802.1537278171469;804.2801692485193;957.3968399908014;5967.940320596826;6011.729472173675;6036.5170786336985;6079.574429789872;6113.510919126459;346.87859249262556;352.64559118086675;358.69869309779386;358.9533360663097;360.56551855014646;4585.6102231310715;4596.195665758479;4614.97692511542;4621.930671039937;4680.836170734008;6900.551464154814;7030.824229394204;7223.891641625275;7259.092613423322;7434;7292.088488938883;7380.741674041383;7387.741429050065;7525.849483010309;7536.849263014709;5526.751296191681;5999.220101386792;6022.54830887694;6026.306974697878;6084.847878803065;5939.3466718661775;5996.130561068708;6004.639721616717;6019.879602408015;6108.51131909455;6713.093732346266;6754.358335958076;6784.118064651564;6847.349501797321;6865.107536020286;6893.586384816927;6946.479014074066;7086.078809754699;7100.076989991268;7168.53404528704;5672.092465205547;5697.088465845611;5730.484256416942;5738.483536481736;5795.971020144872;6038.63768173911;6057.729775095695;6096.634201947897;6165.290991535851;6267.2479302484;5595.384507704231;5667.8866422672145;5699.971500142473;5736;5809.82570522885;5286;5537.944620553743;5662.207290979349;5715.114157305624;5797.652140871562;5273.894522109613;5297.496737809902;5311;5394.379646340564;5395.379531353788;4842.176829938849;4867.148249056472;4915.459299476983;4938.407391113089;4953.529414705597;4946.653734238569;4954.752262386938;4993.201087825931;5032.521910418504;5088.542031217208 23:06:20 INFO - 2015-11-15 23:06:20,404 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.80233516689395;255.48774706713039;261.96987346455165;263.4178465591043;264.0941570413481;4984.950150498498;5093.26147708582;5126.666766660164;5146.897062058762;5156.613254005951;4865.245886887538;4929.186684197103;4931.3835770528685;5040.546350828425;5097.949020509794;3794.165283637595;3830.157365379612;3854.9229015419673;3900.7854567998747;3912.2371137628174;3845.5962123977;3864;3876.7286289959716;3894.6689531389866;3921.5882282378466;3662.450632405134;3698.0569954661523;3718.3121122592406;3725.0501122213795;3894.4742459767854;3806.352920003606;3833.5974722654137;3850.306944749958;3859.459675645412;3895.7662540247393;3294.1435226841195;3310.9006729798143;3338.2655815720505;3342.9832850835833;3374.8818791342187;4888.657793954425;4912.042151780404;4968.3292755477905;4998.050370429607;5013.724245166514;4207.726497777635;4342.609165175118;4386.8025938832825;4456.621187199092;4461.620762235214;5302.973485132588;5323.068463018995;5324.787008519655;5359.5712343012465;5387.24578559002;3612.4942508048894;3616.059824445637;3621.3662609043577;3667.9083022924374;3672.6510981456718;5445.128779395317;5526.4197259288;5530.198121272393;5557.5553955683445;5636.323641163046;3581.247937933011;3672.081979505124;3675.246574452231;3682.3924052531033;3760.3231418344412;3703.370427027412;3752.5927777083593;3754.9061273468383;3760.3231418344963;3796.962030379716;4331.480222373272;4347.282698354799;4355.978220108879;4402.471703395613;4410.0738844842945;5315.149576067811;5319.015982043335;5338.3060202173465;5428.538574221236;5464.9180262296095;1305.1907817153426;1316.7366526694507;1321.7951217561294;1334.7130366971148;1336.472093523053;833.820728543366;865.8354912566718;872.5898827551041;884.2218847414234;888.0143041224236;5096.7767735743155;5111.718855462986;5134.666246693953;5205.115130427836;5213.921791173136;5519.365272993577;5525.392206857243;5538.695371754511;5684.261046063985;5694.943050569441;4882.340883980688;5039.82360617384;5114.207297868837;5124.052050370618;5144.845654630367;2922.795404321677;2963.2147480917574;2992.147238037149;3022.425739109562;3026.772992025607;5555.194496798023;5558.583106267046;5641.12562552805;5664.518515926193;5665.886682266331;5770.105633626795;5789.421057894177;5837.503812175928;5842.941570584325;5917.201177841022;5426.8914621707345;5631.352394474606;5667.914981275284;5771.538276937835;5788.971055144697;5609.158626206102;5621.9156712650165;5627.017680629273;5627.352854421794;5734.770609175586;5517.36550296721;5531.668099914018;5553.278073850373;5588.497035266845;5650.773969041193;5416.7562459688625;5643.097104463266;5695.430456954271;5726.255586773859;5739.799107031234;3597.6582224688614;3602.6037135914503;3608.963910360968;3683.72372072101;3704.036950392971;5613.522850557748;5622.634528755618;5626.156076588544;5645.915311270416;5677.574181936288;5472.753726082416;5482.23248745168;5511.696856672921;5524.502794748331;5576.888462230814;5223.660462069954;5427.294451721409;5435.918461223164;5500.724963751876;5531.557475401878;5325.680459172462;5349.411564727955;5362.785488580413;5413.998410294108;5414.620976531605;5448.809291674773;5476.6166368355425;5495.6153069284765;5499.587530935276;5559.8888022240135;5330.466953304638;5361.410244873139;5377.059014672495;5401.459854014567;5408.810691625774 23:06:20 INFO - 2015-11-15 23:06:20,407 DEBUG : BROWSER_OUTPUT: |5;yui.html;606.5420607441384;612.6446660936657;624.7251209467834;627.8524546731518;644.342770374218;10594.470276486174;10740.462976851166;10831.83752243717;10886.510107045182;10986.890131098686;10091.848622270654;10265.897341026588;10308.948455257712;10412.791744165132;10473.58105675774;546.0934848152068;567.690608618304;571.8570357410647;652.4910569755598;721.3940290156268;678.575890068707;692.6952141057918;698.1099098649212;700.250731717063;709.0215502606396;731.2614259597791;734.1557209209399;737.1191426245639;742.361569050616;750.2347605442445;576.2767726503232;576.7318197038355;578.9044807606782;712.9465290103263;744.8361360500681;529.6133822309697;532.51541097601;544.9727264107147;548.6817645765486;550.1555112901676;10434.478276086165;10537.63118290856;10582.682519524427;10618.73453163677;10672;8742.825143497095;8849.823003539957;8967.775805604846;9147.862782058208;9498.335116541844;6562.868742625121;6833.829154271133;6909.067275917737;7447.813804654927;7538.359239464652;2298.988505057464;2321.860688358687;2328.359701082199;2351.5532048910823;2432.6107822748454;36670.449943250875;37153.44269835955;37265.62734372649;37421.25157496835;37536.62463375386;5111.156659151198;5221.921671174935;5265.473452654781;5330.440303768126;5504.91742623861;9633.710988670351;9664.661736839176;9718.659846905324;9780.657676981271;9872.308938374388;4787.0904528139545;4910.165271903714;4963.156263435225;4999.525045120708;5190.273361729361;2969.4506516294555;3022.697730227004;3046.436409264249;3110.4867696830224;3160.383725173615;2149.9677504837127;2155.450360158181;2157.1479265689964;2199.9340019799433;2201.8458707890613;319.1685658858686;319.3772144318588;329.6308134888892;331.6202947624956;333.5497078943407;336.65661025753593;354.97160227181763;387.9844806207777;388.70458451577;407.9143379890256;5771.971140144273;6207.224096987877;6213.502919766408;6223.657698826608;6232.294617563815;399.70097184151507;407.1246819338387;417.19481400896564;436.4021290831581;454.8498995331533;3037.7417919477093;3195.9360812783616;3252.2837251257165;3306.6197387300285;3369.6124945631077;43627.78186109113;43886.78056609697;45510.54489455129;45668.314975275396;46512;38881;39488.2102357957;39745;39768.801155994035;40225.59774402277;39760.40359394612;39927;40017.39973900452;40124.398134028015;40978.38532422016;6356.269029061717;6620.437262832521;6736.360045795642;6834.179898412222;6887.621180835102;24408.51182976366;24444.388890277885;24522.75477245276;25029.123980660588;28195.731192095995;33865.66134338723;34013.82993085019;35518.11204719903;36282.8185859069;36350.8182459086;8391.832163356821;8633.39566230358;8642.22220000203;8645.697400591202;8789.252913502423;8884.333674974274;8977.685780997634;9005.459672419676;9218.196622225625;9386.296027797805;8274.875876861732;8417.789555261168;8506.532140732319;8592.097829728038;8811.559422029;8375.706850260212;8444.719574099294;8511.95744021276;8771.517566533646;8816.426932249384;5950.851228719317;7553.433492488195;7662.885056724042;8078.6364613593705;8946.150115738994;7010;7228.293777234984;7405.518641288514;7437.888431673638;7810.492317999312;7323.084614423197;7339.486235963432;7455.366293865082;7529;7682.500637458547 23:06:20 INFO - 2015-11-15 23:06:20,407 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:06:20 INFO - 2015-11-15 23:06:20,408 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:06:20 INFO - 2015-11-15 23:06:20,408 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1994 23:06:20 INFO - 2015-11-15 23:06:20,408 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:06:20 INFO - 2015-11-15 23:06:20,408 DEBUG : BROWSER_OUTPUT: __startTimestamp1447657580392__endTimestamp 23:06:20 INFO - 2015-11-15 23:06:20,408 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,409 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:06:20 INFO - 2015-11-15 23:06:20,409 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:06:20 INFO - 2015-11-15 23:06:20,409 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,409 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4287.11 Median:4416.54 stddev:457.76 (10.4%) stddev-sans-first:437.63 23:06:20 INFO - 2015-11-15 23:06:20,409 DEBUG : BROWSER_OUTPUT: Values: 2518.5 2582.5 2586.2 2614.7 2629.1 4050.4 4267.2 4302.3 4353.5 4399.4 4247.0 4391.9 4412.5 4484.1 4537.4 3982.3 3990.0 4017.2 4038.6 4124.8 3797.5 3990.1 4064.3 4120.9 4171.2 3850.1 3863.7 3944.4 4027.1 4059.2 3895.6 3982.3 3994.1 4017.8 4068.3 3917.5 3960.0 4000.0 4010.4 4064.0 4146.1 4215.0 4246.5 4250.6 4319.6 4233.1 4367.7 4380.1 4496.1 4577.2 4670.1 4681.6 4691.6 4705.5 4758.0 4030.7 4346.1 4356.6 4356.8 4394.9 4553.5 4651.0 4689.0 4731.9 4814.2 4474.9 4530.4 4538.4 4539.9 4645.0 4505.0 4649.3 4705.7 4706.6 4760.1 4464.6 4501.3 4523.7 4564.2 4575.4 4496.8 4508.3 4545.7 4579.0 4623.3 3487.5 3526.7 3530.8 3604.8 3639.9 3070.8 3188.3 3250.3 3251.1 3303.7 4220.6 4280.6 4305.8 4314.5 4347.9 4616.1 4634.2 4649.1 4701.4 4732.5 4171.6 4182.3 4239.6 4297.7 4372.3 4001.6 4044.5 4077.3 4120.3 4164.2 4559.7 4657.3 4670.9 4731.8 4750.2 4518.2 4584.3 4606.9 4642.0 4737.5 4683.2 4691.7 4717.4 4768.6 4771.6 4581.8 4588.7 4640.0 4640.9 4665.8 4416.5 4507.0 4510.6 4556.2 4689.8 4485.1 4501.9 4523.3 4552.6 4581.1 4455.9 4492.3 4498.4 4558.6 4571.5 4383.9 4424.0 4428.4 4434.9 4435.3 4400.1 4499.9 4500.8 4549.5 4555.1 4257.5 4331.8 4401.3 4402.9 4501.8 23:06:20 INFO - 2015-11-15 23:06:20,410 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,410 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38417.85 Median:175218.84 stddev:68859.40 (39.3%) stddev-sans-first:68993.55 23:06:20 INFO - 2015-11-15 23:06:20,411 DEBUG : BROWSER_OUTPUT: Values: 446.7 459.8 463.6 473.2 487.0 24379.0 31480.4 31753.0 32226.4 32331.4 33817.3 34043.7 34377.0 34569.7 34583.5 6582.8 6861.0 7355.2 7406.4 7539.5 6574.3 8622.4 8814.6 8966.9 8989.2 8775.4 8816.5 8903.6 8944.4 8964.6 6817.2 6840.0 8675.5 8820.7 9005.0 6667.0 8421.5 8663.2 8823.6 8837.8 28748.1 29245.4 29631.7 29743.6 29762.0 2250.8 2329.2 2357.5 2748.1 2768.2 21570.6 22068.6 22542.9 22795.7 22988.9 1812.2 1843.5 1901.9 1930.8 1939.2 217269.0 221039.0 221467.0 221759.0 222077.0 40792.2 42592.1 45942.5 46112.5 46373.5 38548.6 48973.1 49358.8 50299.7 50383.7 9398.5 9629.0 9727.9 9826.0 9830.7 7071.6 7128.8 7144.7 7265.7 7266.2 14751.8 14839.4 14879.0 15126.5 15198.0 6956.8 7196.6 7223.5 7355.1 7384.3 733.6 742.7 750.5 806.2 936.7 22190.8 22655.8 23919.2 24456.5 24805.8 831.2 834.9 838.9 937.5 940.2 11282.4 11407.9 11512.5 12124.2 12521.4 247432.0 251850.0 252925.0 253906.0 257778.0 42643.0 42757.4 42911.4 42926.8 42934.4 897.5 977.0 990.5 1065.9 1075.5 20796.9 21193.8 21532.0 22359.4 22462.3 33271.5 34055.7 34474.5 35311.8 35317.8 184114.0 318355.0 327204.0 332203.0 333707.0 23443.5 24297.1 24300.0 24620.1 24717.3 31433.4 31686.8 31811.2 31822.7 32082.7 26923.5 27162.5 27580.6 27618.2 28339.6 26434.2 26732.9 26761.7 27156.9 27484.9 27723.4 28007.0 28188.9 28253.4 29020.0 21866.8 23226.9 23313.3 23579.4 23745.8 17871.4 18041.7 18424.7 18646.6 19490.5 23:06:20 INFO - 2015-11-15 23:06:20,412 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,412 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21078.74 Median:432591.07 stddev:70434.10 (16.3%) stddev-sans-first:70614.35 23:06:20 INFO - 2015-11-15 23:06:20,413 DEBUG : BROWSER_OUTPUT: Values: 268.1 268.6 269.1 274.9 281.6 13579.3 13756.6 14278.6 14348.4 15221.6 11115.9 11334.1 11833.9 11853.5 14809.3 4254.7 4498.0 4505.4 4547.5 4557.5 3675.0 3821.4 4444.9 4484.4 4518.7 2688.8 2776.5 2827.9 3768.7 3815.5 3871.1 3874.1 3908.7 3923.7 3944.9 3272.3 3287.1 3322.3 3330.5 3334.6 9976.9 10419.4 10438.1 10644.0 10651.4 1459.9 1516.5 1568.7 1586.0 1626.7 7594.5 7654.8 7819.1 7895.2 7972.2 1235.6 1269.3 1274.4 1290.8 1301.4 42539.6 43909.6 44381.3 44459.3 44779.3 5059.3 5096.3 5114.6 5124.0 5165.7 5840.2 5856.8 5861.4 5912.9 5973.2 3861.3 3883.6 3912.4 3920.0 3968.8 3852.1 3894.0 3903.5 3938.5 3993.3 2286.2 2312.8 2336.4 2338.2 2384.1 809.7 810.4 825.3 842.3 883.5 339.2 344.7 348.7 353.2 380.9 8721.3 9200.7 9450.3 9536.8 9590.6 345.0 353.4 353.5 375.3 378.3 4526.3 4879.4 5002.0 5089.2 5101.3 421625.0 425681.0 430987.1 434195.0 438951.0 52010.7 53425.7 55045.0 55899.7 56842.7 395.4 403.6 406.6 407.4 413.8 8604.0 8613.5 8780.6 8835.8 8840.4 26936.3 27342.9 27362.3 27519.9 28246.0 37420.8 37894.4 38135.4 38207.2 38533.0 4595.2 4899.5 4980.3 4980.7 5028.6 9227.9 9260.7 9281.9 9302.0 9415.9 7827.6 7934.9 7999.6 8109.4 8200.9 7712.8 7766.3 7798.3 7912.1 8057.6 8123.7 8376.9 8391.2 8479.0 8593.5 4922.2 4927.0 4934.3 5018.8 5025.9 7844.9 7981.1 8109.1 8189.9 8358.9 23:06:20 INFO - 2015-11-15 23:06:20,413 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,413 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4385.78 Median:5664.68 stddev:2296.24 (40.5%) stddev-sans-first:2290.67 23:06:20 INFO - 2015-11-15 23:06:20,414 DEBUG : BROWSER_OUTPUT: Values: 1261.1 1361.7 1428.8 1446.3 1511.5 5667.1 6216.8 6242.4 6505.5 6553.0 6339.3 6415.5 6436.9 6527.4 6569.2 1786.8 1790.9 1812.5 1815.0 1819.9 1807.6 1838.1 1854.9 1861.5 1888.5 1767.6 1780.4 1781.8 1814.0 1823.6 1722.5 1767.0 1775.7 1792.9 1807.1 1776.7 1782.5 1787.2 1796.8 1825.1 5596.1 6333.3 6365.1 6401.2 6424.4 3586.5 3717.2 3760.1 3795.0 3890.4 2301.3 2336.8 2363.3 2403.6 2406.0 688.9 703.0 704.4 705.1 729.2 8293.7 8361.3 8390.5 8489.3 8498.3 3479.7 3541.8 3604.1 3611.4 3693.1 7410.1 7441.7 7496.5 7557.5 7615.2 4002.7 4024.3 4025.4 4038.2 4050.8 3616.6 3620.1 3635.2 3692.2 3693.4 2908.0 2958.2 2979.6 2989.3 3004.8 951.1 974.8 975.8 989.4 991.4 783.7 799.6 802.2 804.3 957.4 5967.9 6011.7 6036.5 6079.6 6113.5 346.9 352.6 358.7 359.0 360.6 4585.6 4596.2 4615.0 4621.9 4680.8 6900.6 7030.8 7223.9 7259.1 7434.0 7292.1 7380.7 7387.7 7525.8 7536.8 5526.8 5999.2 6022.5 6026.3 6084.8 5939.3 5996.1 6004.6 6019.9 6108.5 6713.1 6754.4 6784.1 6847.3 6865.1 6893.6 6946.5 7086.1 7100.1 7168.5 5672.1 5697.1 5730.5 5738.5 5796.0 6038.6 6057.7 6096.6 6165.3 6267.2 5595.4 5667.9 5700.0 5736.0 5809.8 5286.0 5537.9 5662.2 5715.1 5797.7 5273.9 5297.5 5311.0 5394.4 5395.4 4842.2 4867.1 4915.5 4938.4 4953.5 4946.7 4954.8 4993.2 5032.5 5088.5 23:06:20 INFO - 2015-11-15 23:06:20,414 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,414 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4483.71 Median:5145.87 stddev:1385.07 (26.9%) stddev-sans-first:1352.04 23:06:20 INFO - 2015-11-15 23:06:20,415 DEBUG : BROWSER_OUTPUT: Values: 251.8 255.5 262.0 263.4 264.1 4985.0 5093.3 5126.7 5146.9 5156.6 4865.2 4929.2 4931.4 5040.5 5097.9 3794.2 3830.2 3854.9 3900.8 3912.2 3845.6 3864.0 3876.7 3894.7 3921.6 3662.5 3698.1 3718.3 3725.1 3894.5 3806.4 3833.6 3850.3 3859.5 3895.8 3294.1 3310.9 3338.3 3343.0 3374.9 4888.7 4912.0 4968.3 4998.1 5013.7 4207.7 4342.6 4386.8 4456.6 4461.6 5303.0 5323.1 5324.8 5359.6 5387.2 3612.5 3616.1 3621.4 3667.9 3672.7 5445.1 5526.4 5530.2 5557.6 5636.3 3581.2 3672.1 3675.2 3682.4 3760.3 3703.4 3752.6 3754.9 3760.3 3797.0 4331.5 4347.3 4356.0 4402.5 4410.1 5315.1 5319.0 5338.3 5428.5 5464.9 1305.2 1316.7 1321.8 1334.7 1336.5 833.8 865.8 872.6 884.2 888.0 5096.8 5111.7 5134.7 5205.1 5213.9 5519.4 5525.4 5538.7 5684.3 5694.9 4882.3 5039.8 5114.2 5124.1 5144.8 2922.8 2963.2 2992.1 3022.4 3026.8 5555.2 5558.6 5641.1 5664.5 5665.9 5770.1 5789.4 5837.5 5842.9 5917.2 5426.9 5631.4 5667.9 5771.5 5789.0 5609.2 5621.9 5627.0 5627.4 5734.8 5517.4 5531.7 5553.3 5588.5 5650.8 5416.8 5643.1 5695.4 5726.3 5739.8 3597.7 3602.6 3609.0 3683.7 3704.0 5613.5 5622.6 5626.2 5645.9 5677.6 5472.8 5482.2 5511.7 5524.5 5576.9 5223.7 5427.3 5435.9 5500.7 5531.6 5325.7 5349.4 5362.8 5414.0 5414.6 5448.8 5476.6 5495.6 5499.6 5559.9 5330.5 5361.4 5377.1 5401.5 5408.8 23:06:20 INFO - 2015-11-15 23:06:20,416 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,416 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10451.26 Median:2937.71 stddev:12675.39 (431.5%) stddev-sans-first:12689.38 23:06:20 INFO - 2015-11-15 23:06:20,417 DEBUG : BROWSER_OUTPUT: Values: 606.5 612.6 624.7 627.9 644.3 10594.5 10740.5 10831.8 10886.5 10986.9 10091.8 10265.9 10308.9 10412.8 10473.6 546.1 567.7 571.9 652.5 721.4 678.6 692.7 698.1 700.3 709.0 731.3 734.2 737.1 742.4 750.2 576.3 576.7 578.9 712.9 744.8 529.6 532.5 545.0 548.7 550.2 10434.5 10537.6 10582.7 10618.7 10672.0 8742.8 8849.8 8967.8 9147.9 9498.3 6562.9 6833.8 6909.1 7447.8 7538.4 2299.0 2321.9 2328.4 2351.6 2432.6 36670.4 37153.4 37265.6 37421.3 37536.6 5111.2 5221.9 5265.5 5330.4 5504.9 9633.7 9664.7 9718.7 9780.7 9872.3 4787.1 4910.2 4963.2 4999.5 5190.3 2969.5 3022.7 3046.4 3110.5 3160.4 2150.0 2155.5 2157.1 2199.9 2201.8 319.2 319.4 329.6 331.6 333.5 336.7 355.0 388.0 388.7 407.9 5772.0 6207.2 6213.5 6223.7 6232.3 399.7 407.1 417.2 436.4 454.8 3037.7 3195.9 3252.3 3306.6 3369.6 43627.8 43886.8 45510.5 45668.3 46512.0 38881.0 39488.2 39745.0 39768.8 40225.6 39760.4 39927.0 40017.4 40124.4 40978.4 6356.3 6620.4 6736.4 6834.2 6887.6 24408.5 24444.4 24522.8 25029.1 28195.7 33865.7 34013.8 35518.1 36282.8 36350.8 8391.8 8633.4 8642.2 8645.7 8789.3 8884.3 8977.7 9005.5 9218.2 9386.3 8274.9 8417.8 8506.5 8592.1 8811.6 8375.7 8444.7 8512.0 8771.5 8816.4 5950.9 7553.4 7662.9 8078.6 8946.2 7010.0 7228.3 7405.5 7437.9 7810.5 7323.1 7339.5 7455.4 7529.0 7682.5 23:06:20 INFO - 2015-11-15 23:06:20,418 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:06:20 INFO - 2015-11-15 23:06:20,418 DEBUG : BROWSER_OUTPUT: 23:06:20 INFO - 2015-11-15 23:06:20,914 INFO : Browser exited with error code: 0 23:06:20 INFO - 2015-11-15 23:06:20,951 INFO : Completed test dromaeo_css (00:18:36) 23:06:20 INFO - 2015-11-15 23:06:20,951 INFO : Starting test kraken 23:06:20 INFO - 2015-11-15 23:06:20,951 DEBUG : operating with platform_type : mac_ 23:06:20 INFO - 2015-11-15 23:06:20,951 INFO : Initialising browser for kraken test... 23:06:20 INFO - 2015-11-15 23:06:20,968 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/tmp0DtTJ8/profile http://localhost:50256/getInfo.html 23:06:24 INFO - 2015-11-15 23:06:24,008 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:06:24 INFO - 2015-11-15 23:06:24,008 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:06:24 INFO - 2015-11-15 23:06:24,009 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:06:24 INFO - 2015-11-15 23:06:24,009 DEBUG : BROWSER_OUTPUT: __metrics 23:06:24 INFO - 2015-11-15 23:06:24,025 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:06:24 INFO - 2015-11-15 23:06:24,873 INFO : Browser initialized. 23:06:24 INFO - 2015-11-15 23:06:24,873 INFO : Running cycle 1/1 for kraken test... 23:06:24 INFO - 2015-11-15 23:06:24,874 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/tmp0DtTJ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:06:37 INFO - 2015-11-15 23:06:37,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 230137856 23:06:37 INFO - 2015-11-15 23:06:37,118 DEBUG : BROWSER_OUTPUT: 23:06:40 INFO - 2015-11-15 23:06:40,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50256/tests/kraken/driver.html?testName=audio-beat-detection) 23:06:40 INFO - 2015-11-15 23:06:40,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 285782016 23:06:40 INFO - 2015-11-15 23:06:40,723 DEBUG : BROWSER_OUTPUT: 23:06:43 INFO - 2015-11-15 23:06:43,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50256/tests/kraken/driver.html?testName=audio-dft) 23:06:44 INFO - 2015-11-15 23:06:44,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 298795008 23:06:44 INFO - 2015-11-15 23:06:44,515 DEBUG : BROWSER_OUTPUT: 23:06:48 INFO - 2015-11-15 23:06:48,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50256/tests/kraken/driver.html?testName=audio-fft) 23:06:48 INFO - 2015-11-15 23:06:48,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 284467200 23:06:48 INFO - 2015-11-15 23:06:48,604 DEBUG : BROWSER_OUTPUT: 23:06:51 INFO - 2015-11-15 23:06:51,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50256/tests/kraken/driver.html?testName=audio-oscillator) 23:06:51 INFO - 2015-11-15 23:06:51,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 285069312 23:06:51 INFO - 2015-11-15 23:06:51,685 DEBUG : BROWSER_OUTPUT: 23:06:54 INFO - 2015-11-15 23:06:54,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:06:54 INFO - 2015-11-15 23:06:54,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 284758016 23:06:54 INFO - 2015-11-15 23:06:54,836 DEBUG : BROWSER_OUTPUT: 23:06:58 INFO - 2015-11-15 23:06:58,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50256/tests/kraken/driver.html?testName=imaging-darkroom) 23:06:59 INFO - 2015-11-15 23:06:59,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 280952832 23:06:59 INFO - 2015-11-15 23:06:59,101 DEBUG : BROWSER_OUTPUT: 23:07:02 INFO - 2015-11-15 23:07:02,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50256/tests/kraken/driver.html?testName=imaging-desaturate) 23:07:03 INFO - 2015-11-15 23:07:03,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 279998464 23:07:03 INFO - 2015-11-15 23:07:03,528 DEBUG : BROWSER_OUTPUT: 23:07:06 INFO - 2015-11-15 23:07:06,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50256/tests/kraken/driver.html?testName=json-parse-financial) 23:07:07 INFO - 2015-11-15 23:07:07,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 282681344 23:07:07 INFO - 2015-11-15 23:07:07,499 DEBUG : BROWSER_OUTPUT: 23:07:09 INFO - 2015-11-15 23:07:09,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:07:09 INFO - 2015-11-15 23:07:09,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 318205952 23:07:09 INFO - 2015-11-15 23:07:09,873 DEBUG : BROWSER_OUTPUT: 23:07:12 INFO - 2015-11-15 23:07:12,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50256/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:07:12 INFO - 2015-11-15 23:07:12,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 318967808 23:07:12 INFO - 2015-11-15 23:07:12,629 DEBUG : BROWSER_OUTPUT: 23:07:15 INFO - 2015-11-15 23:07:15,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:07:15 INFO - 2015-11-15 23:07:15,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 321781760 23:07:15 INFO - 2015-11-15 23:07:15,686 DEBUG : BROWSER_OUTPUT: 23:07:18 INFO - 2015-11-15 23:07:18,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:07:19 INFO - 2015-11-15 23:07:19,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 323403776 23:07:19 INFO - 2015-11-15 23:07:19,410 DEBUG : BROWSER_OUTPUT: 23:07:22 INFO - 2015-11-15 23:07:22,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:07:23 INFO - 2015-11-15 23:07:23,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 324087808 23:07:23 INFO - 2015-11-15 23:07:23,135 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50256/tests/kraken/driver.html?testName=ai-astar) 23:07:25 INFO - 2015-11-15 23:07:25,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 387518464 23:07:25 INFO - 2015-11-15 23:07:25,400 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,401 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:07:25 INFO - 2015-11-15 23:07:25,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:07:25 INFO - 2015-11-15 23:07:25,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:07:25 INFO - 2015-11-15 23:07:25,402 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:07:25 INFO - 2015-11-15 23:07:25,402 DEBUG : BROWSER_OUTPUT: |0;ai-astar;131;136;139;137;139;133;132;139;138;153 23:07:25 INFO - 2015-11-15 23:07:25,402 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;195;166;195;206;164;190;188;163;207;163 23:07:25 INFO - 2015-11-15 23:07:25,402 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;207;204;205;196;197;208;207;204;197 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |3;audio-fft;92;102;107;152;86;88;89;91;142;84 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;119;120;172;115;115;115;154;113;113;150 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;148;149;155;155;141;148;155;148;141;149 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;163;162;162;157;162;165;160;155;162;162 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;117;121;130;120;130;120;120;130;120;120 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;68;73;72;72;76;76;75;76;76 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;85;84;89;89;90;90;90;90;86 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;108;108;109;110;109;108;108;110;121;109 23:07:25 INFO - 2015-11-15 23:07:25,403 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;169;173;160;158;164;170;169;164;171;164 23:07:25 INFO - 2015-11-15 23:07:25,404 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;172;180;196;199;197;173;187;196;199;193 23:07:25 INFO - 2015-11-15 23:07:25,404 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;83;86;86;92;92;92;90;91;90;93 23:07:25 INFO - 2015-11-15 23:07:25,404 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:07:25 INFO - 2015-11-15 23:07:25,404 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:07:25 INFO - 2015-11-15 23:07:25,404 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1020 23:07:25 INFO - 2015-11-15 23:07:25,404 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:07:25 INFO - 2015-11-15 23:07:25,404 DEBUG : BROWSER_OUTPUT: __startTimestamp1447657645400__endTimestamp 23:07:25 INFO - 2015-11-15 23:07:25,404 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,406 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:07:25 INFO - 2015-11-15 23:07:25,406 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:07:25 INFO - 2015-11-15 23:07:25,406 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,408 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:137.70 Median:138.50 stddev:6.17 (4.5%) stddev-sans-first:6.04 23:07:25 INFO - 2015-11-15 23:07:25,408 DEBUG : BROWSER_OUTPUT: Values: 131.0 136.0 139.0 137.0 139.0 133.0 132.0 139.0 138.0 153.0 23:07:25 INFO - 2015-11-15 23:07:25,408 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,408 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:183.70 Median:192.50 stddev:17.99 (9.3%) stddev-sans-first:18.61 23:07:25 INFO - 2015-11-15 23:07:25,408 DEBUG : BROWSER_OUTPUT: Values: 195.0 166.0 195.0 206.0 164.0 190.0 188.0 163.0 207.0 163.0 23:07:25 INFO - 2015-11-15 23:07:25,409 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,409 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:202.20 Median:204.50 stddev:4.87 (2.4%) stddev-sans-first:4.79 23:07:25 INFO - 2015-11-15 23:07:25,409 DEBUG : BROWSER_OUTPUT: Values: 197.0 207.0 204.0 205.0 196.0 197.0 208.0 207.0 204.0 197.0 23:07:25 INFO - 2015-11-15 23:07:25,409 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,409 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:103.30 Median:87.00 stddev:24.21 (27.8%) stddev-sans-first:25.33 23:07:25 INFO - 2015-11-15 23:07:25,410 DEBUG : BROWSER_OUTPUT: Values: 92.0 102.0 107.0 152.0 86.0 88.0 89.0 91.0 142.0 84.0 23:07:25 INFO - 2015-11-15 23:07:25,410 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,410 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:128.60 Median:119.50 stddev:21.59 (18.1%) stddev-sans-first:22.62 23:07:25 INFO - 2015-11-15 23:07:25,410 DEBUG : BROWSER_OUTPUT: Values: 119.0 120.0 172.0 115.0 115.0 115.0 154.0 113.0 113.0 150.0 23:07:25 INFO - 2015-11-15 23:07:25,410 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,410 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:148.90 Median:149.00 stddev:5.15 (3.5%) stddev-sans-first:5.45 23:07:25 INFO - 2015-11-15 23:07:25,411 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 155.0 155.0 141.0 148.0 155.0 148.0 141.0 149.0 23:07:25 INFO - 2015-11-15 23:07:25,411 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,411 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:161.00 Median:162.00 stddev:2.94 (1.8%) stddev-sans-first:3.03 23:07:25 INFO - 2015-11-15 23:07:25,411 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 157.0 162.0 165.0 160.0 155.0 162.0 162.0 23:07:25 INFO - 2015-11-15 23:07:25,411 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,413 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:122.80 Median:120.50 stddev:5.07 (4.2%) stddev-sans-first:4.93 23:07:25 INFO - 2015-11-15 23:07:25,413 DEBUG : BROWSER_OUTPUT: Values: 117.0 121.0 130.0 120.0 130.0 120.0 120.0 130.0 120.0 120.0 23:07:25 INFO - 2015-11-15 23:07:25,413 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,413 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.20 Median:75.50 stddev:3.19 (4.2%) stddev-sans-first:2.77 23:07:25 INFO - 2015-11-15 23:07:25,414 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 73.0 72.0 72.0 76.0 76.0 75.0 76.0 76.0 23:07:25 INFO - 2015-11-15 23:07:25,414 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,414 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:87.30 Median:89.50 stddev:3.43 (3.8%) stddev-sans-first:2.42 23:07:25 INFO - 2015-11-15 23:07:25,414 DEBUG : BROWSER_OUTPUT: Values: 80.0 85.0 84.0 89.0 89.0 90.0 90.0 90.0 90.0 86.0 23:07:25 INFO - 2015-11-15 23:07:25,415 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,415 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:110.00 Median:109.00 stddev:3.94 (3.6%) stddev-sans-first:4.12 23:07:25 INFO - 2015-11-15 23:07:25,415 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 109.0 110.0 109.0 108.0 108.0 110.0 121.0 109.0 23:07:25 INFO - 2015-11-15 23:07:25,415 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,415 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:166.20 Median:169.00 stddev:4.94 (2.9%) stddev-sans-first:5.13 23:07:25 INFO - 2015-11-15 23:07:25,415 DEBUG : BROWSER_OUTPUT: Values: 169.0 173.0 160.0 158.0 164.0 170.0 169.0 164.0 171.0 164.0 23:07:25 INFO - 2015-11-15 23:07:25,415 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,416 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.20 Median:196.00 stddev:10.58 (5.4%) stddev-sans-first:9.21 23:07:25 INFO - 2015-11-15 23:07:25,416 DEBUG : BROWSER_OUTPUT: Values: 172.0 180.0 196.0 199.0 197.0 173.0 187.0 196.0 199.0 193.0 23:07:25 INFO - 2015-11-15 23:07:25,416 DEBUG : BROWSER_OUTPUT: 23:07:25 INFO - 2015-11-15 23:07:25,416 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.50 Median:91.50 stddev:3.34 (3.7%) stddev-sans-first:2.59 23:07:25 INFO - 2015-11-15 23:07:25,416 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 86.0 92.0 92.0 92.0 90.0 91.0 90.0 93.0 23:07:25 INFO - 2015-11-15 23:07:25,416 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:07:25 INFO - 2015-11-15 23:07:25,416 DEBUG : BROWSER_OUTPUT: 23:07:26 INFO - 2015-11-15 23:07:26,072 INFO : Browser exited with error code: 0 23:07:26 INFO - 2015-11-15 23:07:26,131 INFO : Completed test kraken (00:01:05) 23:07:26 INFO - 2015-11-15 23:07:26,131 INFO : Starting test v8_7 23:07:26 INFO - 2015-11-15 23:07:26,131 DEBUG : operating with platform_type : mac_ 23:07:26 INFO - 2015-11-15 23:07:26,131 INFO : Initialising browser for v8_7 test... 23:07:26 INFO - 2015-11-15 23:07:26,147 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/tmphoAElh/profile http://localhost:50256/getInfo.html 23:07:29 INFO - 2015-11-15 23:07:29,077 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:07:29 INFO - 2015-11-15 23:07:29,078 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:07:29 INFO - 2015-11-15 23:07:29,078 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:07:29 INFO - 2015-11-15 23:07:29,078 DEBUG : BROWSER_OUTPUT: __metrics 23:07:29 INFO - 2015-11-15 23:07:29,096 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:07:29 INFO - 2015-11-15 23:07:29,929 INFO : Browser initialized. 23:07:29 INFO - 2015-11-15 23:07:29,929 INFO : Running cycle 1/1 for v8_7 test... 23:07:29 INFO - 2015-11-15 23:07:29,930 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/T/tmphoAElh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:07:42 INFO - 2015-11-15 23:07:42,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 230199296 23:07:42 INFO - 2015-11-15 23:07:42,183 DEBUG : BROWSER_OUTPUT: 23:08:04 INFO - 2015-11-15 23:08:04,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50256/tests/v8_7/run.html (next: http://localhost:50256/tests/v8_7/run.html) 23:08:05 INFO - 2015-11-15 23:08:05,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 307777536 23:08:05 INFO - 2015-11-15 23:08:05,148 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |0;Richards;209.51183741881417 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;244.61839530332682 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |2;Encrypt;397.29837107667856 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7099.290780141844 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2415.458937198068 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |5;Earley;1009.0817356205853 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |6;Boyer;17000 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |7;RegExp;36872.72727272727 23:08:05 INFO - 2015-11-15 23:08:05,149 DEBUG : BROWSER_OUTPUT: |8;Splay;800 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7194.244604316546 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: __startTimestamp1447657685141__endTimestamp 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:209.51 Median:209.51 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: Values: 209.5 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:244.62 Median:244.62 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,150 DEBUG : BROWSER_OUTPUT: Values: 244.6 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:397.30 Median:397.30 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: Values: 397.3 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7099.29 Median:7099.29 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: Values: 7099.3 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2415.46 Median:2415.46 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: Values: 2415.5 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1009.08 Median:1009.08 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: Values: 1009.1 23:08:05 INFO - 2015-11-15 23:08:05,151 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:17000.00 Median:17000.00 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: Values: 17000.0 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36872.73 Median:36872.73 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: Values: 36872.7 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:800.00 Median:800.00 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: Values: 800.0 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7194.24 Median:7194.24 stddev:0.00 (0.0%) 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: Values: 7194.2 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:08:05 INFO - 2015-11-15 23:08:05,152 DEBUG : BROWSER_OUTPUT: 23:08:05 INFO - 2015-11-15 23:08:05,904 INFO : Browser exited with error code: 0 23:08:05 INFO - 2015-11-15 23:08:05,930 INFO : Completed test v8_7 (00:00:39) 23:08:06 INFO - 2015-11-15 23:08:06,041 INFO : Completed test suite (00:20:22) 23:08:06 INFO - 2015-11-15 23:08:06,041 DEBUG : Working with test: dromaeo_css 23:08:06 INFO - 2015-11-15 23:08:06,041 DEBUG : Generating results file: dromaeo_css 23:08:06 INFO - 2015-11-15 23:08:06,042 DEBUG : Working with test: kraken 23:08:06 INFO - 2015-11-15 23:08:06,042 DEBUG : Generating results file: kraken 23:08:06 INFO - 2015-11-15 23:08:06,042 INFO : javascript benchmark 23:08:06 INFO - 2015-11-15 23:08:06,043 DEBUG : Working with test: v8_7 23:08:06 INFO - 2015-11-15 23:08:06,043 DEBUG : Generating results file: v8_7 23:08:06 INFO - 2015-11-15 23:08:06,043 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:06 INFO - 2015-11-15 23:08:06,094 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 23:08:06 INFO - 2015-11-15 23:08:06,094 DEBUG : process_Request line: dromaeo_css 5264.49 graph.html#tests=[[72,63,55]] 23:08:06 INFO - 2015-11-15 23:08:06,094 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:06 INFO - 2015-11-15 23:08:06,123 DEBUG : process_Request line: kraken 1903.60 graph.html#tests=[[232,63,55]] 23:08:06 INFO - 2015-11-15 23:08:06,123 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:06 INFO - 2015-11-15 23:08:06,252 DEBUG : process_Request line: v8_7 14779.76 graph.html#tests=[[230,63,55]] 23:08:06 INFO - 2015-11-15 23:08:06,254 INFO : javascript benchmark 23:08:06 INFO - 2015-11-15 23:08:06,256 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [268.1406093470427, 268.57967281204924, 269.09315606406403, 274.88180082564514, 281.64794007490644, 13579.253141077237, 13756.58730238092, 14278.571642850706, 14348.35432405543, 15221.619459513518, 11115.944420277887, 11334.149938754585, 11833.940830295836, 11853.466594003268, 14809.333579988926, 4254.723442976205, 4497.955020449803, 4505.43682039745, 4547.454305483347, 4557.475890272612, 3675.044488433013, 3821.388577827548, 4444.933326000112, 4484.372187893698, 4518.70628409154, 2688.8386696798257, 2776.47247023066, 2827.9293017674618, 3768.6608205261523, 3815.5039844820135, 3871.05159235989, 3874.089588946595, 3908.687305015606, 3923.7449565778134, 3944.9408258876283, 3272.280098378377, 3287.112479630486, 3322.285708572644, 3330.4504756715114, 3334.583177102862, 9976.850347244797, 10419.426931518763, 10438.060574548252, 10644.042036216777, 10651.414172220524, 1459.9489017884323, 1516.5071351810595, 1568.725473042213, 1585.9762103568455, 1626.6990606737672, 7594.468387212897, 7654.846903061907, 7819.139894611588, 7895.171007044235, 7972.242636949481, 1235.6416639174718, 1269.320913311374, 1274.3628185907046, 1290.8192853000494, 1301.4338762638188, 42539.574604253874, 43909.56090439087, 44381.33427998583, 44459.333110003376, 44779.32831007505, 5059.342285502861, 5096.337476128154, 5114.565261952701, 5123.974380128076, 5165.74171291434, 5840.240768700127, 5856.795012174553, 5861.41385861419, 5912.940870591325, 5973.193618861398, 3861.3242682530445, 3883.5533913599734, 3912.374020156818, 3920.0199950012498, 3968.8015599220503, 3852.056246219694, 3893.9875632335797, 3903.4925459690626, 3938.5076865391825, 3993.281209382339, 2286.1655495743935, 2312.838101332924, 2336.404216924673, 2338.216697406388, 2384.1059602649007, 809.688270016048, 810.4003037752021, 825.2984962781708, 842.2840585502397, 883.4566741454088, 339.1639608365391, 344.6708393484217, 348.73321908739837, 353.17533559139184, 380.9238152369482, 8721.345899057596, 9200.723978280663, 9450.291228157916, 9536.761580960532, 9590.58832936843, 344.9758516903793, 353.43274045157665, 353.45214916879246, 375.2588637441032, 378.2567255343264, 4526.298423744325, 4879.4388645305535, 5001.974990125026, 5089.185730283137, 5101.336826212569, 421625.0, 425681.0, 430987.1407715547, 434195.0, 438951.0, 52010.739946300026, 53425.73287133539, 55045.0, 55899.720501397234, 56842.715786420806, 395.41083785159907, 403.6468090420882, 406.57309824683966, 407.35434336576265, 413.80551140964303, 8603.956980215058, 8613.48319100856, 8780.648774048967, 8835.823283534422, 8840.425372350777, 26936.32659183536, 27342.863285683445, 27362.31594210081, 27519.862400687867, 28246.0, 37420.81289593535, 37894.431583525715, 38135.42796858105, 38207.23585528218, 38533.0, 4595.241785105421, 4899.485554016919, 4980.302757614009, 4980.651354405157, 5028.64799464034, 9227.86158207614, 9260.675876344296, 9281.907180928105, 9302.0, 9415.858762118436, 7827.569483678225, 7934.880976785237, 7999.640016199169, 8109.432339736162, 8200.917990820015, 7712.845743084995, 7766.262205090507, 7798.298153166243, 7912.0901096374655, 8057.597120143852, 8123.7156699515235, 8376.87434688468, 8391.202835730595, 8479.024912134937, 8593.52735599548, 4922.237053256751, 4926.950730492793, 4934.309196712535, 5018.84943451697, 5025.949740502694, 7844.882326764989, 7981.122076571689, 8109.148539403278, 8189.877151842608, 8358.916410835815], "dojo.html": [2518.5214809186255, 2582.5222333868246, 2586.249987503624, 2614.673165854268, 2629.0666813281287, 4050.392441133831, 4267.210566045276, 4302.333138363555, 4353.521112677607, 4399.384086227927, 4246.978765106178, 4391.9121617567625, 4412.536683648219, 4484.148011877741, 4537.4328208973875, 3982.3030969580354, 3989.9800500997453, 4017.216642754664, 4038.5759495253014, 4124.773137477438, 3797.4742947782393, 3990.102226998931, 4064.2887494688457, 4120.855770048049, 4171.186618609372, 3850.0952276215066, 3863.6715879150024, 3944.3886197639413, 4027.0536423940353, 4059.1881623675235, 3895.61043895611, 3982.263281292941, 3994.141259629194, 4017.7589344639414, 4068.2677118118727, 3917.5103112110987, 3960.0495880988356, 3999.960000399988, 4010.418489319062, 4064.04494943688, 4146.087860670647, 4214.957850421487, 4246.511651160125, 4250.605055016349, 4319.589638984291, 4233.1322078973735, 4367.737935723835, 4380.145871555048, 4496.078303947683, 4577.22187228172, 4670.1126785910565, 4681.57865792077, 4691.577758001797, 4705.4588722296685, 4757.976210118927, 4030.717849750548, 4346.065595896897, 4356.629686476622, 4356.8257269709175, 4394.912101757979, 4553.4991150973365, 4651.0, 4689.0, 4731.881702957454, 4814.181589129857, 4474.865754027384, 4530.388397566352, 4538.410006699108, 4539.886502837456, 4645.047765208192, 4505.0, 4649.3026046093355, 4705.670603057822, 4706.552877476634, 4760.119377915097, 4464.55354464551, 4501.279795232747, 4523.683342166017, 4564.201264778717, 4575.359449677047, 4496.842610508616, 4508.278675411918, 4545.704529205591, 4579.015511665008, 4623.260278355447, 3487.4943133246043, 3526.7354948378975, 3530.805805680712, 3604.8197590120913, 3639.872604458831, 3070.7696922730884, 3188.2507610711464, 3250.2686895448337, 3251.1221970068423, 3303.653116422789, 4220.620144187038, 4280.5505421930875, 4305.763183024964, 4314.482262128565, 4347.891302717394, 4616.099860527165, 4634.21218392874, 4649.139909116824, 4701.412323459567, 4732.455767586772, 4171.645410140111, 4182.330827067654, 4239.618434340924, 4297.699161058696, 4372.344148377705, 4001.579834117434, 4044.4539987101953, 4077.347624380085, 4120.25835349634, 4164.1879833432795, 4559.658025648023, 4657.254839225708, 4670.906581868411, 4731.810727570859, 4750.168720473972, 4518.186726389282, 4584.312353146921, 4606.88482787933, 4641.953580464287, 4737.455192652889, 4683.180443422456, 4691.7184968901975, 4717.410323709536, 4768.642351823558, 4771.594414474808, 4581.793819278208, 4588.7476188808605, 4640.048789997974, 4640.93038604428, 4665.836695715634, 4416.536263692266, 4506.977465112654, 4510.639148868017, 4556.17988762026, 4689.765511724332, 4485.05813779097, 4501.887452813575, 4523.276275795857, 4552.590266875997, 4581.106684196549, 4455.866324010285, 4492.326151077365, 4498.415206023196, 4558.566936141061, 4571.497135315046, 4383.890402739829, 4424.004598965207, 4428.446444194476, 4434.933475997798, 4435.3346997949275, 4400.075984043387, 4499.91000179988, 4500.752458614807, 4549.4768101667405, 4555.1117532080925, 4257.510386305491, 4331.761753103609, 4401.273789824643, 4402.8679139625865, 4501.752403617833], "mootools.html": [1261.1361217565973, 1361.652778541472, 1428.7856821476778, 1446.2696338349133, 1511.4860947277923, 5667.149927510875, 6216.782412615565, 6242.438180563749, 6505.479561635069, 6552.984287435455, 6339.302676705559, 6415.486761059115, 6436.903446448296, 6527.445167160785, 6569.24453687826, 1786.8302511261409, 1790.8567314614832, 1812.474382429094, 1815.0108191035852, 1819.8908065516046, 1807.6023274879506, 1838.1360760442572, 1854.8701590888643, 1861.4601765487992, 1888.4712280561464, 1767.6464707058576, 1780.4302623160593, 1781.8218178182142, 1813.9637207255846, 1823.6170404215131, 1722.4832550234942, 1766.9558261043449, 1775.7336399540109, 1792.9103544822706, 1807.0693592799719, 1776.6979613465742, 1782.5454509100225, 1787.2314904591021, 1796.8203179682057, 1825.1421831739062, 5596.076647353182, 6333.334999824998, 6365.140706004677, 6401.231852177769, 6424.421802037839, 3586.5158203642436, 3717.20080182762, 3760.097576581628, 3795.0, 3890.435886796427, 2301.3326135420707, 2336.824738144646, 2363.314638754759, 2403.579373609611, 2405.9639105413435, 688.8553403785211, 703.0438603499236, 704.376626685382, 705.0693085127633, 729.1578227147653, 8293.709720159766, 8361.289290410323, 8390.496570205807, 8489.278411335044, 8498.320134389234, 3479.6694314040124, 3541.7874927503917, 3604.0809593553477, 3611.3860643690637, 3693.095191678056, 7410.147832999166, 7441.739539116105, 7496.512726672858, 7557.5465472071855, 7615.16233214346, 4002.659773919191, 4024.2555127301544, 4025.3961905714377, 4038.1721747042375, 4050.7772072536295, 3616.620254873253, 3620.0587847159927, 3635.163912300186, 3692.2061756721896, 3693.4275187346007, 2908.0, 2958.1717119206655, 2979.642442906865, 2989.2676294308035, 3004.7596192304563, 951.1392190068, 974.7904200596905, 975.7804493988938, 989.3717489394287, 991.3556188477403, 783.6512751825383, 799.5962039170182, 802.1537278171469, 804.2801692485193, 957.3968399908014, 5967.940320596826, 6011.729472173675, 6036.5170786336985, 6079.574429789872, 6113.510919126459, 346.87859249262556, 352.64559118086675, 358.69869309779386, 358.9533360663097, 360.56551855014646, 4585.6102231310715, 4596.195665758479, 4614.97692511542, 4621.930671039937, 4680.836170734008, 6900.551464154814, 7030.824229394204, 7223.891641625275, 7259.092613423322, 7434.0, 7292.088488938883, 7380.741674041383, 7387.741429050065, 7525.849483010309, 7536.849263014709, 5526.751296191681, 5999.220101386792, 6022.54830887694, 6026.306974697878, 6084.847878803065, 5939.3466718661775, 5996.130561068708, 6004.639721616717, 6019.879602408015, 6108.51131909455, 6713.093732346266, 6754.358335958076, 6784.118064651564, 6847.349501797321, 6865.107536020286, 6893.586384816927, 6946.479014074066, 7086.078809754699, 7100.076989991268, 7168.53404528704, 5672.092465205547, 5697.088465845611, 5730.484256416942, 5738.483536481736, 5795.971020144872, 6038.63768173911, 6057.729775095695, 6096.634201947897, 6165.290991535851, 6267.2479302484, 5595.384507704231, 5667.8866422672145, 5699.971500142473, 5736.0, 5809.82570522885, 5286.0, 5537.944620553743, 5662.207290979349, 5715.114157305624, 5797.652140871562, 5273.894522109613, 5297.496737809902, 5311.0, 5394.379646340564, 5395.379531353788, 4842.176829938849, 4867.148249056472, 4915.459299476983, 4938.407391113089, 4953.529414705597, 4946.653734238569, 4954.752262386938, 4993.201087825931, 5032.521910418504, 5088.542031217208], "ext.html": [446.6984785269944, 459.79539105098223, 463.6105671236161, 473.16486401501345, 487.0, 24379.0, 31480.370392592133, 31752.99999999997, 32226.35547289053, 32331.353372932528, 33817.32365352692, 34043.659563404355, 34377.0, 34569.654303456955, 34583.4812477813, 6582.80251592453, 6860.965695171517, 7355.227701091375, 7406.444516661245, 7539.472236943416, 6574.309697481767, 8622.35332350073, 8814.603342849587, 8966.86549701755, 8989.235914947238, 8775.429597076201, 8816.515091669955, 8903.643854245822, 8944.373893827435, 8964.596593153292, 6817.216020157695, 6840.0, 8675.522846243453, 8820.691275805317, 9004.999999999967, 6666.966665166691, 8421.49471031734, 8663.220310172115, 8823.602937867812, 8837.779055523662, 28748.13755587315, 29245.415091698258, 29631.703682963325, 29743.553846692317, 29762.0, 2250.763669814662, 2329.23135365329, 2357.4695693468834, 2748.1480740970364, 2768.2387343480505, 21570.56858862814, 22068.558628827494, 22542.887285563633, 22795.658065129035, 22988.88505557478, 1812.238859678938, 1843.4930394141584, 1901.8858868467937, 1930.845532357408, 1939.1661585518223, 217269.0, 221039.0, 221467.0, 221759.0, 222077.0, 40792.18415631671, 42592.14815703669, 45942.540574593826, 46112.53887461082, 46373.536264637594, 38548.6145138545, 48973.08215342764, 49358.75320623374, 50299.74850125799, 50383.74808126009, 9398.483083430478, 9628.951855240819, 9727.902720972841, 9825.950870245602, 9830.655927042662, 7071.575705457689, 7128.750493732695, 7144.749933752398, 7265.709371625076, 7266.164391094986, 14751.77872331916, 14839.40642374293, 14879.0, 15126.546203613909, 15198.0, 6956.79129626112, 7196.64016799158, 7223.530470519505, 7355.080614923135, 7384.298491643285, 733.618518370455, 742.6620887496176, 750.4746677325894, 806.2381049907898, 936.6605753772035, 22190.778092219192, 22655.773442265698, 23919.155456163502, 24456.510869782862, 24805.751942480707, 831.243568352796, 834.8854279536886, 838.9278482149082, 937.5031233446284, 940.1538615246196, 11282.435878206057, 11407.867391640159, 11512.481938312796, 12124.211926224767, 12521.436535355931, 247432.0, 251850.0, 252925.0, 253906.0, 257778.0, 42643.0, 42757.358639620434, 42911.35632965508, 42926.78536607297, 42934.35598465963, 897.5243121145803, 976.9609215631438, 990.5493000684671, 1065.8774240962077, 1075.5482697267166, 20796.89601552043, 21193.78806211918, 21532.0, 22359.44101397478, 22462.314808824765, 33271.50092748659, 34055.659443405246, 34474.482882756274, 35311.82344088263, 35317.82341088381, 184114.0, 318355.0, 327204.0, 332203.0, 333707.0, 23443.531129376977, 24297.149599763925, 24300.0, 24620.138295159584, 24717.25848224556, 31433.37133257368, 31686.841565792023, 31811.20471988219, 31822.6817731829, 32082.679173208904, 26923.461530768884, 27162.456750864476, 27580.58629120605, 27618.171454856387, 28339.574906376834, 26434.206973790817, 26732.866335668197, 26761.732382675924, 27156.864215678794, 27484.862575687792, 27723.445531088862, 28007.0, 28188.85905570459, 28253.43493130167, 29020.0, 21866.78133218711, 23226.883865580563, 23313.300600982, 23579.41051473727, 23745.762542374356, 17871.374501892373, 18041.66999920036, 18424.723629145843, 18646.627067458303, 19490.512737181685], "prototype.html": [251.80233516689395, 255.48774706713039, 261.96987346455165, 263.4178465591043, 264.0941570413481, 4984.950150498498, 5093.26147708582, 5126.666766660164, 5146.897062058762, 5156.613254005951, 4865.245886887538, 4929.186684197103, 4931.3835770528685, 5040.546350828425, 5097.949020509794, 3794.165283637595, 3830.157365379612, 3854.9229015419673, 3900.7854567998747, 3912.2371137628174, 3845.5962123977, 3864.0, 3876.7286289959716, 3894.6689531389866, 3921.5882282378466, 3662.450632405134, 3698.0569954661523, 3718.3121122592406, 3725.0501122213795, 3894.4742459767854, 3806.352920003606, 3833.5974722654137, 3850.306944749958, 3859.459675645412, 3895.7662540247393, 3294.1435226841195, 3310.9006729798143, 3338.2655815720505, 3342.9832850835833, 3374.8818791342187, 4888.657793954425, 4912.042151780404, 4968.3292755477905, 4998.050370429607, 5013.724245166514, 4207.726497777635, 4342.609165175118, 4386.8025938832825, 4456.621187199092, 4461.620762235214, 5302.973485132588, 5323.068463018995, 5324.787008519655, 5359.5712343012465, 5387.24578559002, 3612.4942508048894, 3616.059824445637, 3621.3662609043577, 3667.9083022924374, 3672.6510981456718, 5445.128779395317, 5526.4197259288, 5530.198121272393, 5557.5553955683445, 5636.323641163046, 3581.247937933011, 3672.081979505124, 3675.246574452231, 3682.3924052531033, 3760.3231418344412, 3703.370427027412, 3752.5927777083593, 3754.9061273468383, 3760.3231418344963, 3796.962030379716, 4331.480222373272, 4347.282698354799, 4355.978220108879, 4402.471703395613, 4410.0738844842945, 5315.149576067811, 5319.015982043335, 5338.3060202173465, 5428.538574221236, 5464.9180262296095, 1305.1907817153426, 1316.7366526694507, 1321.7951217561294, 1334.7130366971148, 1336.472093523053, 833.820728543366, 865.8354912566718, 872.5898827551041, 884.2218847414234, 888.0143041224236, 5096.7767735743155, 5111.718855462986, 5134.666246693953, 5205.115130427836, 5213.921791173136, 5519.365272993577, 5525.392206857243, 5538.695371754511, 5684.261046063985, 5694.943050569441, 4882.340883980688, 5039.82360617384, 5114.207297868837, 5124.052050370618, 5144.845654630367, 2922.795404321677, 2963.2147480917574, 2992.147238037149, 3022.425739109562, 3026.772992025607, 5555.194496798023, 5558.583106267046, 5641.12562552805, 5664.518515926193, 5665.886682266331, 5770.105633626795, 5789.421057894177, 5837.503812175928, 5842.941570584325, 5917.201177841022, 5426.8914621707345, 5631.352394474606, 5667.914981275284, 5771.538276937835, 5788.971055144697, 5609.158626206102, 5621.9156712650165, 5627.017680629273, 5627.352854421794, 5734.770609175586, 5517.36550296721, 5531.668099914018, 5553.278073850373, 5588.497035266845, 5650.773969041193, 5416.7562459688625, 5643.097104463266, 5695.430456954271, 5726.255586773859, 5739.799107031234, 3597.6582224688614, 3602.6037135914503, 3608.963910360968, 3683.72372072101, 3704.036950392971, 5613.522850557748, 5622.634528755618, 5626.156076588544, 5645.915311270416, 5677.574181936288, 5472.753726082416, 5482.23248745168, 5511.696856672921, 5524.502794748331, 5576.888462230814, 5223.660462069954, 5427.294451721409, 5435.918461223164, 5500.724963751876, 5531.557475401878, 5325.680459172462, 5349.411564727955, 5362.785488580413, 5413.998410294108, 5414.620976531605, 5448.809291674773, 5476.6166368355425, 5495.6153069284765, 5499.587530935276, 5559.8888022240135, 5330.466953304638, 5361.410244873139, 5377.059014672495, 5401.459854014567, 5408.810691625774], "yui.html": [606.5420607441384, 612.6446660936657, 624.7251209467834, 627.8524546731518, 644.342770374218, 10594.470276486174, 10740.462976851166, 10831.83752243717, 10886.510107045182, 10986.890131098686, 10091.848622270654, 10265.897341026588, 10308.948455257712, 10412.791744165132, 10473.58105675774, 546.0934848152068, 567.690608618304, 571.8570357410647, 652.4910569755598, 721.3940290156268, 678.575890068707, 692.6952141057918, 698.1099098649212, 700.250731717063, 709.0215502606396, 731.2614259597791, 734.1557209209399, 737.1191426245639, 742.361569050616, 750.2347605442445, 576.2767726503232, 576.7318197038355, 578.9044807606782, 712.9465290103263, 744.8361360500681, 529.6133822309697, 532.51541097601, 544.9727264107147, 548.6817645765486, 550.1555112901676, 10434.478276086165, 10537.63118290856, 10582.682519524427, 10618.73453163677, 10672.0, 8742.825143497095, 8849.823003539957, 8967.775805604846, 9147.862782058208, 9498.335116541844, 6562.868742625121, 6833.829154271133, 6909.067275917737, 7447.813804654927, 7538.359239464652, 2298.988505057464, 2321.860688358687, 2328.359701082199, 2351.5532048910823, 2432.6107822748454, 36670.449943250875, 37153.44269835955, 37265.62734372649, 37421.25157496835, 37536.62463375386, 5111.156659151198, 5221.921671174935, 5265.473452654781, 5330.440303768126, 5504.91742623861, 9633.710988670351, 9664.661736839176, 9718.659846905324, 9780.657676981271, 9872.308938374388, 4787.0904528139545, 4910.165271903714, 4963.156263435225, 4999.525045120708, 5190.273361729361, 2969.4506516294555, 3022.697730227004, 3046.436409264249, 3110.4867696830224, 3160.383725173615, 2149.9677504837127, 2155.450360158181, 2157.1479265689964, 2199.9340019799433, 2201.8458707890613, 319.1685658858686, 319.3772144318588, 329.6308134888892, 331.6202947624956, 333.5497078943407, 336.65661025753593, 354.97160227181763, 387.9844806207777, 388.70458451577, 407.9143379890256, 5771.971140144273, 6207.224096987877, 6213.502919766408, 6223.657698826608, 6232.294617563815, 399.70097184151507, 407.1246819338387, 417.19481400896564, 436.4021290831581, 454.8498995331533, 3037.7417919477093, 3195.9360812783616, 3252.2837251257165, 3306.6197387300285, 3369.6124945631077, 43627.78186109113, 43886.78056609697, 45510.54489455129, 45668.314975275396, 46512.0, 38881.0, 39488.2102357957, 39745.0, 39768.801155994035, 40225.59774402277, 39760.40359394612, 39927.0, 40017.39973900452, 40124.398134028015, 40978.38532422016, 6356.269029061717, 6620.437262832521, 6736.360045795642, 6834.179898412222, 6887.621180835102, 24408.51182976366, 24444.388890277885, 24522.75477245276, 25029.123980660588, 28195.731192095995, 33865.66134338723, 34013.82993085019, 35518.11204719903, 36282.8185859069, 36350.8182459086, 8391.832163356821, 8633.39566230358, 8642.22220000203, 8645.697400591202, 8789.252913502423, 8884.333674974274, 8977.685780997634, 9005.459672419676, 9218.196622225625, 9386.296027797805, 8274.875876861732, 8417.789555261168, 8506.532140732319, 8592.097829728038, 8811.559422029, 8375.706850260212, 8444.719574099294, 8511.95744021276, 8771.517566533646, 8816.426932249384, 5950.851228719317, 7553.433492488195, 7662.885056724042, 8078.6364613593705, 8946.150115738994, 7010.0, 7228.293777234984, 7405.518641288514, 7437.888431673638, 7810.492317999312, 7323.084614423197, 7339.486235963432, 7455.366293865082, 7529.0, 7682.500637458547]}, "summary": {"lowerIsBetter": false, "suite": 5264.487763833373, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5294.757623094401, "unit": "ms", "value": 5294.757623094401}, "dojo.html": {"lowerIsBetter": false, "filtered": 4258.764181497702, "unit": "ms", "value": 4258.764181497702}, "mootools.html": {"lowerIsBetter": false, "filtered": 3513.7584339566383, "unit": "ms", "value": 3513.7584339566383}, "ext.html": {"lowerIsBetter": false, "filtered": 14475.374607223464, "unit": "ms", "value": 14475.374607223464}, "prototype.html": {"lowerIsBetter": false, "filtered": 4021.704002875385, "unit": "ms", "value": 4021.704002875385}, "yui.html": {"lowerIsBetter": false, "filtered": 4614.774860774716, "unit": "ms", "value": 4614.774860774716}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0056"}, "testrun": {"date": 1447656463, "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": "20151115213439", "branch": "Mozilla-Inbound", "revision": "25836f531c30e3119d41d69b71e8c4daccb85f85"}}, {"talos_counters": {}, "results": {"audio-dft": [197.0, 207.0, 204.0, 205.0, 196.0, 197.0, 208.0, 207.0, 204.0, 197.0], "ai-astar": [131.0, 136.0, 139.0, 137.0, 139.0, 133.0, 132.0, 139.0, 138.0, 153.0], "imaging-gaussian-blur": [148.0, 149.0, 155.0, 155.0, 141.0, 148.0, 155.0, 148.0, 141.0, 149.0], "audio-beat-detection": [195.0, 166.0, 195.0, 206.0, 164.0, 190.0, 188.0, 163.0, 207.0, 163.0], "json-stringify-tinderbox": [80.0, 85.0, 84.0, 89.0, 89.0, 90.0, 90.0, 90.0, 90.0, 86.0], "stanford-crypto-pbkdf2": [172.0, 180.0, 196.0, 199.0, 197.0, 173.0, 187.0, 196.0, 199.0, 193.0], "json-parse-financial": [68.0, 68.0, 73.0, 72.0, 72.0, 76.0, 76.0, 75.0, 76.0, 76.0], "stanford-crypto-sha256-iterative": [83.0, 86.0, 86.0, 92.0, 92.0, 92.0, 90.0, 91.0, 90.0, 93.0], "audio-fft": [92.0, 102.0, 107.0, 152.0, 86.0, 88.0, 89.0, 91.0, 142.0, 84.0], "imaging-darkroom": [163.0, 162.0, 162.0, 157.0, 162.0, 165.0, 160.0, 155.0, 162.0, 162.0], "stanford-crypto-ccm": [169.0, 173.0, 160.0, 158.0, 164.0, 170.0, 169.0, 164.0, 171.0, 164.0], "audio-oscillator": [119.0, 120.0, 172.0, 115.0, 115.0, 115.0, 154.0, 113.0, 113.0, 150.0], "stanford-crypto-aes": [108.0, 108.0, 109.0, 110.0, 109.0, 108.0, 108.0, 110.0, 121.0, 109.0], "imaging-desaturate": [117.0, 121.0, 130.0, 120.0, 130.0, 120.0, 120.0, 130.0, 120.0, 120.0]}, "summary": {"lowerIsBetter": true, "suite": 1903.6, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 103.3, "unit": "ms", "value": 103.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 189.2, "unit": "ms", "value": 189.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 183.7, "unit": "ms", "value": 183.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 166.2, "unit": "ms", "value": 166.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 161.0, "unit": "ms", "value": 161.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.2, "unit": "ms", "value": 73.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 128.6, "unit": "ms", "value": 128.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 137.7, "unit": "ms", "value": 137.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 202.2, "unit": "ms", "value": 202.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 89.5, "unit": "ms", "value": 89.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 87.3, "unit": "ms", "value": 87.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 148.9, "unit": "ms", "value": 148.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 110.0, "unit": "ms", "value": 110.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 122.8, "unit": "ms", "value": 122.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0056"}, "testrun": {"date": 1447656463, "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": "20151115213439", "branch": "Mozilla-Inbound", "revision": "25836f531c30e3119d41d69b71e8c4daccb85f85"}}, {"talos_counters": {}, "results": {"DeltaBlue": [244.61839530332682], "Encrypt": [397.29837107667856], "NavierStokes": [7194.244604316546], "Decrypt": [7099.290780141844], "Splay": [800.0], "Richards": [209.51183741881417], "RegExp": [36872.72727272727], "Earley": [1009.0817356205853], "Boyer": [17000.0], "RayTrace": [2415.458937198068]}, "summary": {"lowerIsBetter": false, "suite": 14779.760381266588, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 270.29038399999996, "unit": "score", "value": 270.29038399999996}, "Encrypt": {"lowerIsBetter": false, "filtered": 669.9775769999998, "unit": "score", "value": 669.9775769999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 206.27599999999984, "unit": "score", "value": 206.27599999999984}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.49402697302694, "unit": "score", "value": 37.49402697302694}, "Splay": {"lowerIsBetter": false, "filtered": 101.86374999999995, "unit": "score", "value": 101.86374999999995}, "RegExp": {"lowerIsBetter": false, "filtered": 24.70620069033529, "unit": "score", "value": 24.70620069033529}, "Richards": {"lowerIsBetter": false, "filtered": 168.49644599999993, "unit": "score", "value": 168.49644599999993}, "Earley": {"lowerIsBetter": false, "filtered": 660.4648330000001, "unit": "score", "value": 660.4648330000001}, "Boyer": {"lowerIsBetter": false, "filtered": 39.20370588235296, "unit": "score", "value": 39.20370588235296}, "RayTrace": {"lowerIsBetter": false, "filtered": 306.35544600000003, "unit": "score", "value": 306.35544600000003}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0056"}, "testrun": {"date": 1447656463, "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": "20151115213439", "branch": "Mozilla-Inbound", "revision": "25836f531c30e3119d41d69b71e8c4daccb85f85"}}] 23:08:06 INFO - RETURN: dromaeo_css: 5264.49 23:08:06 INFO - RETURN: kraken: 1903.60 23:08:06 INFO - RETURN: v8_7: 14779.76 23:08:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "14779.76"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1903.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5264.49"}}} 23:08:06 INFO - Return code: 0 23:08:06 INFO - # TBPL SUCCESS # 23:08:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:08:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:08:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:08:06 INFO - 2015-11-15 23:08:06.357 screenresolution[2031:19952] starting screenresolution argv=screenresolution get 23:08:06 INFO - 2015-11-15 23:08:06.360 screenresolution[2031:19952] Display 0: 1600x1200x32@60 23:08:06 INFO - 2015-11-15 23:08:06.367 screenresolution[2032:19955] starting screenresolution argv=screenresolution list 23:08:06 INFO - Available Modes on Display 0 23:08:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:08:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:08:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:08:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:08:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:08:06 INFO - Intel HD Graphics 3000: 23:08:06 INFO - Chipset Model: Intel HD Graphics 3000 23:08:06 INFO - Type: GPU 23:08:06 INFO - Bus: Built-In 23:08:06 INFO - VRAM (Total): 512 MB 23:08:06 INFO - VRAM (Dynamic, Max): 10 23:08:06 INFO - Vendor: Intel (0x8086) 23:08:06 INFO - Device ID: 0x0116 23:08:06 INFO - Revision ID: 0x0009 23:08:06 INFO - Displays: 23:08:06 INFO - Display: 23:08:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:08:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:08:06 INFO - Display Serial Number: 1600x1200 60 23:08:06 INFO - Main Display: Yes 23:08:06 INFO - Mirror: Off 23:08:06 INFO - Online: Yes 23:08:06 INFO - Rotation: Supported 23:08:06 INFO - Return code: 0 23:08:06 INFO - Running post-action listener: _resource_record_post_action 23:08:06 INFO - Running post-run listener: _resource_record_post_run 23:08:07 INFO - Total resource usage - Wall time: 1271s; CPU: 30.0%; Read bytes: 2195456; Write bytes: 690151424; Read time: 514; Write time: 127104 23:08:07 INFO - install - Wall time: 48s; CPU: 29.0%; Read bytes: 336574976; Write bytes: 336031744; Read time: 37765; Write time: 82410 23:08:07 INFO - run-tests - Wall time: 1223s; CPU: 30.0%; Read bytes: 2195456; Write bytes: 343748608; Read time: 514; Write time: 37330 23:08:07 INFO - Running post-run listener: _upload_blobber_files 23:08:07 INFO - Blob upload gear active. 23:08:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:08:07 INFO - Copying logs to upload dir... 23:08:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1361.113527 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 41 secs) (at 2015-11-15 23:08:07.832231) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 23:08:07.836178) ========= 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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners TMPDIR=/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/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/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/el_7wkq1Slii4Oc-XES3gQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 23:08:07.865202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 23:08:07.865524) ========= 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.p4ReIkM2ec/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.7FqNc4KFh6/Listeners TMPDIR=/var/folders/m7/ztbgphf942q4vzd0d8py54q400000w/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.005670 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 23:08:07.915856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 23:08:07.916164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 23:08:07.916586) ========= ========= Total master_lag: 0.34 =========