builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0034 starttime: 1447458924.79 results: success (0) buildid: 20151113141429 builduid: 0cf69c3e376f4accbcbac30dc4782086 revision: 9132d08e6d81983cf8f5f702eb6cbac3469ae921 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:24.787102) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:24.787601) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:24.788106) ========= 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.VK916FmoOl/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.URnNENKoAd/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.006595 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:24.833254) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:24.833569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:24.938629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:24.939101) ========= 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.VK916FmoOl/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.URnNENKoAd/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.005597 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:25.020488) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:25.020862) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:25.021738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:25.022094) ========= 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.VK916FmoOl/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.URnNENKoAd/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-13 15:55:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-13 15:55:25 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.409472 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:25.479068) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:25.479396) ========= 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.VK916FmoOl/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.URnNENKoAd/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.020062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:25.528805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 15:55:25.529167) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9132d08e6d81983cf8f5f702eb6cbac3469ae921 --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 9132d08e6d81983cf8f5f702eb6cbac3469ae921 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VK916FmoOl/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.URnNENKoAd/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-13 15:55:25,605 truncating revision to first 12 chars 2015-11-13 15:55:25,606 Setting DEBUG logging. 2015-11-13 15:55:25,606 attempt 1/10 2015-11-13 15:55:25,606 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9132d08e6d81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 15:55:26,782 unpacking tar archive at: mozilla-inbound-9132d08e6d81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.463526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 15:55:27.012142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:27.012506) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:27.026716) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:27.027049) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 15:55:27.027528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2015-11-13 15:55:27.027853) ========= /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.VK916FmoOl/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.URnNENKoAd/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 15:55:27 INFO - MultiFileLogger online at 20151113 15:55:27 in /builds/slave/test 15:55:27 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 15:55:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:55:27 INFO - {'append_to_log': False, 15:55:27 INFO - 'base_work_dir': '/builds/slave/test', 15:55:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:55:27 INFO - 'branch': 'Mozilla-Inbound', 15:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:55:27 INFO - 'config_files': ('talos/mac_config.py',), 15:55:27 INFO - 'default_actions': ('clobber', 15:55:27 INFO - 'read-buildbot-config', 15:55:27 INFO - 'download-and-extract', 15:55:27 INFO - 'populate-webroot', 15:55:27 INFO - 'create-virtualenv', 15:55:27 INFO - 'install', 15:55:27 INFO - 'run-tests'), 15:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:55:27 INFO - 'download_minidump_stackwalk': True, 15:55:27 INFO - 'download_symbols': 'ondemand', 15:55:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:55:27 INFO - 'tooltool.py': '/tools/tooltool.py', 15:55:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:55:27 INFO - '/tools/misc-python/virtualenv.py')}, 15:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:55:27 INFO - 'installer_path': 'installer.exe', 15:55:27 INFO - 'log_level': 'info', 15:55:27 INFO - 'log_name': 'talos', 15:55:27 INFO - 'log_to_console': True, 15:55:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:55:27 INFO - 'opt_config_files': (), 15:55:27 INFO - 'pip_index': False, 15:55:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:55:27 INFO - 'cmd': ('bash', 15:55:27 INFO - '-c', 15:55:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:55:27 INFO - 'enabled': True, 15:55:27 INFO - 'halt_on_failure': False, 15:55:27 INFO - 'name': 'check_screen_resolution'},), 15:55:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:55:27 INFO - 'cmd': ('bash', 15:55:27 INFO - '-c', 15:55:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:55:27 INFO - 'enabled': True, 15:55:27 INFO - 'halt_on_failure': False, 15:55:27 INFO - 'name': 'check_screen_resolution'},), 15:55:27 INFO - 'run_cmd_checks_enabled': True, 15:55:27 INFO - 'sps_profile': False, 15:55:27 INFO - 'sps_profile_interval': 0, 15:55:27 INFO - 'suite': 'dromaeojs', 15:55:27 INFO - 'system_bits': '64', 15:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:55:27 INFO - 'title': 't-yosemite-r5-0034', 15:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:55:27 INFO - 'use_talos_json': True, 15:55:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:55:27 INFO - 'work_dir': 'build'} 15:55:27 INFO - ##### 15:55:27 INFO - ##### Running clobber step. 15:55:27 INFO - ##### 15:55:27 INFO - Running pre-action listener: _resource_record_pre_action 15:55:27 INFO - Running main action method: clobber 15:55:27 INFO - rmtree: /builds/slave/test/build 15:55:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:55:29 INFO - Running post-action listener: _resource_record_post_action 15:55:29 INFO - ##### 15:55:29 INFO - ##### Running read-buildbot-config step. 15:55:29 INFO - ##### 15:55:29 INFO - Running pre-action listener: _resource_record_pre_action 15:55:29 INFO - Running main action method: read_buildbot_config 15:55:29 INFO - Using buildbot properties: 15:55:29 INFO - { 15:55:29 INFO - "properties": { 15:55:29 INFO - "buildnumber": 3401, 15:55:29 INFO - "product": "firefox", 15:55:29 INFO - "script_repo_revision": "production", 15:55:29 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 15:55:29 INFO - "repository": "", 15:55:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 15:55:29 INFO - "buildid": "20151113141429", 15:55:29 INFO - "slavename": "t-yosemite-r5-0034", 15:55:29 INFO - "pgo_build": "False", 15:55:29 INFO - "basedir": "/builds/slave/test", 15:55:29 INFO - "project": "", 15:55:29 INFO - "platform": "yosemite", 15:55:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:55:29 INFO - "slavebuilddir": "test", 15:55:29 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 15:55:29 INFO - "branch": "mozilla-inbound", 15:55:29 INFO - "repo_path": "integration/mozilla-inbound", 15:55:29 INFO - "stage_platform": "macosx64", 15:55:29 INFO - "builduid": "0cf69c3e376f4accbcbac30dc4782086", 15:55:29 INFO - "revision": "9132d08e6d81983cf8f5f702eb6cbac3469ae921" 15:55:29 INFO - }, 15:55:29 INFO - "sourcestamp": { 15:55:29 INFO - "repository": "", 15:55:29 INFO - "hasPatch": false, 15:55:29 INFO - "project": "", 15:55:29 INFO - "branch": "mozilla-inbound-macosx64-talos", 15:55:29 INFO - "changes": [ 15:55:29 INFO - { 15:55:29 INFO - "category": null, 15:55:29 INFO - "files": [ 15:55:29 INFO - { 15:55:29 INFO - "url": null, 15:55:29 INFO - "name": "https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:55:29 INFO - } 15:55:29 INFO - ], 15:55:29 INFO - "repository": "", 15:55:29 INFO - "rev": "9132d08e6d81983cf8f5f702eb6cbac3469ae921", 15:55:29 INFO - "who": "mjzffr@gmail.com", 15:55:29 INFO - "when": 1447458889, 15:55:29 INFO - "number": 6660917, 15:55:29 INFO - "comments": "Bug 1223517 - Release marionette-client 2.0.0 and marionette-driver 1.1.1; r=automatedtester", 15:55:29 INFO - "project": "", 15:55:29 INFO - "at": "Fri 13 Nov 2015 15:54:49", 15:55:29 INFO - "branch": "mozilla-inbound-macosx64-talos", 15:55:29 INFO - "revlink": "", 15:55:29 INFO - "properties": [ 15:55:29 INFO - [ 15:55:29 INFO - "buildid", 15:55:29 INFO - "20151113141429", 15:55:29 INFO - "Change" 15:55:29 INFO - ], 15:55:29 INFO - [ 15:55:29 INFO - "builduid", 15:55:29 INFO - "0cf69c3e376f4accbcbac30dc4782086", 15:55:29 INFO - "Change" 15:55:29 INFO - ], 15:55:29 INFO - [ 15:55:29 INFO - "pgo_build", 15:55:29 INFO - "False", 15:55:29 INFO - "Change" 15:55:29 INFO - ] 15:55:29 INFO - ], 15:55:29 INFO - "revision": "9132d08e6d81983cf8f5f702eb6cbac3469ae921" 15:55:29 INFO - } 15:55:29 INFO - ], 15:55:29 INFO - "revision": "9132d08e6d81983cf8f5f702eb6cbac3469ae921" 15:55:29 INFO - } 15:55:29 INFO - } 15:55:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:55:29 INFO - Running post-action listener: _resource_record_post_action 15:55:29 INFO - ##### 15:55:29 INFO - ##### Running download-and-extract step. 15:55:29 INFO - ##### 15:55:29 INFO - Running pre-action listener: _resource_record_pre_action 15:55:29 INFO - Running main action method: download_and_extract 15:55:29 INFO - mkdir: /builds/slave/test/build/tests 15:55: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')]} 15:55:29 INFO - https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:55:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/test_packages.json 15:55:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/test_packages.json 15:55:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:55:39 INFO - Downloaded 1149 bytes. 15:55:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:55:39 INFO - Using the following test package requirements: 15:55:39 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:55:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:39 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:55:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:39 INFO - u'jsshell-mac.zip'], 15:55:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:39 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:55:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:55:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:39 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:55:39 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:39 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:55:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:39 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:55:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:55:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:39 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:55:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:55:39 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')]} 15:55:39 INFO - https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/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 15:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/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 15:55:53 INFO - Downloaded 17463022 bytes. 15:55:53 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 15:55:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:55:58 INFO - Return code: 0 15:55:58 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 15:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:58 INFO - https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:55:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/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 15:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/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 15:55:59 INFO - Downloaded 17463022 bytes. 15:55:59 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 15:55:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:56:05 INFO - Return code: 0 15:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:05 INFO - https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:56:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:56:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:56:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/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 15:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/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 15:56:06 INFO - Downloaded 11131693 bytes. 15:56:06 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 15:56:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:56:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:56:06 INFO - Return code: 0 15:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:06 INFO - https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:56:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:56:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:56:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/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 15:56:10 INFO - Downloaded 108690395 bytes. 15:56:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:56:10 INFO - mkdir: /builds/slave/test/properties 15:56:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:56:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:56:10 INFO - Contents: 15:56:10 INFO - build_url:https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:56:10 INFO - Running post-action listener: _resource_record_post_action 15:56:10 INFO - Running post-action listener: set_extra_try_arguments 15:56:10 INFO - ##### 15:56:10 INFO - ##### Running populate-webroot step. 15:56:10 INFO - ##### 15:56:10 INFO - Running pre-action listener: _resource_record_pre_action 15:56:10 INFO - Running main action method: populate_webroot 15:56:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:56:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:56:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:56:10 INFO - '../fennec_ids.txt'], 15:56:10 INFO - 'tests': ['tcheck2']}, 15:56:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:56:10 INFO - '--tppagecycles', 15:56:10 INFO - '7'], 15:56:10 INFO - 'tests': ['tsvgm']}}, 15:56:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:56:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:56:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:56:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:56:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:10 INFO - 'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:10 INFO - 'tests': ['damp', 'tps']}, 15:56:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:10 INFO - 'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['damp', 'tps']}, 15:56:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:56:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:10 INFO - 'other': {'tests': ['a11yr', 15:56:10 INFO - 'ts_paint', 15:56:10 INFO - 'tpaint', 15:56:10 INFO - 'sessionrestore', 15:56:10 INFO - 'sessionrestore_no_auto_restore']}, 15:56:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['a11yr', 15:56:10 INFO - 'ts_paint', 15:56:10 INFO - 'tpaint', 15:56:10 INFO - 'sessionrestore', 15:56:10 INFO - 'sessionrestore_no_auto_restore']}, 15:56:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['a11yr', 15:56:10 INFO - 'ts_paint', 15:56:10 INFO - 'tpaint', 15:56:10 INFO - 'sessionrestore', 15:56:10 INFO - 'sessionrestore_no_auto_restore']}, 15:56:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['a11yr', 15:56:10 INFO - 'ts_paint', 15:56:10 INFO - 'tpaint', 15:56:10 INFO - 'sessionrestore', 15:56:10 INFO - 'sessionrestore_no_auto_restore']}, 15:56:10 INFO - 'other_l64': {'tests': ['a11yr', 15:56:10 INFO - 'ts_paint', 15:56:10 INFO - 'tpaint', 15:56:10 INFO - 'sessionrestore', 15:56:10 INFO - 'sessionrestore_no_auto_restore']}, 15:56:10 INFO - 'other_nol64': {'tests': ['a11yr', 15:56:10 INFO - 'ts_paint', 15:56:10 INFO - 'tpaint', 15:56:10 INFO - 'sessionrestore', 15:56:10 INFO - 'sessionrestore_no_auto_restore']}, 15:56:10 INFO - 'svgr': {'tests': ['tsvgx', 15:56:10 INFO - 'tsvgr_opacity', 15:56:10 INFO - 'tart', 15:56:10 INFO - 'tscrollx', 15:56:10 INFO - 'cart']}, 15:56:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['tsvgx', 15:56:10 INFO - 'tsvgr_opacity', 15:56:10 INFO - 'tart', 15:56:10 INFO - 'tscrollx', 15:56:10 INFO - 'cart']}, 15:56:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:10 INFO - 'tests': ['tp5o']}, 15:56:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:10 INFO - 'talos_options': ['--e10s'], 15:56:10 INFO - 'tests': ['tp5o']}, 15:56:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:10 INFO - 'talos_options': ['--xperf_path', 15:56:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:10 INFO - 'tests': ['tp5n']}, 15:56:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:10 INFO - 'talos_options': ['--e10s', 15:56:10 INFO - '--xperf_path', 15:56:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:10 INFO - 'tests': ['tp5n']}}, 15:56:10 INFO - 'talos.zip': {'path': '', 15:56:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:56:10 INFO - Running post-action listener: _resource_record_post_action 15:56:10 INFO - ##### 15:56:10 INFO - ##### Running create-virtualenv step. 15:56:10 INFO - ##### 15:56:10 INFO - Running pre-action listener: _resource_record_pre_action 15:56:10 INFO - Running main action method: create_virtualenv 15:56:10 INFO - Creating virtualenv /builds/slave/test/build/venv 15:56:10 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 15:56:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:56:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:10 INFO - Using real prefix '/tools/python27' 15:56:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:56:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:16 INFO - Installing pip.................done. 15:56:16 INFO - Return code: 0 15:56:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:16 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2964ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045fe9f0>, '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 0x10435edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045f28c8>, '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.VK916FmoOl/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.URnNENKoAd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 15:56:16 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 15:56:16 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 15:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VK916FmoOl/Render', 15:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:16 INFO - 'HOME': '/Users/cltbld', 15:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:16 INFO - 'LOGNAME': 'cltbld', 15:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:16 INFO - 'MOZ_NO_REMOTE': '1', 15:56:16 INFO - 'NO_EM_RESTART': '1', 15:56:16 INFO - 'PAGER': '/bin/cat', 15:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:16 INFO - 'PWD': '/builds/slave/test', 15:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:16 INFO - 'SHELL': '/bin/bash', 15:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.URnNENKoAd/Listeners', 15:56:16 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 15:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:16 INFO - 'USER': 'cltbld', 15:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:16 INFO - 'XPC_FLAGS': '0x0', 15:56:16 INFO - 'XPC_SERVICE_NAME': '0', 15:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:16 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 15:56:16 INFO - Cleaning up... 15:56:16 INFO - Return code: 0 15:56:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:16 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2964ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045fe9f0>, '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 0x10435edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045f28c8>, '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.VK916FmoOl/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.URnNENKoAd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 15:56:16 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 15:56:16 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 15:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VK916FmoOl/Render', 15:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:16 INFO - 'HOME': '/Users/cltbld', 15:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:16 INFO - 'LOGNAME': 'cltbld', 15:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:16 INFO - 'MOZ_NO_REMOTE': '1', 15:56:16 INFO - 'NO_EM_RESTART': '1', 15:56:16 INFO - 'PAGER': '/bin/cat', 15:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:16 INFO - 'PWD': '/builds/slave/test', 15:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:16 INFO - 'SHELL': '/bin/bash', 15:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.URnNENKoAd/Listeners', 15:56:16 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 15:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:16 INFO - 'USER': 'cltbld', 15:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:16 INFO - 'XPC_FLAGS': '0x0', 15:56:16 INFO - 'XPC_SERVICE_NAME': '0', 15:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:17 INFO - Downloading/unpacking psutil>=0.7.1 15:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:56:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:19 INFO - Installing collected packages: psutil 15:56:19 INFO - Running setup.py install for psutil 15:56:19 INFO - building 'psutil._psutil_osx' extension 15:56:19 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 15:56:20 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 15:56:20 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 15:56:20 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 15:56:20 INFO - building 'psutil._psutil_posix' extension 15:56:20 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 15:56:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:56:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:56:20 INFO - ^ 15:56:20 INFO - 1 warning generated. 15:56:20 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 15:56:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:20 INFO - Successfully installed psutil 15:56:20 INFO - Cleaning up... 15:56:20 INFO - Return code: 0 15:56:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:20 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2964ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045fe9f0>, '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 0x10435edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045f28c8>, '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.VK916FmoOl/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.URnNENKoAd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 15:56:20 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 15:56:20 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 15:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VK916FmoOl/Render', 15:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:20 INFO - 'HOME': '/Users/cltbld', 15:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:20 INFO - 'LOGNAME': 'cltbld', 15:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:20 INFO - 'MOZ_NO_REMOTE': '1', 15:56:20 INFO - 'NO_EM_RESTART': '1', 15:56:20 INFO - 'PAGER': '/bin/cat', 15:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:20 INFO - 'PWD': '/builds/slave/test', 15:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:20 INFO - 'SHELL': '/bin/bash', 15:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.URnNENKoAd/Listeners', 15:56:20 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 15:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:20 INFO - 'USER': 'cltbld', 15:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:20 INFO - 'XPC_FLAGS': '0x0', 15:56:20 INFO - 'XPC_SERVICE_NAME': '0', 15:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:56:21 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 15:56:21 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 15:56:21 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 15:56:21 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 15:56:21 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 15:56:21 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 15:56:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:56:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:56:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:56:23 INFO - Installing collected packages: mozsystemmonitor 15:56:23 INFO - Running setup.py install for mozsystemmonitor 15:56:24 INFO - Successfully installed mozsystemmonitor 15:56:24 INFO - Cleaning up... 15:56:24 INFO - Return code: 0 15:56:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:56:24 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')]} 15:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:24 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')]} 15:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:24 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2964ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045fe9f0>, '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 0x10435edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045f28c8>, '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.VK916FmoOl/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.URnNENKoAd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 15:56:24 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 15:56:24 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 15:56:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VK916FmoOl/Render', 15:56:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:24 INFO - 'HOME': '/Users/cltbld', 15:56:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:24 INFO - 'LOGNAME': 'cltbld', 15:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:24 INFO - 'MOZ_NO_REMOTE': '1', 15:56:24 INFO - 'NO_EM_RESTART': '1', 15:56:24 INFO - 'PAGER': '/bin/cat', 15:56:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:24 INFO - 'PWD': '/builds/slave/test', 15:56:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:24 INFO - 'SHELL': '/bin/bash', 15:56:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.URnNENKoAd/Listeners', 15:56:24 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 15:56:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:24 INFO - 'USER': 'cltbld', 15:56:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:24 INFO - 'XPC_FLAGS': '0x0', 15:56:24 INFO - 'XPC_SERVICE_NAME': '0', 15:56:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:24 INFO - Downloading/unpacking blobuploader==1.2.4 15:56:24 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 15:56:24 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 15:56:24 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 15:56:24 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 15:56:24 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 15:56:24 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 15:56:27 INFO - Downloading blobuploader-1.2.4.tar.gz 15:56:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:56:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:56:27 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 15:56:27 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 15:56:27 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 15:56:27 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 15:56:27 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 15:56:27 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 15:56:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:56:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56:28 INFO - Downloading docopt-0.6.1.tar.gz 15:56:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:56:28 INFO - Installing collected packages: blobuploader, requests, docopt 15:56:28 INFO - Running setup.py install for blobuploader 15:56:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:56:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:56:28 INFO - Running setup.py install for requests 15:56:29 INFO - Running setup.py install for docopt 15:56:29 INFO - Successfully installed blobuploader requests docopt 15:56:29 INFO - Cleaning up... 15:56:29 INFO - Return code: 0 15:56:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56: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')]} 15:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:29 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2964ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045fe9f0>, '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 0x10435edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045f28c8>, '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.VK916FmoOl/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.URnNENKoAd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 15:56:29 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 15:56:29 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 15:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VK916FmoOl/Render', 15:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:29 INFO - 'HOME': '/Users/cltbld', 15:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:29 INFO - 'LOGNAME': 'cltbld', 15:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:29 INFO - 'MOZ_NO_REMOTE': '1', 15:56:29 INFO - 'NO_EM_RESTART': '1', 15:56:29 INFO - 'PAGER': '/bin/cat', 15:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:29 INFO - 'PWD': '/builds/slave/test', 15:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:29 INFO - 'SHELL': '/bin/bash', 15:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.URnNENKoAd/Listeners', 15:56:29 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 15:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:29 INFO - 'USER': 'cltbld', 15:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:29 INFO - 'XPC_FLAGS': '0x0', 15:56:29 INFO - 'XPC_SERVICE_NAME': '0', 15:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-x3_bz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-ZkygcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-klrk75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-QjQltY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-vLgYbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-HR7vmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Fn3KYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-6GfAGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-opak0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-dYhAfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-f_4BE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-MwDJkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-PNCOEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-ZKGCMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Fc346S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:32 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-NAvYmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:32 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-3wrGif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:56:32 INFO - Running setup.py install for manifestparser 15:56:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Running setup.py install for mozcrash 15:56:32 INFO - Running setup.py install for mozdebug 15:56:32 INFO - Running setup.py install for mozdevice 15:56:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozfile 15:56:33 INFO - Running setup.py install for mozhttpd 15:56:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozinfo 15:56:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozInstall 15:56:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozleak 15:56:33 INFO - Running setup.py install for mozlog 15:56:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:56:34 INFO - Running setup.py install for moznetwork 15:56:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:56:34 INFO - Running setup.py install for mozprocess 15:56:34 INFO - Running setup.py install for mozprofile 15:56:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:56:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:56:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:56:34 INFO - Running setup.py install for mozrunner 15:56:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:56:34 INFO - Running setup.py install for mozscreenshot 15:56:35 INFO - Running setup.py install for moztest 15:56:35 INFO - Running setup.py install for mozversion 15:56:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:56:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:56:35 INFO - Cleaning up... 15:56:35 INFO - Return code: 0 15:56:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:35 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')]} 15:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:35 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')]} 15:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:35 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2964ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045fe9f0>, '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 0x10435edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045f28c8>, '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.VK916FmoOl/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.URnNENKoAd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 15:56:35 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 15:56:35 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 15:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VK916FmoOl/Render', 15:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:35 INFO - 'HOME': '/Users/cltbld', 15:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:35 INFO - 'LOGNAME': 'cltbld', 15:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:35 INFO - 'MOZ_NO_REMOTE': '1', 15:56:35 INFO - 'NO_EM_RESTART': '1', 15:56:35 INFO - 'PAGER': '/bin/cat', 15:56:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:35 INFO - 'PWD': '/builds/slave/test', 15:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:35 INFO - 'SHELL': '/bin/bash', 15:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.URnNENKoAd/Listeners', 15:56:35 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 15:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:35 INFO - 'USER': 'cltbld', 15:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:35 INFO - 'XPC_FLAGS': '0x0', 15:56:35 INFO - 'XPC_SERVICE_NAME': '0', 15:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:35 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-gWzzX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:36 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)) 15:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Sz0vqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:36 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)) 15:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-oe9AhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:36 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)) 15:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-MzQ5yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:36 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)) 15:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-oY2EGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:36 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)) 15:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-RGr2mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:36 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)) 15:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Pmzk6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:36 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)) 15:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-VoIaEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:36 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)) 15:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-PDQcxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:37 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)) 15:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-rpQaf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:37 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)) 15:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-ft3mrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:37 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)) 15:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-YzMnkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:37 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)) 15:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-iWrbyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:37 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)) 15:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-hu7bs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:37 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)) 15:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-iNVQ9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:37 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)) 15:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-hu3gO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:38 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)) 15:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:38 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Sn1UdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:38 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 15:56:38 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 15:56:38 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 15:56:38 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 15:56:38 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 15:56:38 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 15:56:40 INFO - Downloading blessings-1.5.1.tar.gz 15:56:40 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 15:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:56:40 INFO - Installing collected packages: blessings 15:56:40 INFO - Running setup.py install for blessings 15:56:41 INFO - Successfully installed blessings 15:56:41 INFO - Cleaning up... 15:56:41 INFO - Return code: 0 15:56:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:56:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:41 INFO - Reading from file tmpfile_stdout 15:56:41 INFO - Current package versions: 15:56:41 INFO - blessings == 1.5.1 15:56:41 INFO - blobuploader == 1.2.4 15:56:41 INFO - docopt == 0.6.1 15:56:41 INFO - manifestparser == 1.1 15:56:41 INFO - mozInstall == 1.12 15:56:41 INFO - mozcrash == 0.16 15:56:41 INFO - mozdebug == 0.1 15:56:41 INFO - mozdevice == 0.47 15:56:41 INFO - mozfile == 1.2 15:56:41 INFO - mozhttpd == 0.7 15:56:41 INFO - mozinfo == 0.9 15:56:41 INFO - mozleak == 0.1 15:56:41 INFO - mozlog == 3.0 15:56:41 INFO - moznetwork == 0.27 15:56:41 INFO - mozprocess == 0.22 15:56:41 INFO - mozprofile == 0.27 15:56:41 INFO - mozrunner == 6.11 15:56:41 INFO - mozscreenshot == 0.1 15:56:41 INFO - mozsystemmonitor == 0.0 15:56:41 INFO - moztest == 0.7 15:56:41 INFO - mozversion == 1.4 15:56:41 INFO - psutil == 3.1.1 15:56:41 INFO - requests == 1.2.3 15:56:41 INFO - wsgiref == 0.1.2 15:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:41 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe2964ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045fe9f0>, '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 0x10435edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045f28c8>, '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.VK916FmoOl/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.URnNENKoAd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 15:56:41 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 15:56:41 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 15:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VK916FmoOl/Render', 15:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:41 INFO - 'HOME': '/Users/cltbld', 15:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:41 INFO - 'LOGNAME': 'cltbld', 15:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:41 INFO - 'MOZ_NO_REMOTE': '1', 15:56:41 INFO - 'NO_EM_RESTART': '1', 15:56:41 INFO - 'PAGER': '/bin/cat', 15:56:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:41 INFO - 'PWD': '/builds/slave/test', 15:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:41 INFO - 'SHELL': '/bin/bash', 15:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.URnNENKoAd/Listeners', 15:56:41 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 15:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:41 INFO - 'USER': 'cltbld', 15:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:41 INFO - 'XPC_FLAGS': '0x0', 15:56:41 INFO - 'XPC_SERVICE_NAME': '0', 15:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 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)) 15:56:41 INFO - Cleaning up... 15:56:41 INFO - Return code: 0 15:56:41 INFO - Running post-action listener: _resource_record_post_action 15:56:41 INFO - Running post-action listener: _start_resource_monitoring 15:56:41 INFO - Starting resource monitoring. 15:56:41 INFO - ##### 15:56:41 INFO - ##### Running install step. 15:56:41 INFO - ##### 15:56:41 INFO - Running pre-action listener: _resource_record_pre_action 15:56:41 INFO - Running main action method: install 15:56:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:42 INFO - Reading from file tmpfile_stdout 15:56:42 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:56:42 INFO - Reading from file tmpfile_stdout 15:56:42 INFO - Output received: 15:56:42 INFO - Usage: mozinstall [options] installer 15:56:42 INFO - Options: 15:56:42 INFO - -h, --help show this help message and exit 15:56:42 INFO - -d DEST, --destination=DEST 15:56:42 INFO - Directory to install application into. [default: 15:56:42 INFO - "/builds/slave/test"] 15:56:42 INFO - --app=APP Application being installed. [default: firefox] 15:56:42 INFO - mkdir: /builds/slave/test/build/application 15:56:42 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'] 15:56:42 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 15:57:23 INFO - Reading from file tmpfile_stdout 15:57:23 INFO - Output received: 15:57:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:57:23 INFO - Running post-action listener: _resource_record_post_action 15:57:23 INFO - ##### 15:57:23 INFO - ##### Running run-tests step. 15:57:23 INFO - ##### 15:57:23 INFO - Running pre-action listener: _resource_record_pre_action 15:57:23 INFO - Running main action method: run_tests 15:57:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:57:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:57:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:57:23 INFO - 2015-11-13 15:57:23.657 screenresolution[2217:17131] starting screenresolution argv=screenresolution get 15:57:23 INFO - 2015-11-13 15:57:23.660 screenresolution[2217:17131] Display 0: 1600x1200x32@60 15:57:23 INFO - 2015-11-13 15:57:23.667 screenresolution[2218:17133] starting screenresolution argv=screenresolution list 15:57:23 INFO - Available Modes on Display 0 15:57:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:57:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:57:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:57:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:57:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:57:23 INFO - Intel HD Graphics 3000: 15:57:23 INFO - Chipset Model: Intel HD Graphics 3000 15:57:23 INFO - Type: GPU 15:57:23 INFO - Bus: Built-In 15:57:23 INFO - VRAM (Total): 512 MB 15:57:23 INFO - VRAM (Dynamic, Max): 10 15:57:23 INFO - Vendor: Intel (0x8086) 15:57:23 INFO - Device ID: 0x0116 15:57:23 INFO - Revision ID: 0x0009 15:57:23 INFO - Displays: 15:57:23 INFO - Display: 15:57:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:57:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:57:23 INFO - Display Serial Number: 1600x1200 60 15:57:23 INFO - Main Display: Yes 15:57:23 INFO - Mirror: Off 15:57:23 INFO - Online: Yes 15:57:23 INFO - Rotation: Supported 15:57:23 INFO - Return code: 0 15:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:57:23 INFO - Python 2.7.3 15:57:23 INFO - Return code: 0 15:57:23 INFO - grabbing minidump binary from tooltool 15:57:23 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')]} 15:57:23 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 0x1045fe9f0>, '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 0x10435edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045f28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:57:23 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 15:57:23 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 15:57:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:57:24 INFO - Return code: 0 15:57:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:57:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:57:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:57:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:57:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:57:24 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/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0034', '--webServer', 'localhost'] in /builds/slave/test/build 15:57:24 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/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0034 --webServer localhost 15:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VK916FmoOl/Render', 15:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:24 INFO - 'HOME': '/Users/cltbld', 15:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:24 INFO - 'LOGNAME': 'cltbld', 15:57:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:57:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:24 INFO - 'MOZ_NO_REMOTE': '1', 15:57:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:57:24 INFO - 'NO_EM_RESTART': '1', 15:57:24 INFO - 'PAGER': '/bin/cat', 15:57:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:24 INFO - 'PWD': '/builds/slave/test', 15:57:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:24 INFO - 'SHELL': '/bin/bash', 15:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.URnNENKoAd/Listeners', 15:57:24 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 15:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:24 INFO - 'USER': 'cltbld', 15:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:24 INFO - 'XPC_FLAGS': '0x0', 15:57:24 INFO - 'XPC_SERVICE_NAME': '0', 15:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:57:24 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/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0034', '--webServer', 'localhost'] with output_timeout 3600 15:57:24 INFO - mozversion INFO | application_buildid: 20151113141429 15:57:24 INFO - mozversion INFO | application_changeset: 9132d08e6d81983cf8f5f702eb6cbac3469ae921 15:57:24 INFO - mozversion INFO | application_display_name: Nightly 15:57:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:57:24 INFO - mozversion INFO | application_name: Firefox 15:57:24 INFO - mozversion INFO | application_remotingname: firefox 15:57:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:57:24 INFO - mozversion INFO | application_vendor: Mozilla 15:57:24 INFO - mozversion INFO | application_version: 45.0a1 15:57:24 INFO - mozversion INFO | platform_buildid: 20151113141429 15:57:24 INFO - mozversion INFO | platform_changeset: 9132d08e6d81983cf8f5f702eb6cbac3469ae921 15:57:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:57:24 INFO - mozversion INFO | platform_version: 45.0a1 15:57:24 INFO - 2015-11-13 15:57:24,325 DEBUG : using testdate: 1447459044 15:57:24 INFO - 2015-11-13 15:57:24,325 DEBUG : actual date: 1447459044 15:57:24 INFO - 2015-11-13 15:57:24,372 INFO : starting webserver on 'localhost:50338' 15:57:24 INFO - 2015-11-13 15:57:24,374 INFO : Starting test suite t-yosemite-r5-0034 15:57:24 INFO - 2015-11-13 15:57:24,374 INFO : Starting test dromaeo_css 15:57:24 INFO - 2015-11-13 15:57:24,374 DEBUG : operating with platform_type : mac_ 15:57:24 INFO - 2015-11-13 15:57:24,375 INFO : Initialising browser for dromaeo_css test... 15:57:24 INFO - 2015-11-13 15:57:24,399 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpj4jwvb/profile http://localhost:50338/getInfo.html 15:57:27 INFO - 2015-11-13 15:57:27,492 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:57:27 INFO - 2015-11-13 15:57:27,493 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:57:27 INFO - 2015-11-13 15:57:27,493 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:57:27 INFO - 2015-11-13 15:57:27,493 DEBUG : BROWSER_OUTPUT: __metrics 15:57:27 INFO - 2015-11-13 15:57:27,510 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:57:28 INFO - 2015-11-13 15:57:28,302 INFO : Browser initialized. 15:57:28 INFO - 2015-11-13 15:57:28,302 INFO : Running cycle 1/1 for dromaeo_css test... 15:57:28 INFO - 2015-11-13 15:57:28,302 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpj4jwvb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:57:40 INFO - 2015-11-13 15:57:40,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 230113280 15:57:40 INFO - 2015-11-13 15:57:40,427 DEBUG : BROWSER_OUTPUT: 15:58:32 INFO - 2015-11-13 15:58:32,337 DEBUG : BROWSER_OUTPUT: 1447459112336 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] 16:00:42 INFO - 2015-11-13 16:00:42,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50338/tests/dromaeo/cssquery-ext.html) 16:00:43 INFO - 2015-11-13 16:00:43,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 336912384 16:00:43 INFO - 2015-11-13 16:00:43,641 DEBUG : BROWSER_OUTPUT: 16:03:46 INFO - 2015-11-13 16:03:46,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-ext.html (next: http://localhost:50338/tests/dromaeo/cssquery-jquery.html) 16:03:47 INFO - 2015-11-13 16:03:47,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 367501312 16:03:47 INFO - 2015-11-13 16:03:47,089 DEBUG : BROWSER_OUTPUT: 16:06:49 INFO - 2015-11-13 16:06:49,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50338/tests/dromaeo/cssquery-mootools.html) 16:06:49 INFO - 2015-11-13 16:06:49,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 321511424 16:06:49 INFO - 2015-11-13 16:06:49,944 DEBUG : BROWSER_OUTPUT: 16:09:52 INFO - 2015-11-13 16:09:52,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50338/tests/dromaeo/cssquery-prototype.html) 16:09:52 INFO - 2015-11-13 16:09:52,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 349614080 16:09:52 INFO - 2015-11-13 16:09:52,698 DEBUG : BROWSER_OUTPUT: 16:12:55 INFO - 2015-11-13 16:12:55,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50338/tests/dromaeo/cssquery-yui.html) 16:12:56 INFO - 2015-11-13 16:12:56,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 320032768 16:12:56 INFO - 2015-11-13 16:12:56,519 DEBUG : BROWSER_OUTPUT: 16:15:59 INFO - 2015-11-13 16:15:59,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/dromaeo/cssquery-yui.html (next: http://localhost:50338/tests/dromaeo/cssquery-dojo.html) 16:16:00 INFO - 2015-11-13 16:16:00,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 368308224 16:16:00 INFO - 2015-11-13 16:16:00,024 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,025 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:16:00 INFO - 2015-11-13 16:16:00,025 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:16:00 INFO - 2015-11-13 16:16:00,025 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:16:00 INFO - 2015-11-13 16:16:00,025 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:16:00 INFO - 2015-11-13 16:16:00,026 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2722.618833363329;2771.9168424947256;2774.3757654527726;2790.9162725118254;2833.6741274753394;4554.658400619958;4589.541045895408;4672.205725026745;4701.6003639690625;4776.880577985552;4619.353290539327;4666.206744853366;4716.080364328957;4723.834665786698;4833.033393321332;4389.122175564884;4417.028253784162;4424.137293227822;4456.754878481682;4486.080353527519;4409.625181859546;4460.732356058631;4469.597736203741;4495.483019452756;4534.38785763921;4212.115455754295;4311.6335111515555;4317.352397140423;4396.824127034914;4462.642988560923;4307.181635489247;4321.58944900234;4403.471583409979;4425.579569940851;4431.8448854289945;4337.522872484024;4348.301864268513;4421.358902959053;4436.64506839452;4517.051419201939;4477.597016268552;4620.930686039712;4623.676342656016;4643.303504474322;4716.292556116576;4935.7532123393685;5020.146575082244;5037.5214354636255;5040.697558146487;5053.545180933734;5088.898222035576;5130.846074617767;5194.11700010999;5226.268322434862;5259.631825772198;4555.316702494586;4695.178343789891;4696.412948381452;4776.665633405663;4785.521447855222;5117.539421452013;5157.355330583677;5171.50870667286;5221.55616772571;5240.68555886648;4939.333190019302;5040.79836806531;5043.193089105725;5045.369328833895;5085.160948443539;5049.873753156127;5120.8719782005;5139.408967968731;5179.326687530673;5186.507281808223;4869.9269510957365;4901.3383193269165;4914.70511769295;4937.1606826839525;4940.7035577865445;5015.84952451427;5056.721880296545;5087.135187018216;5112.897742045213;5116.539511443988;3849.8845034649007;3851.268259030775;3920.8235629396745;3941.4876066111797;4018.517777866616;3475;3480.9477857832153;3512.701420379245;3519.788812671248;3531.6291789362263;4688.2733176357715;4701.95298047022;4705.082508910798;4721.858344249678;4739.691920025256;4893.168161412568;5083.262926875583;5108.029474399852;5154.407243167084;5201.843944681666;4701;4702.976485117552;4755.833545825949;4775.092732380836;4814.9518504815205;4474.977625111918;4491.775411229425;4510.391097201901;4528.366028755977;4542.205114105019;4864.051509955666;5018.172001619692;5046.520580544842;5195.064888320063;5267.499587539101;4991.975040124777;5007.5993920487;5019.447860735243;5046.066477701637;5110.029094472038;5063.316452278895;5095.414027386898;5141.151709967813;5146.6911985281;5148.30497882781;4752.857414277577;4789.95210047909;4849.151398505318;4906.852794416173;4914.926276105933;4905.950940490549;4977.129002424489;4981.551660350586;5013.39839219296;5059.898802024012;4845.5881250092725;4920.532549407801;4951.554360107608;4980.925286120639;5033.219850923113;4660.067986402801;4784.880377990578;4815.181419158822;4914.311996320589;4980.701157930535;4597.586217240464;4704.788284527136;4763.7141771493825;4785.712857228577;4835.419749629927;4925.901481970269;4962.181240095344;4963.70217786934;4964.453910069961;5008.799648014185;4712.882177945578;4839.491853355347;4883.536064073907;4888.560029597354;4890.413150421972 16:16:00 INFO - 2015-11-13 16:16:00,026 DEBUG : BROWSER_OUTPUT: |1;ext.html;475.95002524734895;486.25845585482136;497.21191910821346;500.64204094072755;504.28139900641577;26393.604095938554;27239.727602723968;34494.31011379771;34819;35228.647713522856;36608;37133.628663713425;37203.25593488129;37836.43245351315;37839;7032.296770322978;7874.212578742137;8102.18978102191;8176;8188.877166842472;7277.89083163753;9447.81104377912;9691.079347462015;9705.61177552897;9840.655577054804;9520.42877427353;9537.618495260182;9555.904440955606;9561.521923903778;9619.374740641872;7140.535865168799;7382.040334756447;7478.887816682754;9522.476263805487;9613.61545538181;9436.339456238065;9638.75903102421;9657.517124143766;9789.265805064577;9839.950800245953;33747.49378759296;34173.48739768905;34369.48445773315;34718.65281347205;34773.82613086919;2508.097085049381;2636.525425423423;2638.670166229221;2757.200411880552;2890.59531665567;23017;23437.648435273484;23476.178333758235;24093;24320.63519047198;2004.1983206717284;2063.793620637939;2067.2557879163487;2078.95842083159;2191.1783081344497;236875;238092;243526;245608;245658;48188.27717584239;49025.264621030714;52952.47047529552;53226.73386633042;53290.73354633202;46328;55520.72239638776;56825;56831.885130338465;57581.42418575844;13736.175829450265;13930.721385572231;13941.093828901088;13944.651383715489;14128.293585320693;10357.533910974023;10488.475576221159;10538.57845686164;10632.362058276529;10646.733831654115;17178.742318864977;17290.91354543219;17411.129443527774;17568.824311756973;17578.296868125388;7678.57767822764;7915.564643944524;7929;7947.602619869099;8068.3948703847445;801.6993627389729;867.3624885708999;979.4906648542718;996.3722854601555;1005.8239808033564;24224.87887560551;24261.878690606434;24379.39051523726;24410.38974025628;24424.87787561051;899.3030401438806;921.6774129054911;925.3291363761354;949.3734135470556;990.5790039233297;12740.490380384867;13798;14501.854981450051;14508.854911450962;14522;328178;330313;331735;332345;333375;48946.51053489491;49748.50251497439;49998.250026248905;50528.49471505238;50629.49370506248;1206.390772659801;1210.7094297368744;1226.2090951336515;1231.6920769807548;1234.3026190202506;22775.544489110456;25216.74783252144;25361.619575706747;25620.743792561836;25735.356616084748;42490.150196995266;42997;43469.565304347816;43501.782491088605;43674.34488482739;235921;237859;238356;240330;242442;22822;23277.883610581837;26330.73669263283;27006;27336;31513.527297090102;31940.32686241112;32182.67817321797;32578.83710581432;32917.17707057247;27169.353113010275;28574;29009.12972610825;29342;29386.706132939253;28930.27674308159;28974.565381519715;28989.420211596072;29191.270218244714;29343.413131737674;29467.11598652044;33806.49290260599;35181.472277916364;35496;35513.28973420569;25616.487670246865;27695;27760.86119569389;27772.722272777013;27803;20951.58096838085;21078.262260820797;21102.155913763276;21328.14687412486;21413.357599272047 16:16:00 INFO - 2015-11-13 16:16:00,030 DEBUG : BROWSER_OUTPUT: |2;jquery.html;283.05882939227075;289.3085525593831;291.66895573524044;292.9033418971739;296.0172228202369;12551.184173028747;12957.611271661865;14925.029873058244;15209.163496007715;15447.073175609472;9964.950175249132;10470.057694807465;10473.633422830202;13404.262765547892;15192.772108418383;3746.925061498775;3825.713071519633;3854.036490877281;3879.689624830021;3881.5342158940966;2915.4606397816365;2962.866670999799;2972.0637999030237;3859.5561510426237;3913.31516984528;3909.1009067914397;3965.722399432041;3989.880303590897;4117.773522456264;4147.937780933288;3982.1637456134245;4058.736182148166;4059.2287465381482;4074.2666320062376;4105.733127346728;3486.773359731609;3497.6502349765074;3500.5799304083416;3501.2822371414054;3569.089882080079;11261.943690281496;11356.205065645408;11527.654170374903;11553.94223028888;11566.595169169123;1584.1841451652408;1596.1939220693475;1596.6726821001666;1673.230314055536;1738.8462814336606;7933.286004259587;8040.276375126266;8216.014078310582;8349.916500834976;8371.414001019932;1276.1768659214754;1302.8631993640627;1318.7692153873033;1335;1358.6060042587637;44214;46408;46751.29873051907;47584.286235706495;49442.75278623584;5648.491635752802;5677.886442271214;5729.0260655688635;5731.054376027909;5799.9130013049;6494.123293355431;6502.512311576651;6534.313897040837;6615.437687796495;6625.635590042594;4638.234691275901;4653.464851542049;4700.247960326331;4702.764861756898;4763.642726795504;4840.782164802592;4874.975625121851;4970.950290497121;4972.105021096165;5008.198688209942;2552.680914885639;2557.1050132453493;2569.755873192044;2577.76800087993;2589.3526618345413;843.8565743417703;885.154677283193;889.2441424788877;911.3301723233418;938.863864739609;328.93914625794304;370.1209627135553;391.72774921429334;401.7689828348711;405.72208037493823;9544.475053871965;9822;9917.107460328605;10337.534810933526;10434.321769084985;348.33989589727327;389.5189441040313;389.96100389961344;403.75371023675535;429.04323358909807;5028.622853286018;5320.627556071116;5408.269883565747;5417.810376636878;5436.266104075899;302372;310887;314028;444314;458262;62234.688826555575;62596.374036259964;63870;65235.69528609496;65287.67356163189;430.2921693813659;431.0688911950173;432.2629915993224;432.4507874998734;438.90563528841454;9278;9422.481763503074;9559.713208603753;9635.373700709431;9715.514224288898;28680.426391472472;29267.70732292735;29605.25986850346;30088.699113008588;30159.09522714322;36246;36841.44737828881;37516.81241593775;37659.62340376561;38000.42999355067;5273.683578985273;5297.735113244399;5357.8392648220615;5364.249005139206;5379.1393377059485;9405.153536181777;9994;10150.441725705157;10163.288569800043;10265.794684106426;8301.750947471586;8543.871841922251;8742.650293988423;8794.252488538546;8842.248408885316;8548.914510854811;8570.74287771368;8748.212660860552;8795.340349473943;8828.558572071242;7784.377249820114;9116.088391161096;9118.954405228196;9167.12912273333;9220.861687074834;4933.260010998379;5065.468125846733;5101.234814777813;5316.627836051594;5370.167624018283;8504.659813607386;8582.356323275904;8679.435836670596;8753.299736020976;8769.517676527852 16:16:00 INFO - 2015-11-13 16:16:00,030 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1046.9424181670006;1401.747685416625;1483.1990725008495;1485.5766106659598;1540.4223416218915;5534.667919924807;6047.516198704104;6057.909131363028;6343.238811342645;6361.5864968777;6143.35494773048;6229.781957631484;6244.281907580629;6249.343818899007;6260.123582698426;1640.3356640560592;1724.284421964883;1873.925042998282;1874.297138573035;1901.8003109673493;1609.9678006439865;1856.8236017578377;1884.896330701811;1912.5027492851889;1913.6172765446897;1836.5316844204708;1840.0523730278917;1859.7861245956685;1865;1866.038989920192;1856.053412759489;1883.7645294338208;1887.6696578098847;1891.1111777464569;1895.0998275818877;1869.4204796512988;1881.3791448821855;1907.1989764299028;1921.5484361175113;1932.8357089647398;6069.15031895535;6069.878602427927;6147.385261473862;6149.29283132441;6150.7232174552255;3941.4679018332445;3996.800159991989;4027.6375126238486;4034.435179074932;4045.0494133878515;2414.1791790791217;2437.9024839006597;2450.3016640257442;2461.9876900615563;2487.7885379742743;745.2621904314743;748.1321666866409;749.2657195947947;773.3542492019171;784.9764507064797;8269.173082691743;8307.626156822958;8377.41358104933;8394.622241999125;8609.655613775441;3556.964430355715;3574.660407261306;3636.381815091441;3726.1802403471193;3731.8320675569666;7006.404455621329;7123;7219.711211551584;7220.097487814023;7233.819154521074;4000.0399904022825;4064.1871625674394;4074.75551466907;4076.5311989121633;4077.7145599807727;3659.835307411173;3690.501782259414;3707.073231692077;3718.4980027696456;3768.4158955361963;2863.141057682687;3130.5304204369527;3171.3657268546385;3185.665505121975;3227.177069847174;897.537768049455;1005.6228914157191;1064.723171975292;1065.1744897704186;1076.6016573867719;916.2303664921498;919.4896832258028;926.6478738079487;958.8993155718549;1134.2003887259461;6039.78860739872;6094.939050609526;6125.908111378333;6144.354842741448;6191.226096737908;985.0248254228405;986.1962500562018;987.2891518106951;993.6770549571273;1019.8215312320463;4761.190597598416;4826.58973987215;4861.465238823726;4907.9263811042865;4911.852644420673;7262.346388825031;7592.278733520307;7623.923760762322;7636.274553917369;7657;7558.395328373717;7588.203238659861;7588.317051465395;7591.544507329468;7617.314441700273;5918.940810591839;6031.909521357183;6121.357257487989;6134.601250918676;6147.047207682816;5876.471117599265;5894.410558944071;5899.144624029577;5908.261467316585;5918.141869428822;6676.465882729467;6755.864882702417;6771.950347696115;6820.283870193558;6824.317568243136;6817;6863;6923.9653801730665;6949.617771022642;7052.717891284291;5661.122526008476;5701.344345400166;5730.942690573041;5750.166225897305;5765.221695071112;5571.303587051619;5935.258092738408;5957.046872500379;6004.87990240184;6026.698665066641;4952.678075925053;5493.7802487900035;5629.831105066854;5654.547636189177;5791.7683292667825;5591.440855914376;5723.42765723441;5730.885382292247;5734.856628584319;5826.446487583673;5680.943190568041;5705.144228365778;5720.74256658443;5721.856953576027;5808.94191058084;5134.666246693953;5197.558207552249;5207.895842083213;5218.347706536683;5229;5293.417724050274;5346.064438723286;5380.408155102858;5383.7308134593895;5384.946150538602 16:16:00 INFO - 2015-11-13 16:16:00,034 DEBUG : BROWSER_OUTPUT: |4;prototype.html;263.5427533229846;263.69543177629845;265.58170880862644;268.60515042886954;271.50043919188715;5318.707471089088;5376.838694839156;5379.81170659027;5457.2359869618285;5473.233747275384;4822;5256.684598924067;5285.814996475124;5340.572754179666;5348.438413966536;3838.2131663009154;3954.6638535724496;3997.780122093284;4072.1041370898356;4155.937660935088;4123.567025462328;4154.6676265898805;4164.146349998258;4164.916701665965;4224.112936283369;4043.716939814214;4106.938395924063;4133.21468920904;4138.6482149017365;4140.254754144253;3901.9804900975455;3968.1270120573427;3998.980005099985;4041.1513582147786;4160.126373461577;3524.101354154674;3538.2039041215776;3572.3212589607892;3573.928521429557;3580.7672501287593;5210.713410762407;5216.58267338612;5225.268462415265;5227.843164705065;5299.364076310867;4600.332951721982;4606.401167848192;4618.145643056012;4620.537946205386;4686.109639168581;5467.699276539789;5610.635308704921;5625.38120806711;5626.887462250732;5697.9430205698245;3823.3691440912216;3828.7511311764647;3829.5787463379006;3846.9807650961566;3871.032241939515;5886.2642169729215;5896.557758168155;5931.762729490815;5933.16935629008;6010.398960103955;3877.592852750477;3909.5504017038406;3933.095388060762;3941.4876066111797;3954.2486927483687;3709.3879509880567;3860.864869729546;3860.9806950965067;3951.8616848410165;3969.702272329529;4502.909941801146;4504.977475112603;4510.548945105529;4568.931466028012;4573.5426457354;5616.634918730351;5617.831465055973;5696.629719068247;5714.371419143974;5727.398623144593;1348.373006551958;1359.463012110211;1359.632899117233;1374.752544541992;1378.0491460891953;863.5336918064176;875.9605817738217;879.3536750488386;888.9733308000771;892.433304851424;5316.973415132899;5342.412334643186;5399.784008639689;5403.810866619728;5436.836894893159;5863.179154918314;5885;5890.558208134321;5929.762809487572;5942.108683697394;5317.946820531823;5375.408705042442;5384.5692344612335;5404.675719456845;5415;3026.772992025607;3042.34589563245;3065.785395022327;3163.7152656260587;3185.522171674221;5987.012142996444;6095.969520152459;6118.388161183846;6119.449249567471;6147.72335244915;6129.693515324216;6153.046277826944;6159.599626024294;6163.722632481549;6177.598456100339;5921.822345329647;6011.579189456696;6026.186464827192;6141.84645383869;6202.681565362509;5873.2658417697785;5976.760929562769;6018.067199584071;6026.578139530191;6035.758569657164;5827.067669172912;5827.912581311369;5845.3570107289015;5881.617694849821;5883.852903677443;5993.891130140763;5996.910046349221;6060.090986352083;6108.75564977396;6120.204373431426;3668.559772827278;3766.8493260269283;3797.411401232813;3804.2201348723997;3819.4079917612817;5850.707464626837;5871.6770577618645;5960.940390596212;5962.344142144274;5976.521878249642;5719.199312096393;5757.5393968481585;5771.59598828078;5809.8547536311935;5872.0898260769645;5556.833295001156;5703.914441283467;5706.28671416073;5771.769129234952;5772.595918285848;5552.7223638818705;5569.832905012856;5580.274564306615;5607.523360514402;5657.858553536194;5412.377576578587;5689.914651280152;5705.144228365612;5735.971320143372;5748.137779333133;5410.918836217381;5449.509544141047;5514.255575497256;5527.281453411191;5587.189857470726 16:16:00 INFO - 2015-11-13 16:16:00,035 DEBUG : BROWSER_OUTPUT: |5;yui.html;653.9542232043759;665.6838001949075;666.1040899989515;666.782773119697;667.6027763480729;11830.881691183085;12087;12111.21277116989;12133;12265.325407102617;11201.439928003609;11253.774924501506;11269.09847212223;11333.546658133686;11381.544738210461;603.3001718007113;611.3305930006636;611.523012050599;760.3840888880011;782.1201148707704;750.3696894608528;760.4106817216674;761.9466637335361;771.6334740998009;772.1737740617541;788.5426452657445;804.6137853830165;804.6178065418937;807.1928071928072;811.3549727966281;616.5129547657345;633.9270983836872;638.04612104903;780.0911937592698;816.94281400302;587.3773799772255;593.970301484924;594.2749845188863;597.7011494252873;599.2479438304899;11694.239874408137;11885.049196064294;11897.524099036029;11904.345261010641;12257;9752.171065459444;10210.387376757344;10339;10465.529051192714;10694.358338499715;7970.721024764105;8061.435699501038;8199.95900020502;8204.343652507785;8283.792905177419;2810.241234866595;2894.2619631993707;2910.7089291070934;2940.588317635533;3022.1084779989956;41534;41830;42647.78676106631;42848.57151428477;43098.92252693677;7813.960930195426;7838.764837054898;7933.484323519068;7947.920520794718;7951.284384405431;16673.33226683725;16867.493975180765;16979.405720799714;16980.150992450574;16996.745048824032;5879.176915231871;5891.7054147292465;6131.724072416752;6284.937150628527;6318.210223722035;3228.1445416964525;3280.114369120324;3498.772579782306;3501.4047611906035;3531.6644918732677;2459.8032157427365;2498.2255500794813;2498.487809998946;2544.75824796644;2552.183301343552;361.89324149375994;363.3659264583319;377.9338615742234;378.4947095627313;379.85755341746847;468.0802223630514;482.27899290560134;506.6731957887142;513.1411783388894;524.0122369333833;6550.508711846535;6733.158355205599;6792.150981127359;6941.479389045841;7079.469039822034;355.3816359534392;395.4601968313289;447.74702293204234;457.2615226409325;472.85341544121434;3286.556314897506;3298.703116719507;3369.376665316924;3413.5391722117197;3418.709409700203;49850;49939;50567.24149137766;50905.23642145371;51039.489605104216;43028.354574681405;43816.561834381886;43878.34182487265;43931.34102988458;44223.77888110603;40210.19579608391;40519.79740101281;41295;41346.586534134876;41499.792501037904;6615.338466153346;6621.966890165711;6706.698198580978;6788.355106264897;6822;28845.423091538472;29132.708672913;29260.122196334145;29500.262493437836;30184.698153018187;36676;36678.63321366859;37895.43156852594;40066.599334006285;40471.19057618772;6453.645049522322;6535.117759102651;6610.206775186816;6782.457403407617;6941.501059618634;9704.2721795867;9706.563204655666;9732.314239374453;9777.657781977596;10273.9486302568;9230.584623691815;9344.813103738023;9377.296702747184;9384.81230375375;9416.10546998034;9147.313951453534;9265.53672316395;9279.39683920543;9281.582328795086;9414;9030.729078127404;9079.68221112258;9189.632414703605;9331.626734930798;9370.34407591462;7717.305442510201;7909.446338756462;8003.439759216799;8079.798005049921;8192.221738934792;7703.845923081619;7772.145064043064;7893.36853051743;7971.880421793562;8260.83478330418 16:16:00 INFO - 2015-11-13 16:16:00,035 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:16:00 INFO - 2015-11-13 16:16:00,035 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:16:00 INFO - 2015-11-13 16:16:00,035 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,957 16:16:00 INFO - 2015-11-13 16:16:00,036 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:16:00 INFO - 2015-11-13 16:16:00,036 DEBUG : BROWSER_OUTPUT: __startTimestamp1447460160021__endTimestamp 16:16:00 INFO - 2015-11-13 16:16:00,036 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,036 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:16:00 INFO - 2015-11-13 16:16:00,036 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:16:00 INFO - 2015-11-13 16:16:00,036 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,037 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4694.15 Median:4814.95 stddev:501.75 (10.4%) stddev-sans-first:478.86 16:16:00 INFO - 2015-11-13 16:16:00,038 DEBUG : BROWSER_OUTPUT: Values: 2722.6 2771.9 2774.4 2790.9 2833.7 4554.7 4589.5 4672.2 4701.6 4776.9 4619.4 4666.2 4716.1 4723.8 4833.0 4389.1 4417.0 4424.1 4456.8 4486.1 4409.6 4460.7 4469.6 4495.5 4534.4 4212.1 4311.6 4317.4 4396.8 4462.6 4307.2 4321.6 4403.5 4425.6 4431.8 4337.5 4348.3 4421.4 4436.6 4517.1 4477.6 4620.9 4623.7 4643.3 4716.3 4935.8 5020.1 5037.5 5040.7 5053.5 5088.9 5130.8 5194.1 5226.3 5259.6 4555.3 4695.2 4696.4 4776.7 4785.5 5117.5 5157.4 5171.5 5221.6 5240.7 4939.3 5040.8 5043.2 5045.4 5085.2 5049.9 5120.9 5139.4 5179.3 5186.5 4869.9 4901.3 4914.7 4937.2 4940.7 5015.8 5056.7 5087.1 5112.9 5116.5 3849.9 3851.3 3920.8 3941.5 4018.5 3475.0 3480.9 3512.7 3519.8 3531.6 4688.3 4702.0 4705.1 4721.9 4739.7 4893.2 5083.3 5108.0 5154.4 5201.8 4701.0 4703.0 4755.8 4775.1 4815.0 4475.0 4491.8 4510.4 4528.4 4542.2 4864.1 5018.2 5046.5 5195.1 5267.5 4992.0 5007.6 5019.4 5046.1 5110.0 5063.3 5095.4 5141.2 5146.7 5148.3 4752.9 4790.0 4849.2 4906.9 4914.9 4906.0 4977.1 4981.6 5013.4 5059.9 4845.6 4920.5 4951.6 4980.9 5033.2 4660.1 4784.9 4815.2 4914.3 4980.7 4597.6 4704.8 4763.7 4785.7 4835.4 4925.9 4962.2 4963.7 4964.5 5008.8 4712.9 4839.5 4883.5 4888.6 4890.4 16:16:00 INFO - 2015-11-13 16:16:00,038 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,038 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41721.47 Median:32061.50 stddev:71897.72 (224.2%) stddev-sans-first:72032.71 16:16:00 INFO - 2015-11-13 16:16:00,040 DEBUG : BROWSER_OUTPUT: Values: 476.0 486.3 497.2 500.6 504.3 26393.6 27239.7 34494.3 34819.0 35228.6 36608.0 37133.6 37203.3 37836.4 37839.0 7032.3 7874.2 8102.2 8176.0 8188.9 7277.9 9447.8 9691.1 9705.6 9840.7 9520.4 9537.6 9555.9 9561.5 9619.4 7140.5 7382.0 7478.9 9522.5 9613.6 9436.3 9638.8 9657.5 9789.3 9840.0 33747.5 34173.5 34369.5 34718.7 34773.8 2508.1 2636.5 2638.7 2757.2 2890.6 23017.0 23437.6 23476.2 24093.0 24320.6 2004.2 2063.8 2067.3 2079.0 2191.2 236875.0 238092.0 243526.0 245608.0 245658.0 48188.3 49025.3 52952.5 53226.7 53290.7 46328.0 55520.7 56825.0 56831.9 57581.4 13736.2 13930.7 13941.1 13944.7 14128.3 10357.5 10488.5 10538.6 10632.4 10646.7 17178.7 17290.9 17411.1 17568.8 17578.3 7678.6 7915.6 7929.0 7947.6 8068.4 801.7 867.4 979.5 996.4 1005.8 24224.9 24261.9 24379.4 24410.4 24424.9 899.3 921.7 925.3 949.4 990.6 12740.5 13798.0 14501.9 14508.9 14522.0 328178.0 330313.0 331735.0 332345.0 333375.0 48946.5 49748.5 49998.3 50528.5 50629.5 1206.4 1210.7 1226.2 1231.7 1234.3 22775.5 25216.7 25361.6 25620.7 25735.4 42490.2 42997.0 43469.6 43501.8 43674.3 235921.0 237859.0 238356.0 240330.0 242442.0 22822.0 23277.9 26330.7 27006.0 27336.0 31513.5 31940.3 32182.7 32578.8 32917.2 27169.4 28574.0 29009.1 29342.0 29386.7 28930.3 28974.6 28989.4 29191.3 29343.4 29467.1 33806.5 35181.5 35496.0 35513.3 25616.5 27695.0 27760.9 27772.7 27803.0 20951.6 21078.3 21102.2 21328.1 21413.4 16:16:00 INFO - 2015-11-13 16:16:00,040 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,040 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19946.05 Median:435.68 stddev:61288.04 (14067.3%) stddev-sans-first:61442.18 16:16:00 INFO - 2015-11-13 16:16:00,041 DEBUG : BROWSER_OUTPUT: Values: 283.1 289.3 291.7 292.9 296.0 12551.2 12957.6 14925.0 15209.2 15447.1 9965.0 10470.1 10473.6 13404.3 15192.8 3746.9 3825.7 3854.0 3879.7 3881.5 2915.5 2962.9 2972.1 3859.6 3913.3 3909.1 3965.7 3989.9 4117.8 4147.9 3982.2 4058.7 4059.2 4074.3 4105.7 3486.8 3497.7 3500.6 3501.3 3569.1 11261.9 11356.2 11527.7 11553.9 11566.6 1584.2 1596.2 1596.7 1673.2 1738.8 7933.3 8040.3 8216.0 8349.9 8371.4 1276.2 1302.9 1318.8 1335.0 1358.6 44214.0 46408.0 46751.3 47584.3 49442.8 5648.5 5677.9 5729.0 5731.1 5799.9 6494.1 6502.5 6534.3 6615.4 6625.6 4638.2 4653.5 4700.2 4702.8 4763.6 4840.8 4875.0 4971.0 4972.1 5008.2 2552.7 2557.1 2569.8 2577.8 2589.4 843.9 885.2 889.2 911.3 938.9 328.9 370.1 391.7 401.8 405.7 9544.5 9822.0 9917.1 10337.5 10434.3 348.3 389.5 390.0 403.8 429.0 5028.6 5320.6 5408.3 5417.8 5436.3 302372.0 310887.0 314028.0 444314.0 458262.0 62234.7 62596.4 63870.0 65235.7 65287.7 430.3 431.1 432.3 432.5 438.9 9278.0 9422.5 9559.7 9635.4 9715.5 28680.4 29267.7 29605.3 30088.7 30159.1 36246.0 36841.4 37516.8 37659.6 38000.4 5273.7 5297.7 5357.8 5364.2 5379.1 9405.2 9994.0 10150.4 10163.3 10265.8 8301.8 8543.9 8742.7 8794.3 8842.2 8548.9 8570.7 8748.2 8795.3 8828.6 7784.4 9116.1 9119.0 9167.1 9220.9 4933.3 5065.5 5101.2 5316.6 5370.2 8504.7 8582.4 8679.4 8753.3 8769.5 16:16:00 INFO - 2015-11-13 16:16:00,042 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,042 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4452.08 Median:5703.24 stddev:2240.32 (39.3%) stddev-sans-first:2231.98 16:16:00 INFO - 2015-11-13 16:16:00,042 DEBUG : BROWSER_OUTPUT: Values: 1046.9 1401.7 1483.2 1485.6 1540.4 5534.7 6047.5 6057.9 6343.2 6361.6 6143.4 6229.8 6244.3 6249.3 6260.1 1640.3 1724.3 1873.9 1874.3 1901.8 1610.0 1856.8 1884.9 1912.5 1913.6 1836.5 1840.1 1859.8 1865.0 1866.0 1856.1 1883.8 1887.7 1891.1 1895.1 1869.4 1881.4 1907.2 1921.5 1932.8 6069.2 6069.9 6147.4 6149.3 6150.7 3941.5 3996.8 4027.6 4034.4 4045.0 2414.2 2437.9 2450.3 2462.0 2487.8 745.3 748.1 749.3 773.4 785.0 8269.2 8307.6 8377.4 8394.6 8609.7 3557.0 3574.7 3636.4 3726.2 3731.8 7006.4 7123.0 7219.7 7220.1 7233.8 4000.0 4064.2 4074.8 4076.5 4077.7 3659.8 3690.5 3707.1 3718.5 3768.4 2863.1 3130.5 3171.4 3185.7 3227.2 897.5 1005.6 1064.7 1065.2 1076.6 916.2 919.5 926.6 958.9 1134.2 6039.8 6094.9 6125.9 6144.4 6191.2 985.0 986.2 987.3 993.7 1019.8 4761.2 4826.6 4861.5 4907.9 4911.9 7262.3 7592.3 7623.9 7636.3 7657.0 7558.4 7588.2 7588.3 7591.5 7617.3 5918.9 6031.9 6121.4 6134.6 6147.0 5876.5 5894.4 5899.1 5908.3 5918.1 6676.5 6755.9 6772.0 6820.3 6824.3 6817.0 6863.0 6924.0 6949.6 7052.7 5661.1 5701.3 5730.9 5750.2 5765.2 5571.3 5935.3 5957.0 6004.9 6026.7 4952.7 5493.8 5629.8 5654.5 5791.8 5591.4 5723.4 5730.9 5734.9 5826.4 5680.9 5705.1 5720.7 5721.9 5808.9 5134.7 5197.6 5207.9 5218.3 5229.0 5293.4 5346.1 5380.4 5383.7 5384.9 16:16:00 INFO - 2015-11-13 16:16:00,042 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,042 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4725.44 Median:5407.80 stddev:1470.01 (27.2%) stddev-sans-first:1435.48 16:16:00 INFO - 2015-11-13 16:16:00,044 DEBUG : BROWSER_OUTPUT: Values: 263.5 263.7 265.6 268.6 271.5 5318.7 5376.8 5379.8 5457.2 5473.2 4822.0 5256.7 5285.8 5340.6 5348.4 3838.2 3954.7 3997.8 4072.1 4155.9 4123.6 4154.7 4164.1 4164.9 4224.1 4043.7 4106.9 4133.2 4138.6 4140.3 3902.0 3968.1 3999.0 4041.2 4160.1 3524.1 3538.2 3572.3 3573.9 3580.8 5210.7 5216.6 5225.3 5227.8 5299.4 4600.3 4606.4 4618.1 4620.5 4686.1 5467.7 5610.6 5625.4 5626.9 5697.9 3823.4 3828.8 3829.6 3847.0 3871.0 5886.3 5896.6 5931.8 5933.2 6010.4 3877.6 3909.6 3933.1 3941.5 3954.2 3709.4 3860.9 3861.0 3951.9 3969.7 4502.9 4505.0 4510.5 4568.9 4573.5 5616.6 5617.8 5696.6 5714.4 5727.4 1348.4 1359.5 1359.6 1374.8 1378.0 863.5 876.0 879.4 889.0 892.4 5317.0 5342.4 5399.8 5403.8 5436.8 5863.2 5885.0 5890.6 5929.8 5942.1 5317.9 5375.4 5384.6 5404.7 5415.0 3026.8 3042.3 3065.8 3163.7 3185.5 5987.0 6096.0 6118.4 6119.4 6147.7 6129.7 6153.0 6159.6 6163.7 6177.6 5921.8 6011.6 6026.2 6141.8 6202.7 5873.3 5976.8 6018.1 6026.6 6035.8 5827.1 5827.9 5845.4 5881.6 5883.9 5993.9 5996.9 6060.1 6108.8 6120.2 3668.6 3766.8 3797.4 3804.2 3819.4 5850.7 5871.7 5960.9 5962.3 5976.5 5719.2 5757.5 5771.6 5809.9 5872.1 5556.8 5703.9 5706.3 5771.8 5772.6 5552.7 5569.8 5580.3 5607.5 5657.9 5412.4 5689.9 5705.1 5736.0 5748.1 5410.9 5449.5 5514.3 5527.3 5587.2 16:16:00 INFO - 2015-11-13 16:16:00,044 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,044 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11706.31 Median:3233.28 stddev:13959.24 (431.7%) stddev-sans-first:13973.72 16:16:00 INFO - 2015-11-13 16:16:00,045 DEBUG : BROWSER_OUTPUT: Values: 654.0 665.7 666.1 666.8 667.6 11830.9 12087.0 12111.2 12133.0 12265.3 11201.4 11253.8 11269.1 11333.5 11381.5 603.3 611.3 611.5 760.4 782.1 750.4 760.4 761.9 771.6 772.2 788.5 804.6 804.6 807.2 811.4 616.5 633.9 638.0 780.1 816.9 587.4 594.0 594.3 597.7 599.2 11694.2 11885.0 11897.5 11904.3 12257.0 9752.2 10210.4 10339.0 10465.5 10694.4 7970.7 8061.4 8200.0 8204.3 8283.8 2810.2 2894.3 2910.7 2940.6 3022.1 41534.0 41830.0 42647.8 42848.6 43098.9 7814.0 7838.8 7933.5 7947.9 7951.3 16673.3 16867.5 16979.4 16980.2 16996.7 5879.2 5891.7 6131.7 6284.9 6318.2 3228.1 3280.1 3498.8 3501.4 3531.7 2459.8 2498.2 2498.5 2544.8 2552.2 361.9 363.4 377.9 378.5 379.9 468.1 482.3 506.7 513.1 524.0 6550.5 6733.2 6792.2 6941.5 7079.5 355.4 395.5 447.7 457.3 472.9 3286.6 3298.7 3369.4 3413.5 3418.7 49850.0 49939.0 50567.2 50905.2 51039.5 43028.4 43816.6 43878.3 43931.3 44223.8 40210.2 40519.8 41295.0 41346.6 41499.8 6615.3 6622.0 6706.7 6788.4 6822.0 28845.4 29132.7 29260.1 29500.3 30184.7 36676.0 36678.6 37895.4 40066.6 40471.2 6453.6 6535.1 6610.2 6782.5 6941.5 9704.3 9706.6 9732.3 9777.7 10273.9 9230.6 9344.8 9377.3 9384.8 9416.1 9147.3 9265.5 9279.4 9281.6 9414.0 9030.7 9079.7 9189.6 9331.6 9370.3 7717.3 7909.4 8003.4 8079.8 8192.2 7703.8 7772.1 7893.4 7971.9 8260.8 16:16:00 INFO - 2015-11-13 16:16:00,045 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:16:00 INFO - 2015-11-13 16:16:00,045 DEBUG : BROWSER_OUTPUT: 16:16:00 INFO - 2015-11-13 16:16:00,754 INFO : Browser exited with error code: 0 16:16:00 INFO - 2015-11-13 16:16:00,785 INFO : Completed test dromaeo_css (00:18:36) 16:16:00 INFO - 2015-11-13 16:16:00,785 INFO : Starting test kraken 16:16:00 INFO - 2015-11-13 16:16:00,785 DEBUG : operating with platform_type : mac_ 16:16:00 INFO - 2015-11-13 16:16:00,785 INFO : Initialising browser for kraken test... 16:16:00 INFO - 2015-11-13 16:16:00,800 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpPWKn_K/profile http://localhost:50338/getInfo.html 16:16:03 INFO - 2015-11-13 16:16:03,301 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:16:03 INFO - 2015-11-13 16:16:03,302 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:16:03 INFO - 2015-11-13 16:16:03,302 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:16:03 INFO - 2015-11-13 16:16:03,302 DEBUG : BROWSER_OUTPUT: __metrics 16:16:03 INFO - 2015-11-13 16:16:03,318 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:16:04 INFO - 2015-11-13 16:16:04,099 INFO : Browser initialized. 16:16:04 INFO - 2015-11-13 16:16:04,100 INFO : Running cycle 1/1 for kraken test... 16:16:04 INFO - 2015-11-13 16:16:04,100 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpPWKn_K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:16:16 INFO - 2015-11-13 16:16:16,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 231153664 16:16:16 INFO - 2015-11-13 16:16:16,241 DEBUG : BROWSER_OUTPUT: 16:16:19 INFO - 2015-11-13 16:16:19,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50338/tests/kraken/driver.html?testName=audio-beat-detection) 16:16:19 INFO - 2015-11-13 16:16:19,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 287395840 16:16:19 INFO - 2015-11-13 16:16:19,690 DEBUG : BROWSER_OUTPUT: 16:16:22 INFO - 2015-11-13 16:16:22,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50338/tests/kraken/driver.html?testName=audio-dft) 16:16:23 INFO - 2015-11-13 16:16:23,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 300843008 16:16:23 INFO - 2015-11-13 16:16:23,319 DEBUG : BROWSER_OUTPUT: 16:16:26 INFO - 2015-11-13 16:16:26,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50338/tests/kraken/driver.html?testName=audio-fft) 16:16:27 INFO - 2015-11-13 16:16:27,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 283066368 16:16:27 INFO - 2015-11-13 16:16:27,240 DEBUG : BROWSER_OUTPUT: 16:16:29 INFO - 2015-11-13 16:16:29,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50338/tests/kraken/driver.html?testName=audio-oscillator) 16:16:30 INFO - 2015-11-13 16:16:30,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 285347840 16:16:30 INFO - 2015-11-13 16:16:30,088 DEBUG : BROWSER_OUTPUT: 16:16:32 INFO - 2015-11-13 16:16:32,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:16:33 INFO - 2015-11-13 16:16:33,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 285769728 16:16:33 INFO - 2015-11-13 16:16:33,105 DEBUG : BROWSER_OUTPUT: 16:16:36 INFO - 2015-11-13 16:16:36,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50338/tests/kraken/driver.html?testName=imaging-darkroom) 16:16:37 INFO - 2015-11-13 16:16:37,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 283688960 16:16:37 INFO - 2015-11-13 16:16:37,189 DEBUG : BROWSER_OUTPUT: 16:16:40 INFO - 2015-11-13 16:16:40,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50338/tests/kraken/driver.html?testName=imaging-desaturate) 16:16:41 INFO - 2015-11-13 16:16:41,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 282570752 16:16:41 INFO - 2015-11-13 16:16:41,371 DEBUG : BROWSER_OUTPUT: 16:16:44 INFO - 2015-11-13 16:16:44,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50338/tests/kraken/driver.html?testName=json-parse-financial) 16:16:45 INFO - 2015-11-13 16:16:45,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 284717056 16:16:45 INFO - 2015-11-13 16:16:45,192 DEBUG : BROWSER_OUTPUT: 16:16:46 INFO - 2015-11-13 16:16:46,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:16:47 INFO - 2015-11-13 16:16:47,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 320155648 16:16:47 INFO - 2015-11-13 16:16:47,466 DEBUG : BROWSER_OUTPUT: 16:16:49 INFO - 2015-11-13 16:16:49,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:16:50 INFO - 2015-11-13 16:16:50,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 320507904 16:16:50 INFO - 2015-11-13 16:16:50,118 DEBUG : BROWSER_OUTPUT: 16:16:52 INFO - 2015-11-13 16:16:52,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:16:53 INFO - 2015-11-13 16:16:53,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 328388608 16:16:53 INFO - 2015-11-13 16:16:53,058 DEBUG : BROWSER_OUTPUT: 16:16:56 INFO - 2015-11-13 16:16:56,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:16:56 INFO - 2015-11-13 16:16:56,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 331059200 16:16:56 INFO - 2015-11-13 16:16:56,604 DEBUG : BROWSER_OUTPUT: 16:16:59 INFO - 2015-11-13 16:16:59,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:17:00 INFO - 2015-11-13 16:17:00,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 328593408 16:17:00 INFO - 2015-11-13 16:17:00,116 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50338/tests/kraken/driver.html?testName=ai-astar) 16:17:02 INFO - 2015-11-13 16:17:02,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 388440064 16:17:02 INFO - 2015-11-13 16:17:02,306 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,306 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:17:02 INFO - 2015-11-13 16:17:02,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:17:02 INFO - 2015-11-13 16:17:02,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:17:02 INFO - 2015-11-13 16:17:02,307 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:17:02 INFO - 2015-11-13 16:17:02,307 DEBUG : BROWSER_OUTPUT: |0;ai-astar;121;125;122;132;131;126;113;125;125;111 16:17:02 INFO - 2015-11-13 16:17:02,307 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;186;159;186;200;151;175;180;155;199;150 16:17:02 INFO - 2015-11-13 16:17:02,307 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;187;187;198;190;187;189;191;191;190 16:17:02 INFO - 2015-11-13 16:17:02,308 DEBUG : BROWSER_OUTPUT: |3;audio-fft;83;96;143;101;84;85;86;93;99;80 16:17:02 INFO - 2015-11-13 16:17:02,309 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;113;117;157;110;110;104;145;103;104;144 16:17:02 INFO - 2015-11-13 16:17:02,309 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;141;135;148;144;141;141;141;141;141 16:17:02 INFO - 2015-11-13 16:17:02,309 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;155;149;148;147;147;148;155 16:17:02 INFO - 2015-11-13 16:17:02,309 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;126;114;121;109;110;114;115;122;118 16:17:02 INFO - 2015-11-13 16:17:02,309 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;67;67;69;69;69;71;78;67;68 16:17:02 INFO - 2015-11-13 16:17:02,309 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;75;79;81;81;90;83;82;82;82;83 16:17:02 INFO - 2015-11-13 16:17:02,309 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;104;102;102;102;108;109;103;104;103 16:17:02 INFO - 2015-11-13 16:17:02,309 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;151;164;161;158;151;143;151;160;152;149 16:17:02 INFO - 2015-11-13 16:17:02,310 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;175;164;177;175;176;167;176;177;176;177 16:17:02 INFO - 2015-11-13 16:17:02,310 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;81;82;83;83;84;83;86;88;87 16:17:02 INFO - 2015-11-13 16:17:02,310 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:17:02 INFO - 2015-11-13 16:17:02,310 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:17:02 INFO - 2015-11-13 16:17:02,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 16:17:02 INFO - 2015-11-13 16:17:02,310 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:17:02 INFO - 2015-11-13 16:17:02,310 DEBUG : BROWSER_OUTPUT: __startTimestamp1447460222306__endTimestamp 16:17:02 INFO - 2015-11-13 16:17:02,310 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,312 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:17:02 INFO - 2015-11-13 16:17:02,312 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:17:02 INFO - 2015-11-13 16:17:02,312 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,312 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:123.10 Median:125.00 stddev:6.79 (5.4%) stddev-sans-first:7.16 16:17:02 INFO - 2015-11-13 16:17:02,312 DEBUG : BROWSER_OUTPUT: Values: 121.0 125.0 122.0 132.0 131.0 126.0 113.0 125.0 125.0 111.0 16:17:02 INFO - 2015-11-13 16:17:02,313 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,313 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:174.10 Median:183.00 stddev:19.20 (10.5%) stddev-sans-first:19.87 16:17:02 INFO - 2015-11-13 16:17:02,313 DEBUG : BROWSER_OUTPUT: Values: 186.0 159.0 186.0 200.0 151.0 175.0 180.0 155.0 199.0 150.0 16:17:02 INFO - 2015-11-13 16:17:02,313 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,313 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:189.40 Median:190.00 stddev:3.75 (2.0%) stddev-sans-first:3.43 16:17:02 INFO - 2015-11-13 16:17:02,313 DEBUG : BROWSER_OUTPUT: Values: 184.0 187.0 187.0 198.0 190.0 187.0 189.0 191.0 191.0 190.0 16:17:02 INFO - 2015-11-13 16:17:02,314 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,314 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:95.00 Median:85.50 stddev:18.35 (21.5%) stddev-sans-first:18.95 16:17:02 INFO - 2015-11-13 16:17:02,314 DEBUG : BROWSER_OUTPUT: Values: 83.0 96.0 143.0 101.0 84.0 85.0 86.0 93.0 99.0 80.0 16:17:02 INFO - 2015-11-13 16:17:02,314 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,314 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:120.70 Median:115.00 stddev:20.07 (17.4%) stddev-sans-first:21.09 16:17:02 INFO - 2015-11-13 16:17:02,314 DEBUG : BROWSER_OUTPUT: Values: 113.0 117.0 157.0 110.0 110.0 104.0 145.0 103.0 104.0 144.0 16:17:02 INFO - 2015-11-13 16:17:02,315 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,315 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:141.50 Median:141.00 stddev:3.21 (2.3%) stddev-sans-first:3.40 16:17:02 INFO - 2015-11-13 16:17:02,315 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 135.0 148.0 144.0 141.0 141.0 141.0 141.0 141.0 16:17:02 INFO - 2015-11-13 16:17:02,315 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,315 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.30 Median:148.00 stddev:3.06 (2.1%) stddev-sans-first:3.21 16:17:02 INFO - 2015-11-13 16:17:02,317 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 155.0 149.0 148.0 147.0 147.0 148.0 155.0 16:17:02 INFO - 2015-11-13 16:17:02,317 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,317 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.80 Median:118.50 stddev:5.39 (4.5%) stddev-sans-first:5.66 16:17:02 INFO - 2015-11-13 16:17:02,317 DEBUG : BROWSER_OUTPUT: Values: 119.0 126.0 114.0 121.0 109.0 110.0 114.0 115.0 122.0 118.0 16:17:02 INFO - 2015-11-13 16:17:02,317 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,318 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.00 Median:69.00 stddev:3.56 (5.2%) stddev-sans-first:3.47 16:17:02 INFO - 2015-11-13 16:17:02,318 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 67.0 69.0 69.0 69.0 71.0 78.0 67.0 68.0 16:17:02 INFO - 2015-11-13 16:17:02,318 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,318 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:81.80 Median:82.00 stddev:3.74 (4.6%) stddev-sans-first:3.05 16:17:02 INFO - 2015-11-13 16:17:02,318 DEBUG : BROWSER_OUTPUT: Values: 75.0 79.0 81.0 81.0 90.0 83.0 82.0 82.0 82.0 83.0 16:17:02 INFO - 2015-11-13 16:17:02,319 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,319 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:103.40 Median:104.00 stddev:3.34 (3.2%) stddev-sans-first:2.62 16:17:02 INFO - 2015-11-13 16:17:02,319 DEBUG : BROWSER_OUTPUT: Values: 97.0 104.0 102.0 102.0 102.0 108.0 109.0 103.0 104.0 103.0 16:17:02 INFO - 2015-11-13 16:17:02,319 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,319 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:154.00 Median:155.00 stddev:6.48 (4.2%) stddev-sans-first:6.78 16:17:02 INFO - 2015-11-13 16:17:02,319 DEBUG : BROWSER_OUTPUT: Values: 151.0 164.0 161.0 158.0 151.0 143.0 151.0 160.0 152.0 149.0 16:17:02 INFO - 2015-11-13 16:17:02,320 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,320 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:176.00 stddev:4.59 (2.6%) stddev-sans-first:4.86 16:17:02 INFO - 2015-11-13 16:17:02,320 DEBUG : BROWSER_OUTPUT: Values: 175.0 164.0 177.0 175.0 176.0 167.0 176.0 177.0 176.0 177.0 16:17:02 INFO - 2015-11-13 16:17:02,320 DEBUG : BROWSER_OUTPUT: 16:17:02 INFO - 2015-11-13 16:17:02,320 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.40 Median:83.50 stddev:3.17 (3.8%) stddev-sans-first:2.37 16:17:02 INFO - 2015-11-13 16:17:02,320 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 82.0 83.0 83.0 84.0 83.0 86.0 88.0 87.0 16:17:02 INFO - 2015-11-13 16:17:02,320 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:17:02 INFO - 2015-11-13 16:17:02,320 DEBUG : BROWSER_OUTPUT: 16:17:03 INFO - 2015-11-13 16:17:03,060 INFO : Browser exited with error code: 0 16:17:03 INFO - 2015-11-13 16:17:03,115 INFO : Completed test kraken (00:01:02) 16:17:03 INFO - 2015-11-13 16:17:03,115 INFO : Starting test v8_7 16:17:03 INFO - 2015-11-13 16:17:03,115 DEBUG : operating with platform_type : mac_ 16:17:03 INFO - 2015-11-13 16:17:03,115 INFO : Initialising browser for v8_7 test... 16:17:03 INFO - 2015-11-13 16:17:03,130 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpbyh5ov/profile http://localhost:50338/getInfo.html 16:17:05 INFO - 2015-11-13 16:17:05,603 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:17:05 INFO - 2015-11-13 16:17:05,603 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:17:05 INFO - 2015-11-13 16:17:05,603 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:17:05 INFO - 2015-11-13 16:17:05,603 DEBUG : BROWSER_OUTPUT: __metrics 16:17:05 INFO - 2015-11-13 16:17:05,624 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:17:06 INFO - 2015-11-13 16:17:06,388 INFO : Browser initialized. 16:17:06 INFO - 2015-11-13 16:17:06,389 INFO : Running cycle 1/1 for v8_7 test... 16:17:06 INFO - 2015-11-13 16:17:06,389 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpbyh5ov/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:17:18 INFO - 2015-11-13 16:17:18,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 229265408 16:17:18 INFO - 2015-11-13 16:17:18,491 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50338/tests/v8_7/run.html (next: http://localhost:50338/tests/v8_7/run.html) 16:17:41 INFO - 2015-11-13 16:17:41,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 743350272 16:17:41 INFO - 2015-11-13 16:17:41,660 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,660 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:17:41 INFO - 2015-11-13 16:17:41,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |0;Richards;191.2411550965768 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;224.9718785151856 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |2;Encrypt;363.10820624546113 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6958.333333333333 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2214.6017699115046 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |5;Earley;1085.6832971800434 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |6;Boyer;14750 16:17:41 INFO - 2015-11-13 16:17:41,661 DEBUG : BROWSER_OUTPUT: |7;RegExp;34322.03389830508 16:17:41 INFO - 2015-11-13 16:17:41,662 DEBUG : BROWSER_OUTPUT: |8;Splay;796.8127490039841 16:17:41 INFO - 2015-11-13 16:17:41,662 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6680 16:17:41 INFO - 2015-11-13 16:17:41,662 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:17:41 INFO - 2015-11-13 16:17:41,662 DEBUG : BROWSER_OUTPUT: __startTimestamp1447460261655__endTimestamp 16:17:41 INFO - 2015-11-13 16:17:41,662 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,662 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:17:41 INFO - 2015-11-13 16:17:41,662 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:17:41 INFO - 2015-11-13 16:17:41,662 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:191.24 Median:191.24 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: Values: 191.2 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:224.97 Median:224.97 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: Values: 225.0 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:363.11 Median:363.11 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: Values: 363.1 16:17:41 INFO - 2015-11-13 16:17:41,663 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6958.33 Median:6958.33 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: Values: 6958.3 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2214.60 Median:2214.60 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: Values: 2214.6 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1085.68 Median:1085.68 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: Values: 1085.7 16:17:41 INFO - 2015-11-13 16:17:41,664 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14750.00 Median:14750.00 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: Values: 14750.0 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34322.03 Median:34322.03 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: Values: 34322.0 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: Values: 796.8 16:17:41 INFO - 2015-11-13 16:17:41,665 DEBUG : BROWSER_OUTPUT: 16:17:41 INFO - 2015-11-13 16:17:41,666 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6680.00 Median:6680.00 stddev:0.00 (0.0%) 16:17:41 INFO - 2015-11-13 16:17:41,666 DEBUG : BROWSER_OUTPUT: Values: 6680.0 16:17:41 INFO - 2015-11-13 16:17:41,666 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:17:41 INFO - 2015-11-13 16:17:41,666 DEBUG : BROWSER_OUTPUT: 16:17:42 INFO - 2015-11-13 16:17:42,436 INFO : Browser exited with error code: 0 16:17:42 INFO - 2015-11-13 16:17:42,459 INFO : Completed test v8_7 (00:00:39) 16:17:42 INFO - 2015-11-13 16:17:42,847 INFO : Completed test suite (00:20:18) 16:17:42 INFO - 2015-11-13 16:17:42,847 DEBUG : Working with test: dromaeo_css 16:17:42 INFO - 2015-11-13 16:17:42,847 DEBUG : Generating results file: dromaeo_css 16:17:42 INFO - 2015-11-13 16:17:42,848 DEBUG : Working with test: kraken 16:17:42 INFO - 2015-11-13 16:17:42,848 DEBUG : Generating results file: kraken 16:17:42 INFO - 2015-11-13 16:17:42,848 INFO : javascript benchmark 16:17:42 INFO - 2015-11-13 16:17:42,848 DEBUG : Working with test: v8_7 16:17:42 INFO - 2015-11-13 16:17:42,848 DEBUG : Generating results file: v8_7 16:17:42 INFO - 2015-11-13 16:17:42,849 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:17:42 INFO - 2015-11-13 16:17:42,889 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 16:17:42 INFO - 2015-11-13 16:17:42,889 DEBUG : process_Request line: dromaeo_css 5705.35 graph.html#tests=[[72,63,55]] 16:17:42 INFO - 2015-11-13 16:17:42,889 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:17:42 INFO - 2015-11-13 16:17:42,911 DEBUG : process_Request line: kraken 1775.50 graph.html#tests=[[232,63,55]] 16:17:42 INFO - 2015-11-13 16:17:42,911 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:17:42 INFO - 2015-11-13 16:17:42,931 DEBUG : process_Request line: v8_7 15672.22 graph.html#tests=[[230,63,55]] 16:17:42 INFO - 2015-11-13 16:17:42,932 INFO : javascript benchmark 16:17:42 INFO - 2015-11-13 16:17:42,934 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [283.05882939227075, 289.3085525593831, 291.66895573524044, 292.9033418971739, 296.0172228202369, 12551.184173028747, 12957.611271661865, 14925.029873058244, 15209.163496007715, 15447.073175609472, 9964.950175249132, 10470.057694807465, 10473.633422830202, 13404.262765547892, 15192.772108418383, 3746.925061498775, 3825.713071519633, 3854.036490877281, 3879.689624830021, 3881.5342158940966, 2915.4606397816365, 2962.866670999799, 2972.0637999030237, 3859.5561510426237, 3913.31516984528, 3909.1009067914397, 3965.722399432041, 3989.880303590897, 4117.773522456264, 4147.937780933288, 3982.1637456134245, 4058.736182148166, 4059.2287465381482, 4074.2666320062376, 4105.733127346728, 3486.773359731609, 3497.6502349765074, 3500.5799304083416, 3501.2822371414054, 3569.089882080079, 11261.943690281496, 11356.205065645408, 11527.654170374903, 11553.94223028888, 11566.595169169123, 1584.1841451652408, 1596.1939220693475, 1596.6726821001666, 1673.230314055536, 1738.8462814336606, 7933.286004259587, 8040.276375126266, 8216.014078310582, 8349.916500834976, 8371.414001019932, 1276.1768659214754, 1302.8631993640627, 1318.7692153873033, 1335.0, 1358.6060042587637, 44214.0, 46408.0, 46751.29873051907, 47584.286235706495, 49442.75278623584, 5648.491635752802, 5677.886442271214, 5729.0260655688635, 5731.054376027909, 5799.9130013049, 6494.123293355431, 6502.512311576651, 6534.313897040837, 6615.437687796495, 6625.635590042594, 4638.234691275901, 4653.464851542049, 4700.247960326331, 4702.764861756898, 4763.642726795504, 4840.782164802592, 4874.975625121851, 4970.950290497121, 4972.105021096165, 5008.198688209942, 2552.680914885639, 2557.1050132453493, 2569.755873192044, 2577.76800087993, 2589.3526618345413, 843.8565743417703, 885.154677283193, 889.2441424788877, 911.3301723233418, 938.863864739609, 328.93914625794304, 370.1209627135553, 391.72774921429334, 401.7689828348711, 405.72208037493823, 9544.475053871965, 9822.0, 9917.107460328605, 10337.534810933526, 10434.321769084985, 348.33989589727327, 389.5189441040313, 389.96100389961344, 403.75371023675535, 429.04323358909807, 5028.622853286018, 5320.627556071116, 5408.269883565747, 5417.810376636878, 5436.266104075899, 302372.0, 310887.0, 314028.0, 444314.0, 458262.0, 62234.688826555575, 62596.374036259964, 63870.0, 65235.69528609496, 65287.67356163189, 430.2921693813659, 431.0688911950173, 432.2629915993224, 432.4507874998734, 438.90563528841454, 9278.0, 9422.481763503074, 9559.713208603753, 9635.373700709431, 9715.514224288898, 28680.426391472472, 29267.70732292735, 29605.25986850346, 30088.699113008588, 30159.09522714322, 36246.0, 36841.44737828881, 37516.81241593775, 37659.62340376561, 38000.42999355067, 5273.683578985273, 5297.735113244399, 5357.8392648220615, 5364.249005139206, 5379.1393377059485, 9405.153536181777, 9994.0, 10150.441725705157, 10163.288569800043, 10265.794684106426, 8301.750947471586, 8543.871841922251, 8742.650293988423, 8794.252488538546, 8842.248408885316, 8548.914510854811, 8570.74287771368, 8748.212660860552, 8795.340349473943, 8828.558572071242, 7784.377249820114, 9116.088391161096, 9118.954405228196, 9167.12912273333, 9220.861687074834, 4933.260010998379, 5065.468125846733, 5101.234814777813, 5316.627836051594, 5370.167624018283, 8504.659813607386, 8582.356323275904, 8679.435836670596, 8753.299736020976, 8769.517676527852], "dojo.html": [2722.618833363329, 2771.9168424947256, 2774.3757654527726, 2790.9162725118254, 2833.6741274753394, 4554.658400619958, 4589.541045895408, 4672.205725026745, 4701.6003639690625, 4776.880577985552, 4619.353290539327, 4666.206744853366, 4716.080364328957, 4723.834665786698, 4833.033393321332, 4389.122175564884, 4417.028253784162, 4424.137293227822, 4456.754878481682, 4486.080353527519, 4409.625181859546, 4460.732356058631, 4469.597736203741, 4495.483019452756, 4534.38785763921, 4212.115455754295, 4311.6335111515555, 4317.352397140423, 4396.824127034914, 4462.642988560923, 4307.181635489247, 4321.58944900234, 4403.471583409979, 4425.579569940851, 4431.8448854289945, 4337.522872484024, 4348.301864268513, 4421.358902959053, 4436.64506839452, 4517.051419201939, 4477.597016268552, 4620.930686039712, 4623.676342656016, 4643.303504474322, 4716.292556116576, 4935.7532123393685, 5020.146575082244, 5037.5214354636255, 5040.697558146487, 5053.545180933734, 5088.898222035576, 5130.846074617767, 5194.11700010999, 5226.268322434862, 5259.631825772198, 4555.316702494586, 4695.178343789891, 4696.412948381452, 4776.665633405663, 4785.521447855222, 5117.539421452013, 5157.355330583677, 5171.50870667286, 5221.55616772571, 5240.68555886648, 4939.333190019302, 5040.79836806531, 5043.193089105725, 5045.369328833895, 5085.160948443539, 5049.873753156127, 5120.8719782005, 5139.408967968731, 5179.326687530673, 5186.507281808223, 4869.9269510957365, 4901.3383193269165, 4914.70511769295, 4937.1606826839525, 4940.7035577865445, 5015.84952451427, 5056.721880296545, 5087.135187018216, 5112.897742045213, 5116.539511443988, 3849.8845034649007, 3851.268259030775, 3920.8235629396745, 3941.4876066111797, 4018.517777866616, 3475.0, 3480.9477857832153, 3512.701420379245, 3519.788812671248, 3531.6291789362263, 4688.2733176357715, 4701.95298047022, 4705.082508910798, 4721.858344249678, 4739.691920025256, 4893.168161412568, 5083.262926875583, 5108.029474399852, 5154.407243167084, 5201.843944681666, 4701.0, 4702.976485117552, 4755.833545825949, 4775.092732380836, 4814.9518504815205, 4474.977625111918, 4491.775411229425, 4510.391097201901, 4528.366028755977, 4542.205114105019, 4864.051509955666, 5018.172001619692, 5046.520580544842, 5195.064888320063, 5267.499587539101, 4991.975040124777, 5007.5993920487, 5019.447860735243, 5046.066477701637, 5110.029094472038, 5063.316452278895, 5095.414027386898, 5141.151709967813, 5146.6911985281, 5148.30497882781, 4752.857414277577, 4789.95210047909, 4849.151398505318, 4906.852794416173, 4914.926276105933, 4905.950940490549, 4977.129002424489, 4981.551660350586, 5013.39839219296, 5059.898802024012, 4845.5881250092725, 4920.532549407801, 4951.554360107608, 4980.925286120639, 5033.219850923113, 4660.067986402801, 4784.880377990578, 4815.181419158822, 4914.311996320589, 4980.701157930535, 4597.586217240464, 4704.788284527136, 4763.7141771493825, 4785.712857228577, 4835.419749629927, 4925.901481970269, 4962.181240095344, 4963.70217786934, 4964.453910069961, 5008.799648014185, 4712.882177945578, 4839.491853355347, 4883.536064073907, 4888.560029597354, 4890.413150421972], "mootools.html": [1046.9424181670006, 1401.747685416625, 1483.1990725008495, 1485.5766106659598, 1540.4223416218915, 5534.667919924807, 6047.516198704104, 6057.909131363028, 6343.238811342645, 6361.5864968777, 6143.35494773048, 6229.781957631484, 6244.281907580629, 6249.343818899007, 6260.123582698426, 1640.3356640560592, 1724.284421964883, 1873.925042998282, 1874.297138573035, 1901.8003109673493, 1609.9678006439865, 1856.8236017578377, 1884.896330701811, 1912.5027492851889, 1913.6172765446897, 1836.5316844204708, 1840.0523730278917, 1859.7861245956685, 1865.0, 1866.038989920192, 1856.053412759489, 1883.7645294338208, 1887.6696578098847, 1891.1111777464569, 1895.0998275818877, 1869.4204796512988, 1881.3791448821855, 1907.1989764299028, 1921.5484361175113, 1932.8357089647398, 6069.15031895535, 6069.878602427927, 6147.385261473862, 6149.29283132441, 6150.7232174552255, 3941.4679018332445, 3996.800159991989, 4027.6375126238486, 4034.435179074932, 4045.0494133878515, 2414.1791790791217, 2437.9024839006597, 2450.3016640257442, 2461.9876900615563, 2487.7885379742743, 745.2621904314743, 748.1321666866409, 749.2657195947947, 773.3542492019171, 784.9764507064797, 8269.173082691743, 8307.626156822958, 8377.41358104933, 8394.622241999125, 8609.655613775441, 3556.964430355715, 3574.660407261306, 3636.381815091441, 3726.1802403471193, 3731.8320675569666, 7006.404455621329, 7123.0, 7219.711211551584, 7220.097487814023, 7233.819154521074, 4000.0399904022825, 4064.1871625674394, 4074.75551466907, 4076.5311989121633, 4077.7145599807727, 3659.835307411173, 3690.501782259414, 3707.073231692077, 3718.4980027696456, 3768.4158955361963, 2863.141057682687, 3130.5304204369527, 3171.3657268546385, 3185.665505121975, 3227.177069847174, 897.537768049455, 1005.6228914157191, 1064.723171975292, 1065.1744897704186, 1076.6016573867719, 916.2303664921498, 919.4896832258028, 926.6478738079487, 958.8993155718549, 1134.2003887259461, 6039.78860739872, 6094.939050609526, 6125.908111378333, 6144.354842741448, 6191.226096737908, 985.0248254228405, 986.1962500562018, 987.2891518106951, 993.6770549571273, 1019.8215312320463, 4761.190597598416, 4826.58973987215, 4861.465238823726, 4907.9263811042865, 4911.852644420673, 7262.346388825031, 7592.278733520307, 7623.923760762322, 7636.274553917369, 7657.0, 7558.395328373717, 7588.203238659861, 7588.317051465395, 7591.544507329468, 7617.314441700273, 5918.940810591839, 6031.909521357183, 6121.357257487989, 6134.601250918676, 6147.047207682816, 5876.471117599265, 5894.410558944071, 5899.144624029577, 5908.261467316585, 5918.141869428822, 6676.465882729467, 6755.864882702417, 6771.950347696115, 6820.283870193558, 6824.317568243136, 6817.0, 6863.0, 6923.9653801730665, 6949.617771022642, 7052.717891284291, 5661.122526008476, 5701.344345400166, 5730.942690573041, 5750.166225897305, 5765.221695071112, 5571.303587051619, 5935.258092738408, 5957.046872500379, 6004.87990240184, 6026.698665066641, 4952.678075925053, 5493.7802487900035, 5629.831105066854, 5654.547636189177, 5791.7683292667825, 5591.440855914376, 5723.42765723441, 5730.885382292247, 5734.856628584319, 5826.446487583673, 5680.943190568041, 5705.144228365778, 5720.74256658443, 5721.856953576027, 5808.94191058084, 5134.666246693953, 5197.558207552249, 5207.895842083213, 5218.347706536683, 5229.0, 5293.417724050274, 5346.064438723286, 5380.408155102858, 5383.7308134593895, 5384.946150538602], "ext.html": [475.95002524734895, 486.25845585482136, 497.21191910821346, 500.64204094072755, 504.28139900641577, 26393.604095938554, 27239.727602723968, 34494.31011379771, 34819.0, 35228.647713522856, 36608.0, 37133.628663713425, 37203.25593488129, 37836.43245351315, 37839.0, 7032.296770322978, 7874.212578742137, 8102.18978102191, 8176.0, 8188.877166842472, 7277.89083163753, 9447.81104377912, 9691.079347462015, 9705.61177552897, 9840.655577054804, 9520.42877427353, 9537.618495260182, 9555.904440955606, 9561.521923903778, 9619.374740641872, 7140.535865168799, 7382.040334756447, 7478.887816682754, 9522.476263805487, 9613.61545538181, 9436.339456238065, 9638.75903102421, 9657.517124143766, 9789.265805064577, 9839.950800245953, 33747.49378759296, 34173.48739768905, 34369.48445773315, 34718.65281347205, 34773.82613086919, 2508.097085049381, 2636.525425423423, 2638.670166229221, 2757.200411880552, 2890.59531665567, 23017.0, 23437.648435273484, 23476.178333758235, 24093.0, 24320.63519047198, 2004.1983206717284, 2063.793620637939, 2067.2557879163487, 2078.95842083159, 2191.1783081344497, 236875.0, 238092.0, 243526.0, 245608.0, 245658.0, 48188.27717584239, 49025.264621030714, 52952.47047529552, 53226.73386633042, 53290.73354633202, 46328.0, 55520.72239638776, 56825.0, 56831.885130338465, 57581.42418575844, 13736.175829450265, 13930.721385572231, 13941.093828901088, 13944.651383715489, 14128.293585320693, 10357.533910974023, 10488.475576221159, 10538.57845686164, 10632.362058276529, 10646.733831654115, 17178.742318864977, 17290.91354543219, 17411.129443527774, 17568.824311756973, 17578.296868125388, 7678.57767822764, 7915.564643944524, 7929.0, 7947.602619869099, 8068.3948703847445, 801.6993627389729, 867.3624885708999, 979.4906648542718, 996.3722854601555, 1005.8239808033564, 24224.87887560551, 24261.878690606434, 24379.39051523726, 24410.38974025628, 24424.87787561051, 899.3030401438806, 921.6774129054911, 925.3291363761354, 949.3734135470556, 990.5790039233297, 12740.490380384867, 13798.0, 14501.854981450051, 14508.854911450962, 14522.0, 328178.0, 330313.0, 331735.0, 332345.0, 333375.0, 48946.51053489491, 49748.50251497439, 49998.250026248905, 50528.49471505238, 50629.49370506248, 1206.390772659801, 1210.7094297368744, 1226.2090951336515, 1231.6920769807548, 1234.3026190202506, 22775.544489110456, 25216.74783252144, 25361.619575706747, 25620.743792561836, 25735.356616084748, 42490.150196995266, 42997.0, 43469.565304347816, 43501.782491088605, 43674.34488482739, 235921.0, 237859.0, 238356.0, 240330.0, 242442.0, 22822.0, 23277.883610581837, 26330.73669263283, 27006.0, 27336.0, 31513.527297090102, 31940.32686241112, 32182.67817321797, 32578.83710581432, 32917.17707057247, 27169.353113010275, 28574.0, 29009.12972610825, 29342.0, 29386.706132939253, 28930.27674308159, 28974.565381519715, 28989.420211596072, 29191.270218244714, 29343.413131737674, 29467.11598652044, 33806.49290260599, 35181.472277916364, 35496.0, 35513.28973420569, 25616.487670246865, 27695.0, 27760.86119569389, 27772.722272777013, 27803.0, 20951.58096838085, 21078.262260820797, 21102.155913763276, 21328.14687412486, 21413.357599272047], "prototype.html": [263.5427533229846, 263.69543177629845, 265.58170880862644, 268.60515042886954, 271.50043919188715, 5318.707471089088, 5376.838694839156, 5379.81170659027, 5457.2359869618285, 5473.233747275384, 4822.0, 5256.684598924067, 5285.814996475124, 5340.572754179666, 5348.438413966536, 3838.2131663009154, 3954.6638535724496, 3997.780122093284, 4072.1041370898356, 4155.937660935088, 4123.567025462328, 4154.6676265898805, 4164.146349998258, 4164.916701665965, 4224.112936283369, 4043.716939814214, 4106.938395924063, 4133.21468920904, 4138.6482149017365, 4140.254754144253, 3901.9804900975455, 3968.1270120573427, 3998.980005099985, 4041.1513582147786, 4160.126373461577, 3524.101354154674, 3538.2039041215776, 3572.3212589607892, 3573.928521429557, 3580.7672501287593, 5210.713410762407, 5216.58267338612, 5225.268462415265, 5227.843164705065, 5299.364076310867, 4600.332951721982, 4606.401167848192, 4618.145643056012, 4620.537946205386, 4686.109639168581, 5467.699276539789, 5610.635308704921, 5625.38120806711, 5626.887462250732, 5697.9430205698245, 3823.3691440912216, 3828.7511311764647, 3829.5787463379006, 3846.9807650961566, 3871.032241939515, 5886.2642169729215, 5896.557758168155, 5931.762729490815, 5933.16935629008, 6010.398960103955, 3877.592852750477, 3909.5504017038406, 3933.095388060762, 3941.4876066111797, 3954.2486927483687, 3709.3879509880567, 3860.864869729546, 3860.9806950965067, 3951.8616848410165, 3969.702272329529, 4502.909941801146, 4504.977475112603, 4510.548945105529, 4568.931466028012, 4573.5426457354, 5616.634918730351, 5617.831465055973, 5696.629719068247, 5714.371419143974, 5727.398623144593, 1348.373006551958, 1359.463012110211, 1359.632899117233, 1374.752544541992, 1378.0491460891953, 863.5336918064176, 875.9605817738217, 879.3536750488386, 888.9733308000771, 892.433304851424, 5316.973415132899, 5342.412334643186, 5399.784008639689, 5403.810866619728, 5436.836894893159, 5863.179154918314, 5885.0, 5890.558208134321, 5929.762809487572, 5942.108683697394, 5317.946820531823, 5375.408705042442, 5384.5692344612335, 5404.675719456845, 5415.0, 3026.772992025607, 3042.34589563245, 3065.785395022327, 3163.7152656260587, 3185.522171674221, 5987.012142996444, 6095.969520152459, 6118.388161183846, 6119.449249567471, 6147.72335244915, 6129.693515324216, 6153.046277826944, 6159.599626024294, 6163.722632481549, 6177.598456100339, 5921.822345329647, 6011.579189456696, 6026.186464827192, 6141.84645383869, 6202.681565362509, 5873.2658417697785, 5976.760929562769, 6018.067199584071, 6026.578139530191, 6035.758569657164, 5827.067669172912, 5827.912581311369, 5845.3570107289015, 5881.617694849821, 5883.852903677443, 5993.891130140763, 5996.910046349221, 6060.090986352083, 6108.75564977396, 6120.204373431426, 3668.559772827278, 3766.8493260269283, 3797.411401232813, 3804.2201348723997, 3819.4079917612817, 5850.707464626837, 5871.6770577618645, 5960.940390596212, 5962.344142144274, 5976.521878249642, 5719.199312096393, 5757.5393968481585, 5771.59598828078, 5809.8547536311935, 5872.0898260769645, 5556.833295001156, 5703.914441283467, 5706.28671416073, 5771.769129234952, 5772.595918285848, 5552.7223638818705, 5569.832905012856, 5580.274564306615, 5607.523360514402, 5657.858553536194, 5412.377576578587, 5689.914651280152, 5705.144228365612, 5735.971320143372, 5748.137779333133, 5410.918836217381, 5449.509544141047, 5514.255575497256, 5527.281453411191, 5587.189857470726], "yui.html": [653.9542232043759, 665.6838001949075, 666.1040899989515, 666.782773119697, 667.6027763480729, 11830.881691183085, 12087.0, 12111.21277116989, 12133.0, 12265.325407102617, 11201.439928003609, 11253.774924501506, 11269.09847212223, 11333.546658133686, 11381.544738210461, 603.3001718007113, 611.3305930006636, 611.523012050599, 760.3840888880011, 782.1201148707704, 750.3696894608528, 760.4106817216674, 761.9466637335361, 771.6334740998009, 772.1737740617541, 788.5426452657445, 804.6137853830165, 804.6178065418937, 807.1928071928072, 811.3549727966281, 616.5129547657345, 633.9270983836872, 638.04612104903, 780.0911937592698, 816.94281400302, 587.3773799772255, 593.970301484924, 594.2749845188863, 597.7011494252873, 599.2479438304899, 11694.239874408137, 11885.049196064294, 11897.524099036029, 11904.345261010641, 12257.0, 9752.171065459444, 10210.387376757344, 10339.0, 10465.529051192714, 10694.358338499715, 7970.721024764105, 8061.435699501038, 8199.95900020502, 8204.343652507785, 8283.792905177419, 2810.241234866595, 2894.2619631993707, 2910.7089291070934, 2940.588317635533, 3022.1084779989956, 41534.0, 41830.0, 42647.78676106631, 42848.57151428477, 43098.92252693677, 7813.960930195426, 7838.764837054898, 7933.484323519068, 7947.920520794718, 7951.284384405431, 16673.33226683725, 16867.493975180765, 16979.405720799714, 16980.150992450574, 16996.745048824032, 5879.176915231871, 5891.7054147292465, 6131.724072416752, 6284.937150628527, 6318.210223722035, 3228.1445416964525, 3280.114369120324, 3498.772579782306, 3501.4047611906035, 3531.6644918732677, 2459.8032157427365, 2498.2255500794813, 2498.487809998946, 2544.75824796644, 2552.183301343552, 361.89324149375994, 363.3659264583319, 377.9338615742234, 378.4947095627313, 379.85755341746847, 468.0802223630514, 482.27899290560134, 506.6731957887142, 513.1411783388894, 524.0122369333833, 6550.508711846535, 6733.158355205599, 6792.150981127359, 6941.479389045841, 7079.469039822034, 355.3816359534392, 395.4601968313289, 447.74702293204234, 457.2615226409325, 472.85341544121434, 3286.556314897506, 3298.703116719507, 3369.376665316924, 3413.5391722117197, 3418.709409700203, 49850.0, 49939.0, 50567.24149137766, 50905.23642145371, 51039.489605104216, 43028.354574681405, 43816.561834381886, 43878.34182487265, 43931.34102988458, 44223.77888110603, 40210.19579608391, 40519.79740101281, 41295.0, 41346.586534134876, 41499.792501037904, 6615.338466153346, 6621.966890165711, 6706.698198580978, 6788.355106264897, 6822.0, 28845.423091538472, 29132.708672913, 29260.122196334145, 29500.262493437836, 30184.698153018187, 36676.0, 36678.63321366859, 37895.43156852594, 40066.599334006285, 40471.19057618772, 6453.645049522322, 6535.117759102651, 6610.206775186816, 6782.457403407617, 6941.501059618634, 9704.2721795867, 9706.563204655666, 9732.314239374453, 9777.657781977596, 10273.9486302568, 9230.584623691815, 9344.813103738023, 9377.296702747184, 9384.81230375375, 9416.10546998034, 9147.313951453534, 9265.53672316395, 9279.39683920543, 9281.582328795086, 9414.0, 9030.729078127404, 9079.68221112258, 9189.632414703605, 9331.626734930798, 9370.34407591462, 7717.305442510201, 7909.446338756462, 8003.439759216799, 8079.798005049921, 8192.221738934792, 7703.845923081619, 7772.145064043064, 7893.36853051743, 7971.880421793562, 8260.83478330418]}, "summary": {"lowerIsBetter": false, "suite": 5705.356039959864, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5610.331431843128, "unit": "ms", "value": 5610.331431843128}, "dojo.html": {"lowerIsBetter": false, "filtered": 4662.404169390918, "unit": "ms", "value": 4662.404169390918}, "mootools.html": {"lowerIsBetter": false, "filtered": 3690.453317350777, "unit": "ms", "value": 3690.453317350777}, "ext.html": {"lowerIsBetter": false, "filtered": 16279.471443513246, "unit": "ms", "value": 16279.471443513246}, "prototype.html": {"lowerIsBetter": false, "filtered": 4228.9610344539915, "unit": "ms", "value": 4228.9610344539915}, "yui.html": {"lowerIsBetter": false, "filtered": 5189.192792326509, "unit": "ms", "value": 5189.192792326509}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0034"}, "testrun": {"date": 1447459044, "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": "20151113141429", "branch": "Mozilla-Inbound", "revision": "9132d08e6d81983cf8f5f702eb6cbac3469ae921"}}, {"talos_counters": {}, "results": {"audio-dft": [184.0, 187.0, 187.0, 198.0, 190.0, 187.0, 189.0, 191.0, 191.0, 190.0], "ai-astar": [121.0, 125.0, 122.0, 132.0, 131.0, 126.0, 113.0, 125.0, 125.0, 111.0], "imaging-gaussian-blur": [142.0, 141.0, 135.0, 148.0, 144.0, 141.0, 141.0, 141.0, 141.0, 141.0], "audio-beat-detection": [186.0, 159.0, 186.0, 200.0, 151.0, 175.0, 180.0, 155.0, 199.0, 150.0], "json-stringify-tinderbox": [75.0, 79.0, 81.0, 81.0, 90.0, 83.0, 82.0, 82.0, 82.0, 83.0], "stanford-crypto-pbkdf2": [175.0, 164.0, 177.0, 175.0, 176.0, 167.0, 176.0, 177.0, 176.0, 177.0], "json-parse-financial": [65.0, 67.0, 67.0, 69.0, 69.0, 69.0, 71.0, 78.0, 67.0, 68.0], "stanford-crypto-sha256-iterative": [77.0, 81.0, 82.0, 83.0, 83.0, 84.0, 83.0, 86.0, 88.0, 87.0], "audio-fft": [83.0, 96.0, 143.0, 101.0, 84.0, 85.0, 86.0, 93.0, 99.0, 80.0], "imaging-darkroom": [148.0, 148.0, 148.0, 155.0, 149.0, 148.0, 147.0, 147.0, 148.0, 155.0], "stanford-crypto-ccm": [151.0, 164.0, 161.0, 158.0, 151.0, 143.0, 151.0, 160.0, 152.0, 149.0], "audio-oscillator": [113.0, 117.0, 157.0, 110.0, 110.0, 104.0, 145.0, 103.0, 104.0, 144.0], "stanford-crypto-aes": [97.0, 104.0, 102.0, 102.0, 102.0, 108.0, 109.0, 103.0, 104.0, 103.0], "imaging-desaturate": [119.0, 126.0, 114.0, 121.0, 109.0, 110.0, 114.0, 115.0, 122.0, 118.0]}, "summary": {"lowerIsBetter": true, "suite": 1775.5000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 95.0, "unit": "ms", "value": 95.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 174.0, "unit": "ms", "value": 174.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 174.1, "unit": "ms", "value": 174.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 154.0, "unit": "ms", "value": 154.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 149.3, "unit": "ms", "value": 149.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 69.0, "unit": "ms", "value": 69.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 120.7, "unit": "ms", "value": 120.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 123.1, "unit": "ms", "value": 123.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 189.4, "unit": "ms", "value": 189.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 83.4, "unit": "ms", "value": 83.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 81.8, "unit": "ms", "value": 81.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 141.5, "unit": "ms", "value": 141.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 103.4, "unit": "ms", "value": 103.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 116.8, "unit": "ms", "value": 116.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0034"}, "testrun": {"date": 1447459044, "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": "20151113141429", "branch": "Mozilla-Inbound", "revision": "9132d08e6d81983cf8f5f702eb6cbac3469ae921"}}, {"talos_counters": {}, "results": {"DeltaBlue": [224.9718785151856], "Encrypt": [363.10820624546113], "NavierStokes": [6680.0], "Decrypt": [6958.333333333333], "Splay": [796.8127490039841], "Richards": [191.2411550965768], "RegExp": [34322.03389830508], "Earley": [1085.6832971800434], "Boyer": [14750.0], "RayTrace": [2214.6017699115046]}, "summary": {"lowerIsBetter": false, "suite": 15672.219836003924, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 293.89450999999985, "unit": "score", "value": 293.89450999999985}, "Encrypt": {"lowerIsBetter": false, "filtered": 733.0624740000002, "unit": "score", "value": 733.0624740000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 222.1556886227545, "unit": "score", "value": 222.1556886227545}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.253556886227535, "unit": "score", "value": 38.253556886227535}, "Splay": {"lowerIsBetter": false, "filtered": 102.27120499999998, "unit": "score", "value": 102.27120499999998}, "RegExp": {"lowerIsBetter": false, "filtered": 26.54227901234567, "unit": "score", "value": 26.54227901234567}, "Richards": {"lowerIsBetter": false, "filtered": 184.59415800000005, "unit": "score", "value": 184.59415800000005}, "Earley": {"lowerIsBetter": false, "filtered": 613.8650209790211, "unit": "score", "value": 613.8650209790211}, "Boyer": {"lowerIsBetter": false, "filtered": 45.18393220338984, "unit": "score", "value": 45.18393220338984}, "RayTrace": {"lowerIsBetter": false, "filtered": 334.14088711288707, "unit": "score", "value": 334.14088711288707}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0034"}, "testrun": {"date": 1447459044, "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": "20151113141429", "branch": "Mozilla-Inbound", "revision": "9132d08e6d81983cf8f5f702eb6cbac3469ae921"}}] 16:17:42 INFO - RETURN: dromaeo_css: 5705.35 16:17:42 INFO - RETURN: kraken: 1775.50 16:17:42 INFO - RETURN: v8_7: 15672.22 16:17:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15672.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1775.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5705.35"}}} 16:17:43 INFO - Return code: 0 16:17:43 INFO - # TBPL SUCCESS # 16:17:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:43 INFO - 2015-11-13 16:17:43.054 screenresolution[2242:19168] starting screenresolution argv=screenresolution get 16:17:43 INFO - 2015-11-13 16:17:43.057 screenresolution[2242:19168] Display 0: 1600x1200x32@60 16:17:43 INFO - 2015-11-13 16:17:43.064 screenresolution[2243:19171] starting screenresolution argv=screenresolution list 16:17:43 INFO - Available Modes on Display 0 16:17:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:43 INFO - Intel HD Graphics 3000: 16:17:43 INFO - Chipset Model: Intel HD Graphics 3000 16:17:43 INFO - Type: GPU 16:17:43 INFO - Bus: Built-In 16:17:43 INFO - VRAM (Total): 512 MB 16:17:43 INFO - VRAM (Dynamic, Max): 10 16:17:43 INFO - Vendor: Intel (0x8086) 16:17:43 INFO - Device ID: 0x0116 16:17:43 INFO - Revision ID: 0x0009 16:17:43 INFO - Displays: 16:17:43 INFO - Display: 16:17:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:43 INFO - Display Serial Number: 1600x1200 60 16:17:43 INFO - Main Display: Yes 16:17:43 INFO - Mirror: Off 16:17:43 INFO - Online: Yes 16:17:43 INFO - Rotation: Supported 16:17:43 INFO - Return code: 0 16:17:43 INFO - Running post-action listener: _resource_record_post_action 16:17:43 INFO - Running post-run listener: _resource_record_post_run 16:17:44 INFO - Total resource usage - Wall time: 1261s; CPU: 30.0%; Read bytes: 2519040; Write bytes: 686302208; Read time: 921; Write time: 59129 16:17:44 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 336515584; Write bytes: 334548992; Read time: 35618; Write time: 4510 16:17:44 INFO - run-tests - Wall time: 1220s; CPU: 30.0%; Read bytes: 2519040; Write bytes: 341394432; Read time: 921; Write time: 53247 16:17:44 INFO - Running post-run listener: _upload_blobber_files 16:17:44 INFO - Blob upload gear active. 16:17:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:17:44 INFO - Copying logs to upload dir... 16:17:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1337.442473 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2015-11-13 16:17:44.723879) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 16:17:44.728597) ========= 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.VK916FmoOl/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.URnNENKoAd/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010017 build_url: 'https://queue.taskcluster.net/v1/task/tjZl4_b_RgyXVkuqqtcfRQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.26 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 16:17:45.000942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2015-11-13 16:17:45.001392) ========= 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.VK916FmoOl/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.URnNENKoAd/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.005217 ========= master_lag: 5.50 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2015-11-13 16:17:50.502562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 16:17:50.503261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 16:17:50.509692) ========= ========= Total master_lag: 6.22 =========