builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0082 starttime: 1447374685.09 results: success (0) buildid: 20151112151340 builduid: 1be7cd81ed6541ca873eca115d0ef3cc revision: 285852de5cd54891d8f3b1ddbff179e4c9c7ca5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.091225) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.091665) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.091985) ========= 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.7UeluwetHM/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.R2LbzzgVTk/Listeners TMPDIR=/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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.006731 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.125999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.126376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.192306) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.192910) ========= 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.7UeluwetHM/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.R2LbzzgVTk/Listeners TMPDIR=/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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.006395 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.249467) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.249902) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.250353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.250664) ========= 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.7UeluwetHM/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.R2LbzzgVTk/Listeners TMPDIR=/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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-12 16:31: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% 7.31M=0.002s 2015-11-12 16:31:25 (7.31 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.410196 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.679241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.679590) ========= 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.7UeluwetHM/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.R2LbzzgVTk/Listeners TMPDIR=/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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.022965 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.730049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.732692) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 285852de5cd54891d8f3b1ddbff179e4c9c7ca5f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 285852de5cd54891d8f3b1ddbff179e4c9c7ca5f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7UeluwetHM/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.R2LbzzgVTk/Listeners TMPDIR=/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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-12 16:31:25,822 truncating revision to first 12 chars 2015-11-12 16:31:25,823 Setting DEBUG logging. 2015-11-12 16:31:25,823 attempt 1/10 2015-11-12 16:31:25,823 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/285852de5cd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 16:31:26,086 unpacking tar archive at: mozilla-central-285852de5cd5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554914 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:26.307638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:26.307996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:26.323466) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:26.323820) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:26.324309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-12 16:31:26.324640) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7UeluwetHM/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.R2LbzzgVTk/Listeners TMPDIR=/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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 16:31:26 INFO - MultiFileLogger online at 20151112 16:31:26 in /builds/slave/test 16:31:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:31:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:26 INFO - {'append_to_log': False, 16:31:26 INFO - 'base_work_dir': '/builds/slave/test', 16:31:26 INFO - 'blob_upload_branch': 'Firefox', 16:31:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:26 INFO - 'branch': 'Firefox', 16:31:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:26 INFO - 'config_files': ('talos/mac_config.py',), 16:31:26 INFO - 'default_actions': ('clobber', 16:31:26 INFO - 'read-buildbot-config', 16:31:26 INFO - 'download-and-extract', 16:31:26 INFO - 'populate-webroot', 16:31:26 INFO - 'create-virtualenv', 16:31:26 INFO - 'install', 16:31:26 INFO - 'run-tests'), 16:31:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:26 INFO - 'download_minidump_stackwalk': True, 16:31:26 INFO - 'download_symbols': 'ondemand', 16:31:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:26 INFO - 'installer_path': 'installer.exe', 16:31:26 INFO - 'log_level': 'info', 16:31:26 INFO - 'log_name': 'talos', 16:31:26 INFO - 'log_to_console': True, 16:31:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:31:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:31:26 INFO - 'opt_config_files': (), 16:31:26 INFO - 'pip_index': False, 16:31:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:31:26 INFO - 'cmd': ('bash', 16:31:26 INFO - '-c', 16:31:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:31:26 INFO - 'enabled': True, 16:31:26 INFO - 'halt_on_failure': False, 16:31:26 INFO - 'name': 'check_screen_resolution'},), 16:31:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:31:26 INFO - 'cmd': ('bash', 16:31:26 INFO - '-c', 16:31:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:31:26 INFO - 'enabled': True, 16:31:26 INFO - 'halt_on_failure': False, 16:31:26 INFO - 'name': 'check_screen_resolution'},), 16:31:26 INFO - 'run_cmd_checks_enabled': True, 16:31:26 INFO - 'sps_profile': False, 16:31:26 INFO - 'sps_profile_interval': 0, 16:31:26 INFO - 'suite': 'dromaeojs', 16:31:26 INFO - 'system_bits': '64', 16:31:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:26 INFO - 'title': 't-yosemite-r5-0082', 16:31:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:26 INFO - 'use_talos_json': True, 16:31:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:26 INFO - 'work_dir': 'build'} 16:31:26 INFO - ##### 16:31:26 INFO - ##### Running clobber step. 16:31:26 INFO - ##### 16:31:26 INFO - Running pre-action listener: _resource_record_pre_action 16:31:26 INFO - Running main action method: clobber 16:31:26 INFO - rmtree: /builds/slave/test/build 16:31:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:28 INFO - Running post-action listener: _resource_record_post_action 16:31:28 INFO - ##### 16:31:28 INFO - ##### Running read-buildbot-config step. 16:31:28 INFO - ##### 16:31:28 INFO - Running pre-action listener: _resource_record_pre_action 16:31:28 INFO - Running main action method: read_buildbot_config 16:31:28 INFO - Using buildbot properties: 16:31:28 INFO - { 16:31:28 INFO - "properties": { 16:31:28 INFO - "buildnumber": 480, 16:31:28 INFO - "product": "firefox", 16:31:28 INFO - "script_repo_revision": "production", 16:31:28 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 16:31:28 INFO - "repository": "", 16:31:28 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 16:31:28 INFO - "buildid": "20151112151340", 16:31:28 INFO - "slavename": "t-yosemite-r5-0082", 16:31:28 INFO - "pgo_build": "False", 16:31:28 INFO - "basedir": "/builds/slave/test", 16:31:28 INFO - "project": "", 16:31:28 INFO - "platform": "yosemite", 16:31:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:31:28 INFO - "slavebuilddir": "test", 16:31:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:31:28 INFO - "branch": "mozilla-central", 16:31:28 INFO - "repo_path": "mozilla-central", 16:31:28 INFO - "stage_platform": "macosx64", 16:31:28 INFO - "builduid": "1be7cd81ed6541ca873eca115d0ef3cc", 16:31:28 INFO - "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f" 16:31:28 INFO - }, 16:31:28 INFO - "sourcestamp": { 16:31:28 INFO - "repository": "", 16:31:28 INFO - "hasPatch": false, 16:31:28 INFO - "project": "", 16:31:28 INFO - "branch": "mozilla-central-macosx64-talos", 16:31:28 INFO - "changes": [ 16:31:28 INFO - { 16:31:28 INFO - "category": null, 16:31:28 INFO - "files": [ 16:31:28 INFO - { 16:31:28 INFO - "url": null, 16:31:28 INFO - "name": "https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:31:28 INFO - } 16:31:28 INFO - ], 16:31:28 INFO - "repository": "", 16:31:28 INFO - "rev": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f", 16:31:28 INFO - "who": "kwierso@gmail.com", 16:31:28 INFO - "when": 1447374680, 16:31:28 INFO - "number": 6655420, 16:31:28 INFO - "comments": "Backed out changesets 5a3092c456c0,8dcbfd14f1e5 (bug 1218433) for M3, W3 failures and M10 failure on Android. r=backout a=merge\n* * *\nBacked out changeset 8dcbfd14f1e5 (bug 1218433)\n\n\ndom/security/test/csp/test_child-src_worker-redirect.html | CSP child-src worker test other-src-worker_redir-same - got \"Error: Failed to load script (nsresult = 0x805e0006)\", expected \"blocked\"\ndom/security/test/csp/test_child-src_worker.html | Test timed out.\ndom/security/test/csp/test_child-src_worker_data.html | Test timed out.", 16:31:28 INFO - "project": "", 16:31:28 INFO - "at": "Thu 12 Nov 2015 16:31:20", 16:31:28 INFO - "branch": "mozilla-central-macosx64-talos", 16:31:28 INFO - "revlink": "", 16:31:28 INFO - "properties": [ 16:31:28 INFO - [ 16:31:28 INFO - "buildid", 16:31:28 INFO - "20151112151340", 16:31:28 INFO - "Change" 16:31:28 INFO - ], 16:31:28 INFO - [ 16:31:28 INFO - "builduid", 16:31:28 INFO - "1be7cd81ed6541ca873eca115d0ef3cc", 16:31:28 INFO - "Change" 16:31:28 INFO - ], 16:31:28 INFO - [ 16:31:28 INFO - "pgo_build", 16:31:28 INFO - "False", 16:31:28 INFO - "Change" 16:31:28 INFO - ] 16:31:28 INFO - ], 16:31:28 INFO - "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f" 16:31:28 INFO - } 16:31:28 INFO - ], 16:31:28 INFO - "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f" 16:31:28 INFO - } 16:31:28 INFO - } 16:31:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:31:28 INFO - Running post-action listener: _resource_record_post_action 16:31:28 INFO - ##### 16:31:28 INFO - ##### Running download-and-extract step. 16:31:28 INFO - ##### 16:31:28 INFO - Running pre-action listener: _resource_record_pre_action 16:31:28 INFO - Running main action method: download_and_extract 16:31:28 INFO - mkdir: /builds/slave/test/build/tests 16:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:28 INFO - https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:31:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/test_packages.json 16:31:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/test_packages.json 16:31:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:31:33 INFO - Downloaded 1149 bytes. 16:31:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:31:33 INFO - Using the following test package requirements: 16:31:33 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:33 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:31:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:33 INFO - u'jsshell-mac.zip'], 16:31:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:33 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:31:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:33 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:31:33 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:33 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:31:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:33 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:31:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:33 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:31:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:33 INFO - https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/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 16:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/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 16:31:34 INFO - Downloaded 17459743 bytes. 16:31:34 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 16:31:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:31:40 INFO - Return code: 0 16:31:40 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 16:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:40 INFO - https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/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 16:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/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 16:31:46 INFO - Downloaded 17459743 bytes. 16:31:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:31:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:31:53 INFO - Return code: 0 16:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:53 INFO - https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:31:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:31:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:31:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/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 16:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/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 16:31:55 INFO - Downloaded 11131693 bytes. 16:31:55 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 16:31:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:31:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:31:55 INFO - Return code: 0 16:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:55 INFO - https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:31:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/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 16:31:59 INFO - Downloaded 108714702 bytes. 16:31:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:59 INFO - mkdir: /builds/slave/test/properties 16:31:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:59 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:59 INFO - Contents: 16:31:59 INFO - build_url:https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:59 INFO - Running post-action listener: _resource_record_post_action 16:31:59 INFO - Running post-action listener: set_extra_try_arguments 16:31:59 INFO - ##### 16:31:59 INFO - ##### Running populate-webroot step. 16:31:59 INFO - ##### 16:31:59 INFO - Running pre-action listener: _resource_record_pre_action 16:31:59 INFO - Running main action method: populate_webroot 16:31:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:31:59 INFO - '../fennec_ids.txt'], 16:31:59 INFO - 'tests': ['tcheck2']}, 16:31:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:59 INFO - '--tppagecycles', 16:31:59 INFO - '7'], 16:31:59 INFO - 'tests': ['tsvgm']}}, 16:31:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:31:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:31:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:31:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:59 INFO - 'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:59 INFO - 'tests': ['damp', 'tps']}, 16:31:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:59 INFO - 'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['damp', 'tps']}, 16:31:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:31:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:59 INFO - 'other': {'tests': ['a11yr', 16:31:59 INFO - 'ts_paint', 16:31:59 INFO - 'tpaint', 16:31:59 INFO - 'sessionrestore', 16:31:59 INFO - 'sessionrestore_no_auto_restore']}, 16:31:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['a11yr', 16:31:59 INFO - 'ts_paint', 16:31:59 INFO - 'tpaint', 16:31:59 INFO - 'sessionrestore', 16:31:59 INFO - 'sessionrestore_no_auto_restore']}, 16:31:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['a11yr', 16:31:59 INFO - 'ts_paint', 16:31:59 INFO - 'tpaint', 16:31:59 INFO - 'sessionrestore', 16:31:59 INFO - 'sessionrestore_no_auto_restore']}, 16:31:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['a11yr', 16:31:59 INFO - 'ts_paint', 16:31:59 INFO - 'tpaint', 16:31:59 INFO - 'sessionrestore', 16:31:59 INFO - 'sessionrestore_no_auto_restore']}, 16:31:59 INFO - 'other_l64': {'tests': ['a11yr', 16:31:59 INFO - 'ts_paint', 16:31:59 INFO - 'tpaint', 16:31:59 INFO - 'sessionrestore', 16:31:59 INFO - 'sessionrestore_no_auto_restore']}, 16:31:59 INFO - 'other_nol64': {'tests': ['a11yr', 16:31:59 INFO - 'ts_paint', 16:31:59 INFO - 'tpaint', 16:31:59 INFO - 'sessionrestore', 16:31:59 INFO - 'sessionrestore_no_auto_restore']}, 16:31:59 INFO - 'svgr': {'tests': ['tsvgx', 16:31:59 INFO - 'tsvgr_opacity', 16:31:59 INFO - 'tart', 16:31:59 INFO - 'tscrollx', 16:31:59 INFO - 'cart']}, 16:31:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['tsvgx', 16:31:59 INFO - 'tsvgr_opacity', 16:31:59 INFO - 'tart', 16:31:59 INFO - 'tscrollx', 16:31:59 INFO - 'cart']}, 16:31:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:59 INFO - 'tests': ['tp5o']}, 16:31:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:59 INFO - 'talos_options': ['--e10s'], 16:31:59 INFO - 'tests': ['tp5o']}, 16:31:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:59 INFO - 'talos_options': ['--xperf_path', 16:31:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:59 INFO - 'tests': ['tp5n']}, 16:31:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:59 INFO - 'talos_options': ['--e10s', 16:31:59 INFO - '--xperf_path', 16:31:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:59 INFO - 'tests': ['tp5n']}}, 16:31:59 INFO - 'talos.zip': {'path': '', 16:31:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:59 INFO - Running post-action listener: _resource_record_post_action 16:31:59 INFO - ##### 16:31:59 INFO - ##### Running create-virtualenv step. 16:31:59 INFO - ##### 16:31:59 INFO - Running pre-action listener: _resource_record_pre_action 16:31:59 INFO - Running main action method: create_virtualenv 16:31:59 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:31:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:00 INFO - Using real prefix '/tools/python27' 16:32:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:01 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:04 INFO - Installing pip.................done. 16:32:04 INFO - Return code: 0 16:32:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c903490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8e0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc77155ec80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8269f0>, '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 0x10c586db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81a8c8>, '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.7UeluwetHM/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.R2LbzzgVTk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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 16:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:32:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7UeluwetHM/Render', 16:32:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:04 INFO - 'HOME': '/Users/cltbld', 16:32:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:04 INFO - 'LOGNAME': 'cltbld', 16:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:04 INFO - 'MOZ_NO_REMOTE': '1', 16:32:04 INFO - 'NO_EM_RESTART': '1', 16:32:04 INFO - 'PAGER': '/bin/cat', 16:32:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:04 INFO - 'PWD': '/builds/slave/test', 16:32:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:04 INFO - 'SHELL': '/bin/bash', 16:32:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R2LbzzgVTk/Listeners', 16:32:04 INFO - 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/', 16:32:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:04 INFO - 'USER': 'cltbld', 16:32:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:04 INFO - 'XPC_FLAGS': '0x0', 16:32:04 INFO - 'XPC_SERVICE_NAME': '0', 16:32:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:32:05 INFO - Cleaning up... 16:32:05 INFO - Return code: 0 16:32:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c903490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8e0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc77155ec80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8269f0>, '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 0x10c586db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81a8c8>, '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.7UeluwetHM/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.R2LbzzgVTk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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 16:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:32:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7UeluwetHM/Render', 16:32:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:05 INFO - 'HOME': '/Users/cltbld', 16:32:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:05 INFO - 'LOGNAME': 'cltbld', 16:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:05 INFO - 'MOZ_NO_REMOTE': '1', 16:32:05 INFO - 'NO_EM_RESTART': '1', 16:32:05 INFO - 'PAGER': '/bin/cat', 16:32:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:05 INFO - 'PWD': '/builds/slave/test', 16:32:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:05 INFO - 'SHELL': '/bin/bash', 16:32:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R2LbzzgVTk/Listeners', 16:32:05 INFO - 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/', 16:32:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:05 INFO - 'USER': 'cltbld', 16:32:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:05 INFO - 'XPC_FLAGS': '0x0', 16:32:05 INFO - 'XPC_SERVICE_NAME': '0', 16:32:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:05 INFO - Downloading/unpacking psutil>=0.7.1 16:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:32:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:08 INFO - Installing collected packages: psutil 16:32:08 INFO - Running setup.py install for psutil 16:32:08 INFO - building 'psutil._psutil_osx' extension 16:32:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:32:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:32:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:32:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:32:09 INFO - building 'psutil._psutil_posix' extension 16:32:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:32:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:32:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:32:09 INFO - ^ 16:32:09 INFO - 1 warning generated. 16:32:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:32:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:09 INFO - Successfully installed psutil 16:32:09 INFO - Cleaning up... 16:32:10 INFO - Return code: 0 16:32:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:32:10 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')]} 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:10 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')]} 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:10 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 0x10c903490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8e0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc77155ec80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8269f0>, '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 0x10c586db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81a8c8>, '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.7UeluwetHM/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.R2LbzzgVTk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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 16:32:10 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 16:32:10 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 16:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7UeluwetHM/Render', 16:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:10 INFO - 'HOME': '/Users/cltbld', 16:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:10 INFO - 'LOGNAME': 'cltbld', 16:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:10 INFO - 'MOZ_NO_REMOTE': '1', 16:32:10 INFO - 'NO_EM_RESTART': '1', 16:32:10 INFO - 'PAGER': '/bin/cat', 16:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:10 INFO - 'PWD': '/builds/slave/test', 16:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:10 INFO - 'SHELL': '/bin/bash', 16:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R2LbzzgVTk/Listeners', 16:32:10 INFO - 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/', 16:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:10 INFO - 'USER': 'cltbld', 16:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:10 INFO - 'XPC_FLAGS': '0x0', 16:32:10 INFO - 'XPC_SERVICE_NAME': '0', 16:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:32:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:32:13 INFO - Installing collected packages: mozsystemmonitor 16:32:13 INFO - Running setup.py install for mozsystemmonitor 16:32:13 INFO - Successfully installed mozsystemmonitor 16:32:13 INFO - Cleaning up... 16:32:13 INFO - Return code: 0 16:32:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c903490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8e0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc77155ec80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8269f0>, '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 0x10c586db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81a8c8>, '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.7UeluwetHM/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.R2LbzzgVTk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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 16:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:32:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7UeluwetHM/Render', 16:32:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:13 INFO - 'HOME': '/Users/cltbld', 16:32:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:13 INFO - 'LOGNAME': 'cltbld', 16:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:13 INFO - 'MOZ_NO_REMOTE': '1', 16:32:13 INFO - 'NO_EM_RESTART': '1', 16:32:13 INFO - 'PAGER': '/bin/cat', 16:32:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:13 INFO - 'PWD': '/builds/slave/test', 16:32:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:13 INFO - 'SHELL': '/bin/bash', 16:32:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R2LbzzgVTk/Listeners', 16:32:13 INFO - 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/', 16:32:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:13 INFO - 'USER': 'cltbld', 16:32:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:13 INFO - 'XPC_FLAGS': '0x0', 16:32:13 INFO - 'XPC_SERVICE_NAME': '0', 16:32:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:13 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:16 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:18 INFO - Downloading docopt-0.6.1.tar.gz 16:32:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:18 INFO - Running setup.py install for blobuploader 16:32:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:18 INFO - Running setup.py install for requests 16:32:19 INFO - Running setup.py install for docopt 16:32:19 INFO - Successfully installed blobuploader requests docopt 16:32:19 INFO - Cleaning up... 16:32:19 INFO - Return code: 0 16:32:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c903490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8e0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc77155ec80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8269f0>, '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 0x10c586db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81a8c8>, '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.7UeluwetHM/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.R2LbzzgVTk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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 16:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7UeluwetHM/Render', 16:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:19 INFO - 'HOME': '/Users/cltbld', 16:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:19 INFO - 'LOGNAME': 'cltbld', 16:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:19 INFO - 'MOZ_NO_REMOTE': '1', 16:32:19 INFO - 'NO_EM_RESTART': '1', 16:32:19 INFO - 'PAGER': '/bin/cat', 16:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:19 INFO - 'PWD': '/builds/slave/test', 16:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:19 INFO - 'SHELL': '/bin/bash', 16:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R2LbzzgVTk/Listeners', 16:32:19 INFO - 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/', 16:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:19 INFO - 'USER': 'cltbld', 16:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:19 INFO - 'XPC_FLAGS': '0x0', 16:32:19 INFO - 'XPC_SERVICE_NAME': '0', 16:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:20 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-i7RB8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:20 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-PBwC8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:20 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-y8U9ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:20 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-Q59_bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:20 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-AggzTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:20 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-vc4SQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:21 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-lazKqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:21 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-FDWFSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:21 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-tygYZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:21 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-PtuUdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:21 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-7OUo7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:21 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-GEW9sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:21 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-fyorwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:22 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-nx6MsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:22 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-AITjpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:22 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-pPCyw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:22 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-e4zmVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:22 INFO - Running setup.py install for manifestparser 16:32:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:22 INFO - Running setup.py install for mozcrash 16:32:23 INFO - Running setup.py install for mozdebug 16:32:23 INFO - Running setup.py install for mozdevice 16:32:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:32:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:23 INFO - Running setup.py install for mozfile 16:32:23 INFO - Running setup.py install for mozhttpd 16:32:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:23 INFO - Running setup.py install for mozinfo 16:32:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:24 INFO - Running setup.py install for mozInstall 16:32:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:24 INFO - Running setup.py install for mozleak 16:32:24 INFO - Running setup.py install for mozlog 16:32:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:24 INFO - Running setup.py install for moznetwork 16:32:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:24 INFO - Running setup.py install for mozprocess 16:32:25 INFO - Running setup.py install for mozprofile 16:32:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:25 INFO - Running setup.py install for mozrunner 16:32:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:25 INFO - Running setup.py install for mozscreenshot 16:32:25 INFO - Running setup.py install for moztest 16:32:26 INFO - Running setup.py install for mozversion 16:32:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:26 INFO - Cleaning up... 16:32:26 INFO - Return code: 0 16:32:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c903490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8e0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc77155ec80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8269f0>, '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 0x10c586db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81a8c8>, '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.7UeluwetHM/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.R2LbzzgVTk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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 16:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7UeluwetHM/Render', 16:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:26 INFO - 'HOME': '/Users/cltbld', 16:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:26 INFO - 'LOGNAME': 'cltbld', 16:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:26 INFO - 'MOZ_NO_REMOTE': '1', 16:32:26 INFO - 'NO_EM_RESTART': '1', 16:32:26 INFO - 'PAGER': '/bin/cat', 16:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:26 INFO - 'PWD': '/builds/slave/test', 16:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:26 INFO - 'SHELL': '/bin/bash', 16:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R2LbzzgVTk/Listeners', 16:32:26 INFO - 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/', 16:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:26 INFO - 'USER': 'cltbld', 16:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:26 INFO - 'XPC_FLAGS': '0x0', 16:32:26 INFO - 'XPC_SERVICE_NAME': '0', 16:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:26 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-sbboqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:26 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-9TDnQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:26 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)) 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:26 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-HtAE4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:27 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-pFEh0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:27 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-sD2skQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:27 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-A2Q3mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:27 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-rK316Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:27 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-ulKSeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:27 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)) 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:27 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-7KQOon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:27 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)) 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:27 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-PWR6Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:28 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-kRIF9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:28 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-hTy_aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:28 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-7vr6IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:28 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-93sfxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:28 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-KI61Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:28 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)) 16:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:28 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-vUyGtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:28 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)) 16:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:29 INFO - Running setup.py (path:/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/pip-7yOpYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:32:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:32 INFO - Downloading blessings-1.5.1.tar.gz 16:32:32 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:32 INFO - Installing collected packages: blessings 16:32:32 INFO - Running setup.py install for blessings 16:32:32 INFO - Successfully installed blessings 16:32:32 INFO - Cleaning up... 16:32:32 INFO - Return code: 0 16:32:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:32 INFO - Reading from file tmpfile_stdout 16:32:32 INFO - Current package versions: 16:32:32 INFO - blessings == 1.5.1 16:32:32 INFO - blobuploader == 1.2.4 16:32:32 INFO - docopt == 0.6.1 16:32:32 INFO - manifestparser == 1.1 16:32:32 INFO - mozInstall == 1.12 16:32:32 INFO - mozcrash == 0.16 16:32:32 INFO - mozdebug == 0.1 16:32:32 INFO - mozdevice == 0.47 16:32:32 INFO - mozfile == 1.2 16:32:32 INFO - mozhttpd == 0.7 16:32:32 INFO - mozinfo == 0.9 16:32:32 INFO - mozleak == 0.1 16:32:32 INFO - mozlog == 3.0 16:32:32 INFO - moznetwork == 0.27 16:32:32 INFO - mozprocess == 0.22 16:32:32 INFO - mozprofile == 0.27 16:32:32 INFO - mozrunner == 6.11 16:32:32 INFO - mozscreenshot == 0.1 16:32:32 INFO - mozsystemmonitor == 0.0 16:32:32 INFO - moztest == 0.7 16:32:32 INFO - mozversion == 1.4 16:32:32 INFO - psutil == 3.1.1 16:32:32 INFO - requests == 1.2.3 16:32:32 INFO - wsgiref == 0.1.2 16:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10c903490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8e0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc77155ec80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8269f0>, '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 0x10c586db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81a8c8>, '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.7UeluwetHM/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.R2LbzzgVTk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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 16:32:32 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 16:32:32 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 16:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7UeluwetHM/Render', 16:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:32 INFO - 'HOME': '/Users/cltbld', 16:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:32 INFO - 'LOGNAME': 'cltbld', 16:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:32 INFO - 'MOZ_NO_REMOTE': '1', 16:32:32 INFO - 'NO_EM_RESTART': '1', 16:32:32 INFO - 'PAGER': '/bin/cat', 16:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:32 INFO - 'PWD': '/builds/slave/test', 16:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:32 INFO - 'SHELL': '/bin/bash', 16:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R2LbzzgVTk/Listeners', 16:32:32 INFO - 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/', 16:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:32 INFO - 'USER': 'cltbld', 16:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:32 INFO - 'XPC_FLAGS': '0x0', 16:32:32 INFO - 'XPC_SERVICE_NAME': '0', 16:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:32:33 INFO - Cleaning up... 16:32:33 INFO - Return code: 0 16:32:33 INFO - Running post-action listener: _resource_record_post_action 16:32:33 INFO - Running post-action listener: _start_resource_monitoring 16:32:33 INFO - Starting resource monitoring. 16:32:33 INFO - ##### 16:32:33 INFO - ##### Running install step. 16:32:33 INFO - ##### 16:32:33 INFO - Running pre-action listener: _resource_record_pre_action 16:32:33 INFO - Running main action method: install 16:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:33 INFO - Reading from file tmpfile_stdout 16:32:33 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:33 INFO - Reading from file tmpfile_stdout 16:32:33 INFO - Output received: 16:32:33 INFO - Usage: mozinstall [options] installer 16:32:33 INFO - Options: 16:32:33 INFO - -h, --help show this help message and exit 16:32:33 INFO - -d DEST, --destination=DEST 16:32:33 INFO - Directory to install application into. [default: 16:32:33 INFO - "/builds/slave/test"] 16:32:33 INFO - --app=APP Application being installed. [default: firefox] 16:32:33 INFO - mkdir: /builds/slave/test/build/application 16:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:33:18 INFO - Reading from file tmpfile_stdout 16:33:18 INFO - Output received: 16:33:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:33:18 INFO - Running post-action listener: _resource_record_post_action 16:33:18 INFO - ##### 16:33:18 INFO - ##### Running run-tests step. 16:33:18 INFO - ##### 16:33:18 INFO - Running pre-action listener: _resource_record_pre_action 16:33:18 INFO - Running main action method: run_tests 16:33:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:33:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:33:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:33:18 INFO - 2015-11-12 16:33:18.179 screenresolution[2203:15463] starting screenresolution argv=screenresolution get 16:33:18 INFO - 2015-11-12 16:33:18.183 screenresolution[2203:15463] Display 0: 1600x1200x32@60 16:33:18 INFO - 2015-11-12 16:33:18.191 screenresolution[2204:15465] starting screenresolution argv=screenresolution list 16:33:18 INFO - Available Modes on Display 0 16:33:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:33:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:33:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:33:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:33:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:33:18 INFO - Intel HD Graphics 3000: 16:33:18 INFO - Chipset Model: Intel HD Graphics 3000 16:33:18 INFO - Type: GPU 16:33:18 INFO - Bus: Built-In 16:33:18 INFO - VRAM (Total): 512 MB 16:33:18 INFO - VRAM (Dynamic, Max): 10 16:33:18 INFO - Vendor: Intel (0x8086) 16:33:18 INFO - Device ID: 0x0116 16:33:18 INFO - Revision ID: 0x0009 16:33:18 INFO - Displays: 16:33:18 INFO - Display: 16:33:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:33:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:33:18 INFO - Display Serial Number: 1600x1200 60 16:33:18 INFO - Main Display: Yes 16:33:18 INFO - Mirror: Off 16:33:18 INFO - Online: Yes 16:33:18 INFO - Rotation: Supported 16:33:18 INFO - Return code: 0 16:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:33:18 INFO - Python 2.7.3 16:33:18 INFO - Return code: 0 16:33:18 INFO - grabbing minidump binary from tooltool 16:33:18 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')]} 16:33:18 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 0x10c8269f0>, '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 0x10c586db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81a8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:33:18 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 16:33:18 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 16:33:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:33:18 INFO - Return code: 0 16:33:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:33:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:33:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:33:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:33:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0082', '--webServer', 'localhost'] in /builds/slave/test/build 16:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0082 --webServer localhost 16:33:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7UeluwetHM/Render', 16:33:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:18 INFO - 'HOME': '/Users/cltbld', 16:33:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:18 INFO - 'LOGNAME': 'cltbld', 16:33:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:33:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:18 INFO - 'MOZ_NO_REMOTE': '1', 16:33:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:33:18 INFO - 'NO_EM_RESTART': '1', 16:33:18 INFO - 'PAGER': '/bin/cat', 16:33:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:18 INFO - 'PWD': '/builds/slave/test', 16:33:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:33:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:18 INFO - 'SHELL': '/bin/bash', 16:33:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R2LbzzgVTk/Listeners', 16:33:18 INFO - 'TMPDIR': '/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/', 16:33:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:18 INFO - 'USER': 'cltbld', 16:33:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:18 INFO - 'XPC_FLAGS': '0x0', 16:33:18 INFO - 'XPC_SERVICE_NAME': '0', 16:33:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:33:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0082', '--webServer', 'localhost'] with output_timeout 3600 16:33:18 INFO - mozversion INFO | application_buildid: 20151112151340 16:33:18 INFO - mozversion INFO | application_changeset: 285852de5cd54891d8f3b1ddbff179e4c9c7ca5f 16:33:18 INFO - mozversion INFO | application_display_name: Nightly 16:33:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:33:18 INFO - mozversion INFO | application_name: Firefox 16:33:18 INFO - mozversion INFO | application_remotingname: firefox 16:33:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 16:33:18 INFO - mozversion INFO | application_vendor: Mozilla 16:33:18 INFO - mozversion INFO | application_version: 45.0a1 16:33:18 INFO - mozversion INFO | platform_buildid: 20151112151340 16:33:18 INFO - mozversion INFO | platform_changeset: 285852de5cd54891d8f3b1ddbff179e4c9c7ca5f 16:33:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 16:33:18 INFO - mozversion INFO | platform_version: 45.0a1 16:33:18 INFO - 2015-11-12 16:33:18,918 DEBUG : using testdate: 1447374798 16:33:18 INFO - 2015-11-12 16:33:18,918 DEBUG : actual date: 1447374798 16:33:19 INFO - 2015-11-12 16:33:19,023 INFO : starting webserver on 'localhost:50228' 16:33:19 INFO - 2015-11-12 16:33:19,025 INFO : Starting test suite t-yosemite-r5-0082 16:33:19 INFO - 2015-11-12 16:33:19,025 INFO : Starting test dromaeo_css 16:33:19 INFO - 2015-11-12 16:33:19,025 DEBUG : operating with platform_type : mac_ 16:33:19 INFO - 2015-11-12 16:33:19,085 INFO : Initialising browser for dromaeo_css test... 16:33:19 INFO - 2015-11-12 16:33:19,122 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/tmpowqBGk/profile http://localhost:50228/getInfo.html 16:33:22 INFO - 2015-11-12 16:33:22,393 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:33:22 INFO - 2015-11-12 16:33:22,393 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:33:22 INFO - 2015-11-12 16:33:22,393 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:33:22 INFO - 2015-11-12 16:33:22,394 DEBUG : BROWSER_OUTPUT: __metrics 16:33:22 INFO - 2015-11-12 16:33:22,410 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:33:23 INFO - 2015-11-12 16:33:23,260 INFO : Browser initialized. 16:33:23 INFO - 2015-11-12 16:33:23,260 INFO : Running cycle 1/1 for dromaeo_css test... 16:33:23 INFO - 2015-11-12 16:33:23,260 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/tmpowqBGk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:33:35 INFO - 2015-11-12 16:33:35,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 232140800 16:33:35 INFO - 2015-11-12 16:33:35,568 DEBUG : BROWSER_OUTPUT: 16:34:27 INFO - 2015-11-12 16:34:27,032 DEBUG : BROWSER_OUTPUT: 1447374867027 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:36:38 INFO - 2015-11-12 16:36:38,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50228/tests/dromaeo/cssquery-ext.html) 16:36:39 INFO - 2015-11-12 16:36:39,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 326852608 16:36:39 INFO - 2015-11-12 16:36:39,441 DEBUG : BROWSER_OUTPUT: 16:39:42 INFO - 2015-11-12 16:39:42,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/dromaeo/cssquery-ext.html (next: http://localhost:50228/tests/dromaeo/cssquery-jquery.html) 16:39:42 INFO - 2015-11-12 16:39:42,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 357212160 16:39:42 INFO - 2015-11-12 16:39:42,995 DEBUG : BROWSER_OUTPUT: 16:42:45 INFO - 2015-11-12 16:42:45,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50228/tests/dromaeo/cssquery-mootools.html) 16:42:45 INFO - 2015-11-12 16:42:45,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 317579264 16:42:45 INFO - 2015-11-12 16:42:45,983 DEBUG : BROWSER_OUTPUT: 16:45:48 INFO - 2015-11-12 16:45:48,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50228/tests/dromaeo/cssquery-prototype.html) 16:45:48 INFO - 2015-11-12 16:45:48,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 317624320 16:45:48 INFO - 2015-11-12 16:45:48,826 DEBUG : BROWSER_OUTPUT: 16:48:52 INFO - 2015-11-12 16:48:52,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50228/tests/dromaeo/cssquery-yui.html) 16:48:52 INFO - 2015-11-12 16:48:52,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 320475136 16:48:52 INFO - 2015-11-12 16:48:52,680 DEBUG : BROWSER_OUTPUT: 16:51:55 INFO - 2015-11-12 16:51:55,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/dromaeo/cssquery-yui.html (next: http://localhost:50228/tests/dromaeo/cssquery-dojo.html) 16:51:56 INFO - 2015-11-12 16:51:56,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 375345152 16:51:56 INFO - 2015-11-12 16:51:56,228 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,228 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:51:56 INFO - 2015-11-12 16:51:56,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:51:56 INFO - 2015-11-12 16:51:56,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:51:56 INFO - 2015-11-12 16:51:56,230 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:51:56 INFO - 2015-11-12 16:51:56,231 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2459.70483541975;2496.7752902238794;2499.1377974598768;2526.6715327007487;2536.239128261522;4046.31212693842;4168.937465938009;4169.6455801256925;4170.311898536738;4230.36544518322;4049.2711311963835;4104.6921480888905;4137.979310103446;4157.127003329297;4179.3313069908745;3967.662748666367;3968;3969.6030396960364;4000.819963101653;4060.106776509178;4009.659178969791;4073.083556199861;4075.502577126694;4077.87766367008;4129.710920235585;3715.405535114382;3820.522434695663;3875.302445559798;3881.359575670011;3925.646691797723;3956;3983.581723918976;3992.8203230854683;3992.840286388541;4029.234445455354;3945.1123497213184;3952.565217826037;3990.521137463494;3997.040710229524;4038.51537815464;4017.678585713136;4059.8985025374304;4148.875533733993;4180.540140584533;4181.540030596662;4368;4393.626541743955;4399.098184872126;4412.073464572443;4436.223660859369;4474.351219073249;4486.663500237462;4516.07420478801;4539.546045395467;4586.72479651222;3964.8017599120217;4057.472528571267;4069.1861627674584;4077.2049450356894;4130.132672138824;4578.381918441034;4608.585227329557;4614.976925115353;4641.396618439581;4692.577668009895;4374.5625437456;4381.518033016366;4385.528749577351;4393.604575588149;4462.754548499864;4225.091605304813;4317.8272869084885;4426.15902978433;4431.135928493977;4444.400005999213;4411.360352748833;4430.579094985971;4446.510883802779;4473.530279320689;4492.0791237796175;4476.776161191928;4477.059817438309;4478.932816007762;4517.2094883395275;4559.293309537027;3297.9175520612175;3379.864805407756;3459.446488561868;3461.463473161664;3474.0793689672255;3092;3164.6360668522952;3169.4770362889867;3172.762042846796;3189.3302406494895;4189.874303770892;4202.117555313418;4209.431726716854;4251.893702657459;4259.190753756776;4227.112306415625;4354.978225108917;4364.148990946735;4485.708428952108;4508.1659892919915;4028.657564107025;4091.5908409158847;4110;4144.984478802652;4155.8753237402925;3929.9214015719526;3979.0450291930306;4011.338129208706;4015.4501891299237;4071.5521292657786;4430.889227769331;4498.415206023196;4505.098980204038;4661.160991021648;4664.906701866012;4338.154059958278;4418.558144185556;4435.1351486459835;4477.731336119843;4516.593506584423;4598;4649.442066951988;4653.650976176868;4669.649776266861;4719.315699223662;4200.579942005775;4309.547497512716;4319.028218650778;4413.293872980308;4413.293872980308;4413.117376524644;4424.159409712273;4428.424304840479;4486.64106871456;4535.002299494106;4390.780460977002;4394.714343567658;4418.668599855088;4436.844710435119;4510.120526497301;4025.8389664414267;4347.152305300562;4357.520672726061;4446.3108218226225;4460.966542750944;4158.480189976253;4252.532221455699;4281.657467402538;4311.267084595689;4362;4409.338599210144;4427.911441771211;4442.2892337225885;4445.73325600465;4484.977575112103;4048.2915489789757;4201.264778663783;4243.42713733642;4303.354496825501;4315.827366905414 16:51:56 INFO - 2015-11-12 16:51:56,234 DEBUG : BROWSER_OUTPUT: |1;ext.html;447.5569186505361;450.47744616245154;460.8410098516012;464.57723471640816;480.0926249388658;23148.76851231489;24438.14466493673;31308.217294567618;31753.84123079387;31876.20309492264;33422.66577334226;34039.319213615774;34054.48918266228;34325.656743432555;34348.1412964676;6546.672666366662;7239.963800180992;7400.222976587462;7466.925330746704;7488.887666685004;6591.736330546796;6687.431568316674;8797.472151670889;8976.147266009719;9090.090990900922;8726.607302671364;8799.912000879973;8865.867011994826;8901.421407608517;8912.064233255513;6734.292899245557;6881.65591720417;8655.134486551358;8799.340049496313;8859.06979767128;6552.410283074499;8712.607932643046;8979.14698103679;9050.411723238034;9055.366124371296;31499.370012599848;31504.212394690087;31614.525782113287;31693.52459713106;31945.84027079873;2241.1035585765826;2250.3586477853733;2403.5072810074066;2429.5748244057218;2768;21505.354839354688;21768.238111666014;22366.2171823987;22478;23020.194293199656;1886.415211284506;1895.573495963411;1901.6672082385528;1924.3072493902184;2000.3398878370103;207465;207798;207846;209541;210326;44603;46197.53802461999;46441;46855;46855;39576.80211598924;54702.45297547053;54996.45003549993;55625;55948.16077758837;12983.805242921364;13122.60632181036;13209.40557674907;13248.40382182804;13259.801102983463;10019.849702254473;10127.949360253298;10137.898621013843;10258.692239232834;10275.897241027644;15077.396904123932;15497.922510387376;15527.689446211012;15534.45629402988;15618.84381156174;5972.970135149383;6327.3988971047675;6398.424141827165;6424.421802037839;6460.483161347081;727.8435136445584;734.2107234722588;779.3570304498811;852.1776485691214;874.3922973533461;22283.4401591887;22528.21151259698;22792.886035569714;22886.900920400767;23193.188238411913;770.5222761887666;812.6424373275858;854.5043874552745;925.8102089071724;962.7015625156224;11545.307281563133;11722.238054526599;11846.466908989116;11875.762484750257;11925.1652384334;257415;259207;260421;263436;264681;42154.15227248844;42288.365674514906;42385.152296953886;42575.57424425778;43128.137437251076;1070.1599244593112;1074.08166018055;1083.2363183955292;1091.5088210305394;1110.439228189759;22192.334229973127;22458.213962511232;22474.438139046655;22508;22528.211512597634;34506.82746586251;35542.822285888404;38234.80882595569;38518.2296354077;38664.42003370008;215133;218980;222502;227178;227808;23780.762192377853;23809.166679166145;23851.403714907265;23861.522769544164;24043.278701638978;24529.386765331008;26852.865735671196;27859.721402786523;29772.702272976992;31424;24648.630270546313;26855;27035.459290814466;28020.859895700392;28237.43525129527;26607.20178394651;26936.191914242605;27259.727402726512;27896.860515698103;28097.87608495719;25681.743182567934;26309;26411.339716507242;26610.733892660824;26670.333241669112;21704.565908681423;23934;24262.085305687793;24861;25199.49601007933;17868;18830.52923676919;18890;18900.621987560447;19256.903715481334 16:51:56 INFO - 2015-11-12 16:51:56,236 DEBUG : BROWSER_OUTPUT: |2;jquery.html;260.2349093664626;262.76088759229094;264.38266647378373;266.597437868818;273.2948991601667;11899.643010709671;13580.049396542247;13747.45010199592;14077.436902523887;14100.15399076055;11152.442377881094;11287.209895307331;11751.236169648966;11860.822087668692;13820.930895345535;4145.626893579577;4228.090960443504;4252.043290259698;4267.935980960288;4297.505786834523;4192.214743653753;4194.475690538683;4256.212600668886;4277.957220427803;4279.48646162461;3022.7430668393104;3146.2606287522412;3166.9841650791714;4221.957780422203;4479.507254202035;4590.495045544987;4593.242115051013;4598.609118224955;4623.491415944243;4629.791659375336;3749.2876353492748;3841.116543195081;3981.422693709425;4002.0195052212102;4004.5194576650697;15994.920025399799;16362.754558681629;16627.916860415622;16791.83208167915;16804.159792010472;1544.1815837606086;1596.4731638559247;1611.564877483073;1745.6159644878107;1895.8388536974373;10233.181345492343;10479.371237725762;10481.895181048245;10745.83881241782;10775.191860610406;1323.0672375974914;1326.7511567892427;1348.7976803479457;1351.061012596246;1365.8019587159906;46510.5348946513;47380.526194737955;47465.050698986175;47767.283490747664;47862.28206576904;7379.852402951911;7389.076365454318;7645.388368930472;7720.227977202235;7764.340031097307;9440.858387124199;9524.14282714559;9552.235821134293;9555.092266234697;9563.139317461462;6027.517798576191;6035.034394496859;6065.5450841187085;6088.573799834057;6092.939070609325;6063.393660633989;6090.086487026892;6124.142620033199;6150.846228844314;6174.722137503823;4539.160255352705;4568.885777855514;4570.245909424974;4662.557057079572;4673.883152921204;1333.7265860498574;1343.402186027228;1364.536057740373;1365.1058556645214;1372.7872179812146;274.82685907878306;288.4202752467555;691.1774987764544;804.4087595617217;853.50923219148;7156.964215178891;7885.921140788633;8114.63484143215;8162.795930101676;8402.537860417613;306.7362068620984;326.25939118202024;331.1159204922862;343.46591050916066;348.45118937673266;3611.2235869287706;4288.871333859989;4396.692231543761;4479.417675702203;4522.841700540465;417306;424325;425532;455158;457413;54799;55216;55678.443215568135;56372.43627563672;57742;354.54795136201034;385.74926297906586;400.71549200067693;400.91781184857615;401.7890607431122;8329.29201017896;8580.184882436159;8593.226609605166;8622.655093796178;8688.435251708872;15796.21018949025;24227.757722423255;24416;25559.872200638878;26347.73652263453;36141.27717445689;36394.63605363912;36513.63486365102;36687.816560918094;36701.08247293839;4696.332945863517;4702.341672165968;4717.103750287434;4837.685550439211;4840.007798401249;8900.77748056278;9057.230135438298;9115.179633832988;9150.483617005377;9236.445813251226;7740.496867703581;7774.378049756119;7942.6028698566;7971.043474783063;8003.119656837627;7599.392048636207;7716.807079823049;7720.189380115232;7775.416843736629;7814.960925195338;7771.22287771241;7884.645190966535;7966.442349035512;8100.554469504234;8128.309093726863;4288.8284468620905;4715.0805592909055;4728.007118505015;4737.692050016738;4781.019890922283;6368.172137622079;6808.421284190899;6875.1749790025515;7588.8482230356185;7812 16:51:56 INFO - 2015-11-12 16:51:56,239 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1031.0617338222219;1341.4030756313439;1367.2275164532039;1406.3319923036559;1418.2483283859551;5444.455554444554;5610.803621873235;5613.775448982046;5835.445632664901;5852.707364631762;5880.794172203974;5997.700114994254;6003.969980150104;6005.6096353736975;6013.368596297391;1673.129972414344;1680.8991460512348;1688.4850120713177;1696.4062578097692;1698.4819630012842;1701.6681747059329;1710.598009467774;1729.368780395153;1734.0549400576654;1753.1059159828515;1672.0636443591627;1691.1882296497688;1699.9970017689561;1702.0893821805337;1702.6509565539097;1654.9172541372943;1681.7477378393216;1681.840225178606;1725.2581390002294;1727.179589694885;1710.1705672748708;1722.3885520640117;1723.0781531880384;1728.1013872786082;1739.5564131146602;5425.13197888336;5950.196723442366;5980.790672326491;5992.730327135246;6006.159137720722;3221.5650887130173;3272.5091236314506;3473.444248920186;3549.0772399176144;3556.324298383299;2263.7283525976986;2284.291869520454;2305.13557415969;2313.652952057188;2323.97676023241;705.8870580707113;714.1144980224536;714.1501613080418;718.4719231364943;737.0565675934812;7993;8018.558979256139;8032.799180020546;8061.153578874192;8091.231333023354;3088.2279430142466;3198.696123868229;3231;3258.6904244096772;3267.591551056118;7113.822154446077;7136.357727804522;7145.464090193256;7178.497505174588;7184.9640751795905;3688.4651725499652;3726.5155529781496;3730.6642402183934;3731.1231860512758;3731.869384571527;3362.764606477572;3386.813725245135;3395;3400.489926510994;3407.148212946763;2667.146513115823;2671.4389978104814;2671.9599206011926;2683.409649877024;2700.7164247753703;846.0777752250077;874.8600223964263;880.3529405886668;882.8808110904946;886.9201771840566;1015.3197357770312;1025.8820235672845;1042.593388578455;1045.3780000899453;1052.6263176572359;5630.662160270397;5668.914966275509;5685.715714214272;5727.713614319267;5746.367899531048;306.7975136409959;307.7830129758515;308.4386416721545;942.9057094290516;992.6376872441507;4456.420665313553;4542.568455996675;4542.5911667949385;4544.772761361919;4571.81712731487;5772.826815195551;6759.493038022168;7223.097112860893;7225.205227424979;7248.963755181296;7041.260667629927;7080.645967701595;7099.89350159748;7159.212486626467;7200.135983681992;5415.187721841677;5577.6932268724795;5720.11338242573;5732.570057245724;5786.768529258867;5601.383847776823;5651.943480565142;5675.659460432387;5710.914336284876;5762.020456522485;6164.079158281586;6206.162168107247;6240.28236752761;6350.333215012357;6421.5825971311715;6098.664573448503;6519.282878883224;6556.409923106943;6583.835404114744;6659.600423974577;5341.465853414627;5486.561075113901;5498.340199176125;5532.059549876451;5545.805896793593;5645.633033852787;5707.286589176353;5722.313322401338;5737.540996720169;5759.740811663569;5406.513413792777;5466.262054622575;5524.91712624319;5560;5619.157126431068;5313.468653134811;5388.892222155457;5447.509724124848;5447.891042179055;5500.7524661391135;5508.807191748269;5513.917291240715;5531.308586426697;5592.049351610317;5593.105103183471;4986.900261994667;5093.8471845843205;5094.898102038012;5103.3110530077965;5107.029664363759;5040.823571174991;5144.717040562805;5168.01807656544;5176.922346164735;5196.68819870809 16:51:56 INFO - 2015-11-12 16:51:56,241 DEBUG : BROWSER_OUTPUT: |4;prototype.html;238.92354446577096;240.9554232466995;243.79521202190168;248.83452504084784;254.09162244974223;4894.314795928568;4948.455669876311;4950.851474455768;4958.256261560768;5005.374328208974;4674.7428891410955;4939.554920314449;4943.975280123604;4952.380952380952;4966.155753521901;3799.1262009737775;3800.4869342638804;3805.353089974711;3808.0479880029993;3824.8087595620245;3783;3785.697144228469;3802.2775672622115;3810.637989391017;3816.2939856126704;3531.8940431787087;3595.262971090933;3627.220147668251;3660.8718694845684;3753.6246375362516;3728.5525736911472;3735.8132093395493;3738.383166777465;3777.8111094445444;3797.886063418102;3180.236743181643;3180.6024246969127;3182.7931184472936;3183.6657150999044;3186.7928584641922;4651.720896746206;4705.694129881581;4715.221988371914;4769.356136921506;4769.427668679746;4177.6866734995;4180.874573762792;4184.727992680497;4227.682923780729;4228.640565551932;5179.067767801795;5186.247994040843;5186.870328241824;5196.948030519722;5217.634765566412;3408.931821363584;3421.4183588789715;3439.466882633196;3445;3449.913752156191;5184.585233181337;5316.149416093445;5346.572274218053;5457.345118585716;5461.918071228934;3452.5684289463816;3457.2048428861503;3459.100633835221;3460.826958652108;3474.0793689672255;3513.595936467339;3523.136831476305;3549.4498352755363;3559.60844307126;3562.76842005274;4135.0902801383645;4159.417681524589;4167.5207351155;4177.624013838708;4179.435776170239;5002.399712034507;5148.536631703165;5158.0199762045095;5201;5202.557782588447;1232.6363722701824;1257.7610254051701;1257.8553466351486;1262.7600755856358;1265.5697062998624;761.1589193940727;773.6402572803673;774.7946794099568;788.1842293226483;801.0387534958073;4931.13705101613;4940.2342636891335;4968.527989840959;4972.204447288416;4993.151164302078;5354.196870469461;5367.1680889462195;5385.5960802939935;5411.161270003156;5450.100733379028;4826.131296366688;4892.3884514435695;4926.187179115477;4960.181570040902;4964.542551437062;2810.536261516827;2873.741363277273;2911.1121108062243;2919.1534455008236;2924.005838015085;5564.582656300794;5610.410906854803;5659.660420374791;5661.547076233974;5695.658260504383;5294.655847369909;5415.593830462731;5434.755436005389;5590.692511911884;5613.410591887875;5449.727513624303;5569.275994120739;5603.019471592455;5617.859553511195;5621.690807005572;5431.4840090191365;5446.809361672323;5468.56251499887;5472.50747432733;5491.148871924858;5305.65513241638;5316.760745766527;5334.146536554133;5352.973235133955;5355.30381050461;5452.427495112956;5591.8881622368135;5595.832125036255;5606.607537472338;5630.88738225225;3516.5604299462566;3535.9292814144087;3548.449990251515;3554.804485753205;3565.893023209308;5435.483629055233;5451.127819548853;5464.480874316933;5468.9179662304305;5480.150576660624;5080.745962701924;5256.4480729524375;5282.498162674539;5290.629655924048;5333.013392522395;5209.661372010807;5220.243064755665;5228.660137091077;5247.921281180709;5271.920921186109;5171.276021357088;5172.069027575073;5172.379314482287;5173.741312934263;5181.481851814789;5292.338457692788;5316.415194328543;5328.57371410294;5345.4654534546235;5364.839054828361;4989.351384320015;5161.509656582619;5186.818461353834;5193.454687257784;5199.090159222196 16:51:56 INFO - 2015-11-12 16:51:56,245 DEBUG : BROWSER_OUTPUT: |5;yui.html;537.1110811606787;584.5820238529451;595.9659989917494;598.9101634754786;603.2218438214703;10343;10641.627543035995;10678.252522323432;10694.893051069486;10698.946505267462;8606.483610983345;9579.856302155456;10033.899661003388;10091.495425228728;10262;696.6238231355075;703.806453225362;704.6441547018749;710.4777988178685;716.3123401534507;647.6308504152635;687.8142901416614;699.2413231643673;702.6697452197459;706.9893951590731;729.9270072992684;741.8256709673223;748.7267147491181;755.7430473638962;756.4855897989365;726.1685370251085;730.9232530584292;738.4609235258291;740.0601236429704;740.1192580828797;546.7730891679948;548.5227851768987;549.2228496677197;554.6810583914265;554.9982281981023;9432.717018489457;9514.952425237829;9534;9586.808263834753;9596.280278979035;7636.198199189116;7769.689212431496;8061.4760040597175;8223.42436029478;8350.08149103598;6910.2744211858035;6991.126109236346;6997.615131167784;7015.754448594325;7144.642767861586;2545.6308835218974;2565.2834935397395;2589.37854914821;2656.481986012728;2737.671479422462;28799.71200287991;28861.134165975054;28865.56701649477;32802;33460.49809252863;5360.115580929181;5431.918521222185;5493.835184944458;5662.915056274159;5691.808653668368;9263.25893928484;9324;9379.343445958717;9412.15290623847;9459.763505912408;4760.238361862154;4786.16242157621;4824.614030877521;4840.951590484121;4881.8535443936735;2760.4479104179245;2844.687084420712;2905.5205891027745;2965.525515917443;3052.877884884624;2079.8856062916684;2163.8701677899376;2218.123841082763;2223.899924503401;2230.9107635694713;361.5480649188514;364.6371859999318;368.60743308376493;369.5306960160581;381.3231514062506;449.58638052991324;452.19960669614596;455.71973236459337;469.1719115760685;499.03934925268715;5756.740946657411;6091.360407157274;6124.732729852323;6171.6297022178815;6280.183576135073;367.9006668199571;404.68030256097353;423.5936690188544;442.2415557319213;494.9059678661115;2938.4270067337093;3024.0927721683406;3033.7572994160855;3045.497492913689;3080.4147212029643;44749.32876006862;46700.29949550759;46721.53278467172;46868;46936.53063469322;40436.393454098215;41116.38325425121;41250.38124428136;41345.1730965379;41559.168816623496;31568.833330031244;37890.43164352537;38526.42210366847;39372.2125557493;40232;6440.32376600469;6583.96708016476;6638.302978187414;6676.799696008933;6684.264730879697;23070.76929230686;25146.62280065764;26034.34914127162;27978.720212797612;28536.85731571329;28319;29089.272768180967;34430.48354274738;35141.82429087838;36215.637843621225;6000.849978750566;6039.607425517327;6159.168512250968;6196.504279657526;6335.714892829926;8764.956175219084;8942.418742781698;8951.194392504705;9049.59276832531;9193.816123677623;8190.959045204974;8259.132791056853;8473;8548.871766923625;8575.3997220194;8212.63043163071;8301.543415111984;8553.315734741082;8568.35737319691;8683.739487815375;8198.508089514648;8345.374096942633;8386.580670966305;8410.663573456994;8426.073131955358;7173.10336207974;7208.135023796968;7290.817729556804;7310.159331676925;7416.25837416254;6965;7302.233265507258;7334.486585938933;7380.815479613053;7565.167831538416 16:51:56 INFO - 2015-11-12 16:51:56,245 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:51:56 INFO - 2015-11-12 16:51:56,245 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:51:56 INFO - 2015-11-12 16:51:56,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,920 16:51:56 INFO - 2015-11-12 16:51:56,245 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:51:56 INFO - 2015-11-12 16:51:56,245 DEBUG : BROWSER_OUTPUT: __startTimestamp1447375916227__endTimestamp 16:51:56 INFO - 2015-11-12 16:51:56,245 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,246 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:51:56 INFO - 2015-11-12 16:51:56,246 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:51:56 INFO - 2015-11-12 16:51:56,246 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,246 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4167.95 Median:4252.53 stddev:435.40 (10.2%) stddev-sans-first:415.61 16:51:56 INFO - 2015-11-12 16:51:56,246 DEBUG : BROWSER_OUTPUT: Values: 2459.7 2496.8 2499.1 2526.7 2536.2 4046.3 4168.9 4169.6 4170.3 4230.4 4049.3 4104.7 4138.0 4157.1 4179.3 3967.7 3968.0 3969.6 4000.8 4060.1 4009.7 4073.1 4075.5 4077.9 4129.7 3715.4 3820.5 3875.3 3881.4 3925.6 3956.0 3983.6 3992.8 3992.8 4029.2 3945.1 3952.6 3990.5 3997.0 4038.5 4017.7 4059.9 4148.9 4180.5 4181.5 4368.0 4393.6 4399.1 4412.1 4436.2 4474.4 4486.7 4516.1 4539.5 4586.7 3964.8 4057.5 4069.2 4077.2 4130.1 4578.4 4608.6 4615.0 4641.4 4692.6 4374.6 4381.5 4385.5 4393.6 4462.8 4225.1 4317.8 4426.2 4431.1 4444.4 4411.4 4430.6 4446.5 4473.5 4492.1 4476.8 4477.1 4478.9 4517.2 4559.3 3297.9 3379.9 3459.4 3461.5 3474.1 3092.0 3164.6 3169.5 3172.8 3189.3 4189.9 4202.1 4209.4 4251.9 4259.2 4227.1 4355.0 4364.1 4485.7 4508.2 4028.7 4091.6 4110.0 4145.0 4155.9 3929.9 3979.0 4011.3 4015.5 4071.6 4430.9 4498.4 4505.1 4661.2 4664.9 4338.2 4418.6 4435.1 4477.7 4516.6 4598.0 4649.4 4653.7 4669.6 4719.3 4200.6 4309.5 4319.0 4413.3 4413.3 4413.1 4424.2 4428.4 4486.6 4535.0 4390.8 4394.7 4418.7 4436.8 4510.1 4025.8 4347.2 4357.5 4446.3 4461.0 4158.5 4252.5 4281.7 4311.3 4362.0 4409.3 4427.9 4442.3 4445.7 4485.0 4048.3 4201.3 4243.4 4303.4 4315.8 16:51:56 INFO - 2015-11-12 16:51:56,247 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,247 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36439.78 Median:26895.60 stddev:60582.27 (225.2%) stddev-sans-first:60691.95 16:51:56 INFO - 2015-11-12 16:51:56,247 DEBUG : BROWSER_OUTPUT: Values: 447.6 450.5 460.8 464.6 480.1 23148.8 24438.1 31308.2 31753.8 31876.2 33422.7 34039.3 34054.5 34325.7 34348.1 6546.7 7240.0 7400.2 7466.9 7488.9 6591.7 6687.4 8797.5 8976.1 9090.1 8726.6 8799.9 8865.9 8901.4 8912.1 6734.3 6881.7 8655.1 8799.3 8859.1 6552.4 8712.6 8979.1 9050.4 9055.4 31499.4 31504.2 31614.5 31693.5 31945.8 2241.1 2250.4 2403.5 2429.6 2768.0 21505.4 21768.2 22366.2 22478.0 23020.2 1886.4 1895.6 1901.7 1924.3 2000.3 207465.0 207798.0 207846.0 209541.0 210326.0 44603.0 46197.5 46441.0 46855.0 46855.0 39576.8 54702.5 54996.5 55625.0 55948.2 12983.8 13122.6 13209.4 13248.4 13259.8 10019.8 10127.9 10137.9 10258.7 10275.9 15077.4 15497.9 15527.7 15534.5 15618.8 5973.0 6327.4 6398.4 6424.4 6460.5 727.8 734.2 779.4 852.2 874.4 22283.4 22528.2 22792.9 22886.9 23193.2 770.5 812.6 854.5 925.8 962.7 11545.3 11722.2 11846.5 11875.8 11925.2 257415.0 259207.0 260421.0 263436.0 264681.0 42154.2 42288.4 42385.2 42575.6 43128.1 1070.2 1074.1 1083.2 1091.5 1110.4 22192.3 22458.2 22474.4 22508.0 22528.2 34506.8 35542.8 38234.8 38518.2 38664.4 215133.0 218980.0 222502.0 227178.0 227808.0 23780.8 23809.2 23851.4 23861.5 24043.3 24529.4 26852.9 27859.7 29772.7 31424.0 24648.6 26855.0 27035.5 28020.9 28237.4 26607.2 26936.2 27259.7 27896.9 28097.9 25681.7 26309.0 26411.3 26610.7 26670.3 21704.6 23934.0 24262.1 24861.0 25199.5 17868.0 18830.5 18890.0 18900.6 19256.9 16:51:56 INFO - 2015-11-12 16:51:56,247 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,247 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21721.24 Median:4531.00 stddev:71336.19 (1574.4%) stddev-sans-first:71518.10 16:51:56 INFO - 2015-11-12 16:51:56,249 DEBUG : BROWSER_OUTPUT: Values: 260.2 262.8 264.4 266.6 273.3 11899.6 13580.0 13747.5 14077.4 14100.2 11152.4 11287.2 11751.2 11860.8 13820.9 4145.6 4228.1 4252.0 4267.9 4297.5 4192.2 4194.5 4256.2 4278.0 4279.5 3022.7 3146.3 3167.0 4222.0 4479.5 4590.5 4593.2 4598.6 4623.5 4629.8 3749.3 3841.1 3981.4 4002.0 4004.5 15994.9 16362.8 16627.9 16791.8 16804.2 1544.2 1596.5 1611.6 1745.6 1895.8 10233.2 10479.4 10481.9 10745.8 10775.2 1323.1 1326.8 1348.8 1351.1 1365.8 46510.5 47380.5 47465.1 47767.3 47862.3 7379.9 7389.1 7645.4 7720.2 7764.3 9440.9 9524.1 9552.2 9555.1 9563.1 6027.5 6035.0 6065.5 6088.6 6092.9 6063.4 6090.1 6124.1 6150.8 6174.7 4539.2 4568.9 4570.2 4662.6 4673.9 1333.7 1343.4 1364.5 1365.1 1372.8 274.8 288.4 691.2 804.4 853.5 7157.0 7885.9 8114.6 8162.8 8402.5 306.7 326.3 331.1 343.5 348.5 3611.2 4288.9 4396.7 4479.4 4522.8 417306.0 424325.0 425532.0 455158.0 457413.0 54799.0 55216.0 55678.4 56372.4 57742.0 354.5 385.7 400.7 400.9 401.8 8329.3 8580.2 8593.2 8622.7 8688.4 15796.2 24227.8 24416.0 25559.9 26347.7 36141.3 36394.6 36513.6 36687.8 36701.1 4696.3 4702.3 4717.1 4837.7 4840.0 8900.8 9057.2 9115.2 9150.5 9236.4 7740.5 7774.4 7942.6 7971.0 8003.1 7599.4 7716.8 7720.2 7775.4 7815.0 7771.2 7884.6 7966.4 8100.6 8128.3 4288.8 4715.1 4728.0 4737.7 4781.0 6368.2 6808.4 6875.2 7588.8 7812.0 16:51:56 INFO - 2015-11-12 16:51:56,249 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,250 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4184.41 Median:5447.70 stddev:2171.02 (39.9%) stddev-sans-first:2164.17 16:51:56 INFO - 2015-11-12 16:51:56,251 DEBUG : BROWSER_OUTPUT: Values: 1031.1 1341.4 1367.2 1406.3 1418.2 5444.5 5610.8 5613.8 5835.4 5852.7 5880.8 5997.7 6004.0 6005.6 6013.4 1673.1 1680.9 1688.5 1696.4 1698.5 1701.7 1710.6 1729.4 1734.1 1753.1 1672.1 1691.2 1700.0 1702.1 1702.7 1654.9 1681.7 1681.8 1725.3 1727.2 1710.2 1722.4 1723.1 1728.1 1739.6 5425.1 5950.2 5980.8 5992.7 6006.2 3221.6 3272.5 3473.4 3549.1 3556.3 2263.7 2284.3 2305.1 2313.7 2324.0 705.9 714.1 714.2 718.5 737.1 7993.0 8018.6 8032.8 8061.2 8091.2 3088.2 3198.7 3231.0 3258.7 3267.6 7113.8 7136.4 7145.5 7178.5 7185.0 3688.5 3726.5 3730.7 3731.1 3731.9 3362.8 3386.8 3395.0 3400.5 3407.1 2667.1 2671.4 2672.0 2683.4 2700.7 846.1 874.9 880.4 882.9 886.9 1015.3 1025.9 1042.6 1045.4 1052.6 5630.7 5668.9 5685.7 5727.7 5746.4 306.8 307.8 308.4 942.9 992.6 4456.4 4542.6 4542.6 4544.8 4571.8 5772.8 6759.5 7223.1 7225.2 7249.0 7041.3 7080.6 7099.9 7159.2 7200.1 5415.2 5577.7 5720.1 5732.6 5786.8 5601.4 5651.9 5675.7 5710.9 5762.0 6164.1 6206.2 6240.3 6350.3 6421.6 6098.7 6519.3 6556.4 6583.8 6659.6 5341.5 5486.6 5498.3 5532.1 5545.8 5645.6 5707.3 5722.3 5737.5 5759.7 5406.5 5466.3 5524.9 5560.0 5619.2 5313.5 5388.9 5447.5 5447.9 5500.8 5508.8 5513.9 5531.3 5592.0 5593.1 4986.9 5093.8 5094.9 5103.3 5107.0 5040.8 5144.7 5168.0 5176.9 5196.7 16:51:56 INFO - 2015-11-12 16:51:56,251 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,251 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4329.53 Median:4967.34 stddev:1350.90 (27.2%) stddev-sans-first:1319.34 16:51:56 INFO - 2015-11-12 16:51:56,252 DEBUG : BROWSER_OUTPUT: Values: 238.9 241.0 243.8 248.8 254.1 4894.3 4948.5 4950.9 4958.3 5005.4 4674.7 4939.6 4944.0 4952.4 4966.2 3799.1 3800.5 3805.4 3808.0 3824.8 3783.0 3785.7 3802.3 3810.6 3816.3 3531.9 3595.3 3627.2 3660.9 3753.6 3728.6 3735.8 3738.4 3777.8 3797.9 3180.2 3180.6 3182.8 3183.7 3186.8 4651.7 4705.7 4715.2 4769.4 4769.4 4177.7 4180.9 4184.7 4227.7 4228.6 5179.1 5186.2 5186.9 5196.9 5217.6 3408.9 3421.4 3439.5 3445.0 3449.9 5184.6 5316.1 5346.6 5457.3 5461.9 3452.6 3457.2 3459.1 3460.8 3474.1 3513.6 3523.1 3549.4 3559.6 3562.8 4135.1 4159.4 4167.5 4177.6 4179.4 5002.4 5148.5 5158.0 5201.0 5202.6 1232.6 1257.8 1257.9 1262.8 1265.6 761.2 773.6 774.8 788.2 801.0 4931.1 4940.2 4968.5 4972.2 4993.2 5354.2 5367.2 5385.6 5411.2 5450.1 4826.1 4892.4 4926.2 4960.2 4964.5 2810.5 2873.7 2911.1 2919.2 2924.0 5564.6 5610.4 5659.7 5661.5 5695.7 5294.7 5415.6 5434.8 5590.7 5613.4 5449.7 5569.3 5603.0 5617.9 5621.7 5431.5 5446.8 5468.6 5472.5 5491.1 5305.7 5316.8 5334.1 5353.0 5355.3 5452.4 5591.9 5595.8 5606.6 5630.9 3516.6 3535.9 3548.4 3554.8 3565.9 5435.5 5451.1 5464.5 5468.9 5480.2 5080.7 5256.4 5282.5 5290.6 5333.0 5209.7 5220.2 5228.7 5247.9 5271.9 5171.3 5172.1 5172.4 5173.7 5181.5 5292.3 5316.4 5328.6 5345.5 5364.8 4989.4 5161.5 5186.8 5193.5 5199.1 16:51:56 INFO - 2015-11-12 16:51:56,253 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,253 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10073.23 Median:590.27 stddev:12299.52 (2083.7%) stddev-sans-first:12313.18 16:51:56 INFO - 2015-11-12 16:51:56,254 DEBUG : BROWSER_OUTPUT: Values: 537.1 584.6 596.0 598.9 603.2 10343.0 10641.6 10678.3 10694.9 10698.9 8606.5 9579.9 10033.9 10091.5 10262.0 696.6 703.8 704.6 710.5 716.3 647.6 687.8 699.2 702.7 707.0 729.9 741.8 748.7 755.7 756.5 726.2 730.9 738.5 740.1 740.1 546.8 548.5 549.2 554.7 555.0 9432.7 9515.0 9534.0 9586.8 9596.3 7636.2 7769.7 8061.5 8223.4 8350.1 6910.3 6991.1 6997.6 7015.8 7144.6 2545.6 2565.3 2589.4 2656.5 2737.7 28799.7 28861.1 28865.6 32802.0 33460.5 5360.1 5431.9 5493.8 5662.9 5691.8 9263.3 9324.0 9379.3 9412.2 9459.8 4760.2 4786.2 4824.6 4841.0 4881.9 2760.4 2844.7 2905.5 2965.5 3052.9 2079.9 2163.9 2218.1 2223.9 2230.9 361.5 364.6 368.6 369.5 381.3 449.6 452.2 455.7 469.2 499.0 5756.7 6091.4 6124.7 6171.6 6280.2 367.9 404.7 423.6 442.2 494.9 2938.4 3024.1 3033.8 3045.5 3080.4 44749.3 46700.3 46721.5 46868.0 46936.5 40436.4 41116.4 41250.4 41345.2 41559.2 31568.8 37890.4 38526.4 39372.2 40232.0 6440.3 6584.0 6638.3 6676.8 6684.3 23070.8 25146.6 26034.3 27978.7 28536.9 28319.0 29089.3 34430.5 35141.8 36215.6 6000.8 6039.6 6159.2 6196.5 6335.7 8765.0 8942.4 8951.2 9049.6 9193.8 8191.0 8259.1 8473.0 8548.9 8575.4 8212.6 8301.5 8553.3 8568.4 8683.7 8198.5 8345.4 8386.6 8410.7 8426.1 7173.1 7208.1 7290.8 7310.2 7416.3 6965.0 7302.2 7334.5 7380.8 7565.2 16:51:56 INFO - 2015-11-12 16:51:56,254 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:51:56 INFO - 2015-11-12 16:51:56,254 DEBUG : BROWSER_OUTPUT: 16:51:57 INFO - 2015-11-12 16:51:57,006 INFO : Browser exited with error code: 0 16:51:57 INFO - 2015-11-12 16:51:57,042 INFO : Completed test dromaeo_css (00:18:38) 16:51:57 INFO - 2015-11-12 16:51:57,042 INFO : Starting test kraken 16:51:57 INFO - 2015-11-12 16:51:57,042 DEBUG : operating with platform_type : mac_ 16:51:57 INFO - 2015-11-12 16:51:57,043 INFO : Initialising browser for kraken test... 16:51:57 INFO - 2015-11-12 16:51:57,060 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/tmp3rEsOa/profile http://localhost:50228/getInfo.html 16:51:59 INFO - 2015-11-12 16:51:59,821 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:51:59 INFO - 2015-11-12 16:51:59,821 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:51:59 INFO - 2015-11-12 16:51:59,822 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:51:59 INFO - 2015-11-12 16:51:59,822 DEBUG : BROWSER_OUTPUT: __metrics 16:51:59 INFO - 2015-11-12 16:51:59,842 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:52:00 INFO - 2015-11-12 16:52:00,684 INFO : Browser initialized. 16:52:00 INFO - 2015-11-12 16:52:00,684 INFO : Running cycle 1/1 for kraken test... 16:52:00 INFO - 2015-11-12 16:52:00,685 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/tmp3rEsOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:52:12 INFO - 2015-11-12 16:52:12,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 228593664 16:52:12 INFO - 2015-11-12 16:52:12,884 DEBUG : BROWSER_OUTPUT: 16:52:16 INFO - 2015-11-12 16:52:16,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50228/tests/kraken/driver.html?testName=audio-beat-detection) 16:52:16 INFO - 2015-11-12 16:52:16,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 285945856 16:52:16 INFO - 2015-11-12 16:52:16,641 DEBUG : BROWSER_OUTPUT: 16:52:19 INFO - 2015-11-12 16:52:19,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50228/tests/kraken/driver.html?testName=audio-dft) 16:52:20 INFO - 2015-11-12 16:52:20,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 299618304 16:52:20 INFO - 2015-11-12 16:52:20,449 DEBUG : BROWSER_OUTPUT: 16:52:23 INFO - 2015-11-12 16:52:23,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50228/tests/kraken/driver.html?testName=audio-fft) 16:52:24 INFO - 2015-11-12 16:52:24,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 284372992 16:52:24 INFO - 2015-11-12 16:52:24,581 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50228/tests/kraken/driver.html?testName=audio-oscillator) 16:52:27 INFO - 2015-11-12 16:52:27,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 284958720 16:52:27 INFO - 2015-11-12 16:52:27,550 DEBUG : BROWSER_OUTPUT: 16:52:30 INFO - 2015-11-12 16:52:30,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:52:30 INFO - 2015-11-12 16:52:30,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 284680192 16:52:30 INFO - 2015-11-12 16:52:30,743 DEBUG : BROWSER_OUTPUT: 16:52:34 INFO - 2015-11-12 16:52:34,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50228/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:35 INFO - 2015-11-12 16:52:35,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 281546752 16:52:35 INFO - 2015-11-12 16:52:35,029 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-12 16:52:38,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50228/tests/kraken/driver.html?testName=imaging-desaturate) 16:52:39 INFO - 2015-11-12 16:52:39,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 282173440 16:52:39 INFO - 2015-11-12 16:52:39,501 DEBUG : BROWSER_OUTPUT: 16:52:42 INFO - 2015-11-12 16:52:42,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50228/tests/kraken/driver.html?testName=json-parse-financial) 16:52:43 INFO - 2015-11-12 16:52:43,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 282873856 16:52:43 INFO - 2015-11-12 16:52:43,508 DEBUG : BROWSER_OUTPUT: 16:52:45 INFO - 2015-11-12 16:52:45,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:45 INFO - 2015-11-12 16:52:45,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 322760704 16:52:45 INFO - 2015-11-12 16:52:45,887 DEBUG : BROWSER_OUTPUT: 16:52:48 INFO - 2015-11-12 16:52:48,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50228/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:48 INFO - 2015-11-12 16:52:48,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 323604480 16:52:48 INFO - 2015-11-12 16:52:48,653 DEBUG : BROWSER_OUTPUT: 16:52:51 INFO - 2015-11-12 16:52:51,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:51 INFO - 2015-11-12 16:52:51,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 322019328 16:52:51 INFO - 2015-11-12 16:52:51,769 DEBUG : BROWSER_OUTPUT: 16:52:54 INFO - 2015-11-12 16:52:54,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:55 INFO - 2015-11-12 16:52:55,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 323903488 16:52:55 INFO - 2015-11-12 16:52:55,521 DEBUG : BROWSER_OUTPUT: 16:52:58 INFO - 2015-11-12 16:52:58,735 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:59 INFO - 2015-11-12 16:52:59,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 317964288 16:52:59 INFO - 2015-11-12 16:52:59,332 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50228/tests/kraken/driver.html?testName=ai-astar) 16:53:01 INFO - 2015-11-12 16:53:01,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 382963712 16:53:01 INFO - 2015-11-12 16:53:01,629 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,629 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:53:01 INFO - 2015-11-12 16:53:01,629 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:53:01 INFO - 2015-11-12 16:53:01,629 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:53:01 INFO - 2015-11-12 16:53:01,629 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:53:01 INFO - 2015-11-12 16:53:01,630 DEBUG : BROWSER_OUTPUT: |0;ai-astar;131;142;135;142;140;139;126;139;141;125 16:53:01 INFO - 2015-11-12 16:53:01,630 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;198;166;196;207;165;205;194;164;209;164 16:53:01 INFO - 2015-11-12 16:53:01,632 DEBUG : BROWSER_OUTPUT: |2;audio-dft;200;207;206;206;205;197;207;206;207;207 16:53:01 INFO - 2015-11-12 16:53:01,632 DEBUG : BROWSER_OUTPUT: |3;audio-fft;93;97;107;157;85;88;89;90;145;86 16:53:01 INFO - 2015-11-12 16:53:01,632 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;120;125;175;115;115;116;162;113;114;162 16:53:01 INFO - 2015-11-12 16:53:01,632 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;156;149;156;155;149;148;148;141;149;148 16:53:01 INFO - 2015-11-12 16:53:01,632 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;162;163;162;162;163;168;154;162;162;162 16:53:01 INFO - 2015-11-12 16:53:01,632 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;120;121;130;120;130;119;125;137;125;124 16:53:01 INFO - 2015-11-12 16:53:01,632 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;72;72;75;75;76;75;78;75;76 16:53:01 INFO - 2015-11-12 16:53:01,633 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;82;87;89;88;88;89;88;89;89 16:53:01 INFO - 2015-11-12 16:53:01,633 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;104;109;110;110;109;109;108;109;122;117 16:53:01 INFO - 2015-11-12 16:53:01,633 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;172;162;160;164;172;177;169;165;165;169 16:53:01 INFO - 2015-11-12 16:53:01,633 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;183;200;202;203;202;186;200;191;201;200 16:53:01 INFO - 2015-11-12 16:53:01,634 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;87;87;92;92;93;92;91;91;92;91 16:53:01 INFO - 2015-11-12 16:53:01,634 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:53:01 INFO - 2015-11-12 16:53:01,634 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:53:01 INFO - 2015-11-12 16:53:01,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1031 16:53:01 INFO - 2015-11-12 16:53:01,634 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:53:01 INFO - 2015-11-12 16:53:01,634 DEBUG : BROWSER_OUTPUT: __startTimestamp1447375981628__endTimestamp 16:53:01 INFO - 2015-11-12 16:53:01,634 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,635 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:53:01 INFO - 2015-11-12 16:53:01,636 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:53:01 INFO - 2015-11-12 16:53:01,636 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,636 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:136.00 Median:139.50 stddev:6.48 (4.6%) stddev-sans-first:6.62 16:53:01 INFO - 2015-11-12 16:53:01,636 DEBUG : BROWSER_OUTPUT: Values: 131.0 142.0 135.0 142.0 140.0 139.0 126.0 139.0 141.0 125.0 16:53:01 INFO - 2015-11-12 16:53:01,637 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,637 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:186.80 Median:197.00 stddev:19.56 (9.9%) stddev-sans-first:20.32 16:53:01 INFO - 2015-11-12 16:53:01,637 DEBUG : BROWSER_OUTPUT: Values: 198.0 166.0 196.0 207.0 165.0 205.0 194.0 164.0 209.0 164.0 16:53:01 INFO - 2015-11-12 16:53:01,637 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,638 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:204.80 Median:206.50 stddev:3.46 (1.7%) stddev-sans-first:3.20 16:53:01 INFO - 2015-11-12 16:53:01,638 DEBUG : BROWSER_OUTPUT: Values: 200.0 207.0 206.0 206.0 205.0 197.0 207.0 206.0 207.0 207.0 16:53:01 INFO - 2015-11-12 16:53:01,638 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,638 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:103.70 Median:88.50 stddev:25.88 (29.2%) stddev-sans-first:27.16 16:53:01 INFO - 2015-11-12 16:53:01,639 DEBUG : BROWSER_OUTPUT: Values: 93.0 97.0 107.0 157.0 85.0 88.0 89.0 90.0 145.0 86.0 16:53:01 INFO - 2015-11-12 16:53:01,639 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,639 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:131.70 Median:122.50 stddev:24.40 (19.9%) stddev-sans-first:25.51 16:53:01 INFO - 2015-11-12 16:53:01,639 DEBUG : BROWSER_OUTPUT: Values: 120.0 125.0 175.0 115.0 115.0 116.0 162.0 113.0 114.0 162.0 16:53:01 INFO - 2015-11-12 16:53:01,639 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,639 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:149.90 Median:149.00 stddev:4.63 (3.1%) stddev-sans-first:4.35 16:53:01 INFO - 2015-11-12 16:53:01,640 DEBUG : BROWSER_OUTPUT: Values: 156.0 149.0 156.0 155.0 149.0 148.0 148.0 141.0 149.0 148.0 16:53:01 INFO - 2015-11-12 16:53:01,640 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,641 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:162.00 Median:162.00 stddev:3.37 (2.1%) stddev-sans-first:3.57 16:53:01 INFO - 2015-11-12 16:53:01,641 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 162.0 163.0 168.0 154.0 162.0 162.0 162.0 16:53:01 INFO - 2015-11-12 16:53:01,641 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,642 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.10 Median:125.00 stddev:5.74 (4.6%) stddev-sans-first:5.79 16:53:01 INFO - 2015-11-12 16:53:01,642 DEBUG : BROWSER_OUTPUT: Values: 120.0 121.0 130.0 120.0 130.0 119.0 125.0 137.0 125.0 124.0 16:53:01 INFO - 2015-11-12 16:53:01,642 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,642 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.20 Median:75.00 stddev:2.82 (3.8%) stddev-sans-first:1.90 16:53:01 INFO - 2015-11-12 16:53:01,642 DEBUG : BROWSER_OUTPUT: Values: 68.0 72.0 72.0 75.0 75.0 76.0 75.0 78.0 75.0 76.0 16:53:01 INFO - 2015-11-12 16:53:01,642 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,643 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:86.90 Median:88.50 stddev:3.21 (3.6%) stddev-sans-first:2.24 16:53:01 INFO - 2015-11-12 16:53:01,643 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 87.0 89.0 88.0 88.0 89.0 88.0 89.0 89.0 16:53:01 INFO - 2015-11-12 16:53:01,643 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,643 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:110.70 Median:109.50 stddev:5.08 (4.6%) stddev-sans-first:4.77 16:53:01 INFO - 2015-11-12 16:53:01,643 DEBUG : BROWSER_OUTPUT: Values: 104.0 109.0 110.0 110.0 109.0 109.0 108.0 109.0 122.0 117.0 16:53:01 INFO - 2015-11-12 16:53:01,643 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,643 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:167.50 Median:169.00 stddev:5.23 (3.1%) stddev-sans-first:5.29 16:53:01 INFO - 2015-11-12 16:53:01,644 DEBUG : BROWSER_OUTPUT: Values: 172.0 162.0 160.0 164.0 172.0 177.0 169.0 165.0 165.0 169.0 16:53:01 INFO - 2015-11-12 16:53:01,644 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,646 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.80 Median:200.50 stddev:7.32 (3.6%) stddev-sans-first:5.81 16:53:01 INFO - 2015-11-12 16:53:01,646 DEBUG : BROWSER_OUTPUT: Values: 183.0 200.0 202.0 203.0 202.0 186.0 200.0 191.0 201.0 200.0 16:53:01 INFO - 2015-11-12 16:53:01,646 DEBUG : BROWSER_OUTPUT: 16:53:01 INFO - 2015-11-12 16:53:01,646 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:90.80 Median:92.00 stddev:2.10 (2.3%) stddev-sans-first:1.72 16:53:01 INFO - 2015-11-12 16:53:01,646 DEBUG : BROWSER_OUTPUT: Values: 87.0 87.0 92.0 92.0 93.0 92.0 91.0 91.0 92.0 91.0 16:53:01 INFO - 2015-11-12 16:53:01,646 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:53:01 INFO - 2015-11-12 16:53:01,646 DEBUG : BROWSER_OUTPUT: 16:53:02 INFO - 2015-11-12 16:53:02,277 INFO : Browser exited with error code: 0 16:53:02 INFO - 2015-11-12 16:53:02,340 INFO : Completed test kraken (00:01:05) 16:53:02 INFO - 2015-11-12 16:53:02,340 INFO : Starting test v8_7 16:53:02 INFO - 2015-11-12 16:53:02,340 DEBUG : operating with platform_type : mac_ 16:53:02 INFO - 2015-11-12 16:53:02,340 INFO : Initialising browser for v8_7 test... 16:53:02 INFO - 2015-11-12 16:53:02,357 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/tmpukM9_J/profile http://localhost:50228/getInfo.html 16:53:05 INFO - 2015-11-12 16:53:05,018 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:53:05 INFO - 2015-11-12 16:53:05,018 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:53:05 INFO - 2015-11-12 16:53:05,018 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:53:05 INFO - 2015-11-12 16:53:05,019 DEBUG : BROWSER_OUTPUT: __metrics 16:53:05 INFO - 2015-11-12 16:53:05,039 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:53:05 INFO - 2015-11-12 16:53:05,869 INFO : Browser initialized. 16:53:05 INFO - 2015-11-12 16:53:05,870 INFO : Running cycle 1/1 for v8_7 test... 16:53:05 INFO - 2015-11-12 16:53:05,870 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/T/tmpukM9_J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:53:18 INFO - 2015-11-12 16:53:18,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 229797888 16:53:18 INFO - 2015-11-12 16:53:18,054 DEBUG : BROWSER_OUTPUT: 16:53:40 INFO - 2015-11-12 16:53:40,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50228/tests/v8_7/run.html (next: http://localhost:50228/tests/v8_7/run.html) 16:53:41 INFO - 2015-11-12 16:53:41,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 618717184 16:53:41 INFO - 2015-11-12 16:53:41,224 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,224 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:53:41 INFO - 2015-11-12 16:53:41,224 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:53:41 INFO - 2015-11-12 16:53:41,224 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:53:41 INFO - 2015-11-12 16:53:41,225 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:53:41 INFO - 2015-11-12 16:53:41,225 DEBUG : BROWSER_OUTPUT: |0;Richards;214.73051320592657 16:53:41 INFO - 2015-11-12 16:53:41,225 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;244.5585717779408 16:53:41 INFO - 2015-11-12 16:53:41,225 DEBUG : BROWSER_OUTPUT: |2;Encrypt;405.0222762251924 16:53:41 INFO - 2015-11-12 16:53:41,225 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7192.857142857143 16:53:41 INFO - 2015-11-12 16:53:41,226 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2414.4578313253014 16:53:41 INFO - 2015-11-12 16:53:41,226 DEBUG : BROWSER_OUTPUT: |5;Earley;1035.1966873706003 16:53:41 INFO - 2015-11-12 16:53:41,226 DEBUG : BROWSER_OUTPUT: |6;Boyer;16966.101694915254 16:53:41 INFO - 2015-11-12 16:53:41,226 DEBUG : BROWSER_OUTPUT: |7;RegExp;39333.333333333336 16:53:41 INFO - 2015-11-12 16:53:41,226 DEBUG : BROWSER_OUTPUT: |8;Splay;798.7220447284345 16:53:41 INFO - 2015-11-12 16:53:41,226 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7360.294117647059 16:53:41 INFO - 2015-11-12 16:53:41,227 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:53:41 INFO - 2015-11-12 16:53:41,227 DEBUG : BROWSER_OUTPUT: __startTimestamp1447376021222__endTimestamp 16:53:41 INFO - 2015-11-12 16:53:41,227 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,227 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:53:41 INFO - 2015-11-12 16:53:41,228 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:53:41 INFO - 2015-11-12 16:53:41,228 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,228 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:214.73 Median:214.73 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,228 DEBUG : BROWSER_OUTPUT: Values: 214.7 16:53:41 INFO - 2015-11-12 16:53:41,228 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,229 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:244.56 Median:244.56 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,229 DEBUG : BROWSER_OUTPUT: Values: 244.6 16:53:41 INFO - 2015-11-12 16:53:41,229 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,229 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:405.02 Median:405.02 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,229 DEBUG : BROWSER_OUTPUT: Values: 405.0 16:53:41 INFO - 2015-11-12 16:53:41,230 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,230 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7192.86 Median:7192.86 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,230 DEBUG : BROWSER_OUTPUT: Values: 7192.9 16:53:41 INFO - 2015-11-12 16:53:41,230 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,230 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2414.46 Median:2414.46 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,230 DEBUG : BROWSER_OUTPUT: Values: 2414.5 16:53:41 INFO - 2015-11-12 16:53:41,231 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,231 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1035.20 Median:1035.20 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,232 DEBUG : BROWSER_OUTPUT: Values: 1035.2 16:53:41 INFO - 2015-11-12 16:53:41,232 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,232 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16966.10 Median:16966.10 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,233 DEBUG : BROWSER_OUTPUT: Values: 16966.1 16:53:41 INFO - 2015-11-12 16:53:41,233 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,233 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:39333.33 Median:39333.33 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,233 DEBUG : BROWSER_OUTPUT: Values: 39333.3 16:53:41 INFO - 2015-11-12 16:53:41,233 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,233 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,234 DEBUG : BROWSER_OUTPUT: Values: 798.7 16:53:41 INFO - 2015-11-12 16:53:41,234 DEBUG : BROWSER_OUTPUT: 16:53:41 INFO - 2015-11-12 16:53:41,234 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7360.29 Median:7360.29 stddev:0.00 (0.0%) 16:53:41 INFO - 2015-11-12 16:53:41,234 DEBUG : BROWSER_OUTPUT: Values: 7360.3 16:53:41 INFO - 2015-11-12 16:53:41,234 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:53:41 INFO - 2015-11-12 16:53:41,234 DEBUG : BROWSER_OUTPUT: 16:53:42 INFO - 2015-11-12 16:53:42,111 INFO : Browser exited with error code: 0 16:53:42 INFO - 2015-11-12 16:53:42,137 INFO : Completed test v8_7 (00:00:39) 16:53:42 INFO - 2015-11-12 16:53:42,546 INFO : Completed test suite (00:20:23) 16:53:42 INFO - 2015-11-12 16:53:42,546 DEBUG : Working with test: dromaeo_css 16:53:42 INFO - 2015-11-12 16:53:42,547 DEBUG : Generating results file: dromaeo_css 16:53:42 INFO - 2015-11-12 16:53:42,548 DEBUG : Working with test: kraken 16:53:42 INFO - 2015-11-12 16:53:42,548 DEBUG : Generating results file: kraken 16:53:42 INFO - 2015-11-12 16:53:42,548 INFO : javascript benchmark 16:53:42 INFO - 2015-11-12 16:53:42,548 DEBUG : Working with test: v8_7 16:53:42 INFO - 2015-11-12 16:53:42,548 DEBUG : Generating results file: v8_7 16:53:42 INFO - 2015-11-12 16:53:42,548 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:53:42 INFO - 2015-11-12 16:53:42,610 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 16:53:42 INFO - 2015-11-12 16:53:42,610 DEBUG : process_Request line: dromaeo_css 5270.89 graph.html#tests=[[72,1,55]] 16:53:42 INFO - 2015-11-12 16:53:42,611 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:53:42 INFO - 2015-11-12 16:53:42,731 DEBUG : process_Request line: kraken 1926.90 graph.html#tests=[[232,1,55]] 16:53:42 INFO - 2015-11-12 16:53:42,731 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:53:42 INFO - 2015-11-12 16:53:42,768 DEBUG : process_Request line: v8_7 14539.96 graph.html#tests=[[230,1,55]] 16:53:42 INFO - 2015-11-12 16:53:42,769 INFO : javascript benchmark 16:53:42 INFO - 2015-11-12 16:53:42,771 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [260.2349093664626, 262.76088759229094, 264.38266647378373, 266.597437868818, 273.2948991601667, 11899.643010709671, 13580.049396542247, 13747.45010199592, 14077.436902523887, 14100.15399076055, 11152.442377881094, 11287.209895307331, 11751.236169648966, 11860.822087668692, 13820.930895345535, 4145.626893579577, 4228.090960443504, 4252.043290259698, 4267.935980960288, 4297.505786834523, 4192.214743653753, 4194.475690538683, 4256.212600668886, 4277.957220427803, 4279.48646162461, 3022.7430668393104, 3146.2606287522412, 3166.9841650791714, 4221.957780422203, 4479.507254202035, 4590.495045544987, 4593.242115051013, 4598.609118224955, 4623.491415944243, 4629.791659375336, 3749.2876353492748, 3841.116543195081, 3981.422693709425, 4002.0195052212102, 4004.5194576650697, 15994.920025399799, 16362.754558681629, 16627.916860415622, 16791.83208167915, 16804.159792010472, 1544.1815837606086, 1596.4731638559247, 1611.564877483073, 1745.6159644878107, 1895.8388536974373, 10233.181345492343, 10479.371237725762, 10481.895181048245, 10745.83881241782, 10775.191860610406, 1323.0672375974914, 1326.7511567892427, 1348.7976803479457, 1351.061012596246, 1365.8019587159906, 46510.5348946513, 47380.526194737955, 47465.050698986175, 47767.283490747664, 47862.28206576904, 7379.852402951911, 7389.076365454318, 7645.388368930472, 7720.227977202235, 7764.340031097307, 9440.858387124199, 9524.14282714559, 9552.235821134293, 9555.092266234697, 9563.139317461462, 6027.517798576191, 6035.034394496859, 6065.5450841187085, 6088.573799834057, 6092.939070609325, 6063.393660633989, 6090.086487026892, 6124.142620033199, 6150.846228844314, 6174.722137503823, 4539.160255352705, 4568.885777855514, 4570.245909424974, 4662.557057079572, 4673.883152921204, 1333.7265860498574, 1343.402186027228, 1364.536057740373, 1365.1058556645214, 1372.7872179812146, 274.82685907878306, 288.4202752467555, 691.1774987764544, 804.4087595617217, 853.50923219148, 7156.964215178891, 7885.921140788633, 8114.63484143215, 8162.795930101676, 8402.537860417613, 306.7362068620984, 326.25939118202024, 331.1159204922862, 343.46591050916066, 348.45118937673266, 3611.2235869287706, 4288.871333859989, 4396.692231543761, 4479.417675702203, 4522.841700540465, 417306.0, 424325.0, 425532.0, 455158.0, 457413.0, 54799.0, 55216.0, 55678.443215568135, 56372.43627563672, 57742.0, 354.54795136201034, 385.74926297906586, 400.71549200067693, 400.91781184857615, 401.7890607431122, 8329.29201017896, 8580.184882436159, 8593.226609605166, 8622.655093796178, 8688.435251708872, 15796.21018949025, 24227.757722423255, 24416.0, 25559.872200638878, 26347.73652263453, 36141.27717445689, 36394.63605363912, 36513.63486365102, 36687.816560918094, 36701.08247293839, 4696.332945863517, 4702.341672165968, 4717.103750287434, 4837.685550439211, 4840.007798401249, 8900.77748056278, 9057.230135438298, 9115.179633832988, 9150.483617005377, 9236.445813251226, 7740.496867703581, 7774.378049756119, 7942.6028698566, 7971.043474783063, 8003.119656837627, 7599.392048636207, 7716.807079823049, 7720.189380115232, 7775.416843736629, 7814.960925195338, 7771.22287771241, 7884.645190966535, 7966.442349035512, 8100.554469504234, 8128.309093726863, 4288.8284468620905, 4715.0805592909055, 4728.007118505015, 4737.692050016738, 4781.019890922283, 6368.172137622079, 6808.421284190899, 6875.1749790025515, 7588.8482230356185, 7812.0], "dojo.html": [2459.70483541975, 2496.7752902238794, 2499.1377974598768, 2526.6715327007487, 2536.239128261522, 4046.31212693842, 4168.937465938009, 4169.6455801256925, 4170.311898536738, 4230.36544518322, 4049.2711311963835, 4104.6921480888905, 4137.979310103446, 4157.127003329297, 4179.3313069908745, 3967.662748666367, 3968.0, 3969.6030396960364, 4000.819963101653, 4060.106776509178, 4009.659178969791, 4073.083556199861, 4075.502577126694, 4077.87766367008, 4129.710920235585, 3715.405535114382, 3820.522434695663, 3875.302445559798, 3881.359575670011, 3925.646691797723, 3956.0, 3983.581723918976, 3992.8203230854683, 3992.840286388541, 4029.234445455354, 3945.1123497213184, 3952.565217826037, 3990.521137463494, 3997.040710229524, 4038.51537815464, 4017.678585713136, 4059.8985025374304, 4148.875533733993, 4180.540140584533, 4181.540030596662, 4368.0, 4393.626541743955, 4399.098184872126, 4412.073464572443, 4436.223660859369, 4474.351219073249, 4486.663500237462, 4516.07420478801, 4539.546045395467, 4586.72479651222, 3964.8017599120217, 4057.472528571267, 4069.1861627674584, 4077.2049450356894, 4130.132672138824, 4578.381918441034, 4608.585227329557, 4614.976925115353, 4641.396618439581, 4692.577668009895, 4374.5625437456, 4381.518033016366, 4385.528749577351, 4393.604575588149, 4462.754548499864, 4225.091605304813, 4317.8272869084885, 4426.15902978433, 4431.135928493977, 4444.400005999213, 4411.360352748833, 4430.579094985971, 4446.510883802779, 4473.530279320689, 4492.0791237796175, 4476.776161191928, 4477.059817438309, 4478.932816007762, 4517.2094883395275, 4559.293309537027, 3297.9175520612175, 3379.864805407756, 3459.446488561868, 3461.463473161664, 3474.0793689672255, 3092.0, 3164.6360668522952, 3169.4770362889867, 3172.762042846796, 3189.3302406494895, 4189.874303770892, 4202.117555313418, 4209.431726716854, 4251.893702657459, 4259.190753756776, 4227.112306415625, 4354.978225108917, 4364.148990946735, 4485.708428952108, 4508.1659892919915, 4028.657564107025, 4091.5908409158847, 4110.0, 4144.984478802652, 4155.8753237402925, 3929.9214015719526, 3979.0450291930306, 4011.338129208706, 4015.4501891299237, 4071.5521292657786, 4430.889227769331, 4498.415206023196, 4505.098980204038, 4661.160991021648, 4664.906701866012, 4338.154059958278, 4418.558144185556, 4435.1351486459835, 4477.731336119843, 4516.593506584423, 4598.0, 4649.442066951988, 4653.650976176868, 4669.649776266861, 4719.315699223662, 4200.579942005775, 4309.547497512716, 4319.028218650778, 4413.293872980308, 4413.293872980308, 4413.117376524644, 4424.159409712273, 4428.424304840479, 4486.64106871456, 4535.002299494106, 4390.780460977002, 4394.714343567658, 4418.668599855088, 4436.844710435119, 4510.120526497301, 4025.8389664414267, 4347.152305300562, 4357.520672726061, 4446.3108218226225, 4460.966542750944, 4158.480189976253, 4252.532221455699, 4281.657467402538, 4311.267084595689, 4362.0, 4409.338599210144, 4427.911441771211, 4442.2892337225885, 4445.73325600465, 4484.977575112103, 4048.2915489789757, 4201.264778663783, 4243.42713733642, 4303.354496825501, 4315.827366905414], "mootools.html": [1031.0617338222219, 1341.4030756313439, 1367.2275164532039, 1406.3319923036559, 1418.2483283859551, 5444.455554444554, 5610.803621873235, 5613.775448982046, 5835.445632664901, 5852.707364631762, 5880.794172203974, 5997.700114994254, 6003.969980150104, 6005.6096353736975, 6013.368596297391, 1673.129972414344, 1680.8991460512348, 1688.4850120713177, 1696.4062578097692, 1698.4819630012842, 1701.6681747059329, 1710.598009467774, 1729.368780395153, 1734.0549400576654, 1753.1059159828515, 1672.0636443591627, 1691.1882296497688, 1699.9970017689561, 1702.0893821805337, 1702.6509565539097, 1654.9172541372943, 1681.7477378393216, 1681.840225178606, 1725.2581390002294, 1727.179589694885, 1710.1705672748708, 1722.3885520640117, 1723.0781531880384, 1728.1013872786082, 1739.5564131146602, 5425.13197888336, 5950.196723442366, 5980.790672326491, 5992.730327135246, 6006.159137720722, 3221.5650887130173, 3272.5091236314506, 3473.444248920186, 3549.0772399176144, 3556.324298383299, 2263.7283525976986, 2284.291869520454, 2305.13557415969, 2313.652952057188, 2323.97676023241, 705.8870580707113, 714.1144980224536, 714.1501613080418, 718.4719231364943, 737.0565675934812, 7993.0, 8018.558979256139, 8032.799180020546, 8061.153578874192, 8091.231333023354, 3088.2279430142466, 3198.696123868229, 3231.0, 3258.6904244096772, 3267.591551056118, 7113.822154446077, 7136.357727804522, 7145.464090193256, 7178.497505174588, 7184.9640751795905, 3688.4651725499652, 3726.5155529781496, 3730.6642402183934, 3731.1231860512758, 3731.869384571527, 3362.764606477572, 3386.813725245135, 3395.0, 3400.489926510994, 3407.148212946763, 2667.146513115823, 2671.4389978104814, 2671.9599206011926, 2683.409649877024, 2700.7164247753703, 846.0777752250077, 874.8600223964263, 880.3529405886668, 882.8808110904946, 886.9201771840566, 1015.3197357770312, 1025.8820235672845, 1042.593388578455, 1045.3780000899453, 1052.6263176572359, 5630.662160270397, 5668.914966275509, 5685.715714214272, 5727.713614319267, 5746.367899531048, 306.7975136409959, 307.7830129758515, 308.4386416721545, 942.9057094290516, 992.6376872441507, 4456.420665313553, 4542.568455996675, 4542.5911667949385, 4544.772761361919, 4571.81712731487, 5772.826815195551, 6759.493038022168, 7223.097112860893, 7225.205227424979, 7248.963755181296, 7041.260667629927, 7080.645967701595, 7099.89350159748, 7159.212486626467, 7200.135983681992, 5415.187721841677, 5577.6932268724795, 5720.11338242573, 5732.570057245724, 5786.768529258867, 5601.383847776823, 5651.943480565142, 5675.659460432387, 5710.914336284876, 5762.020456522485, 6164.079158281586, 6206.162168107247, 6240.28236752761, 6350.333215012357, 6421.5825971311715, 6098.664573448503, 6519.282878883224, 6556.409923106943, 6583.835404114744, 6659.600423974577, 5341.465853414627, 5486.561075113901, 5498.340199176125, 5532.059549876451, 5545.805896793593, 5645.633033852787, 5707.286589176353, 5722.313322401338, 5737.540996720169, 5759.740811663569, 5406.513413792777, 5466.262054622575, 5524.91712624319, 5560.0, 5619.157126431068, 5313.468653134811, 5388.892222155457, 5447.509724124848, 5447.891042179055, 5500.7524661391135, 5508.807191748269, 5513.917291240715, 5531.308586426697, 5592.049351610317, 5593.105103183471, 4986.900261994667, 5093.8471845843205, 5094.898102038012, 5103.3110530077965, 5107.029664363759, 5040.823571174991, 5144.717040562805, 5168.01807656544, 5176.922346164735, 5196.68819870809], "ext.html": [447.5569186505361, 450.47744616245154, 460.8410098516012, 464.57723471640816, 480.0926249388658, 23148.76851231489, 24438.14466493673, 31308.217294567618, 31753.84123079387, 31876.20309492264, 33422.66577334226, 34039.319213615774, 34054.48918266228, 34325.656743432555, 34348.1412964676, 6546.672666366662, 7239.963800180992, 7400.222976587462, 7466.925330746704, 7488.887666685004, 6591.736330546796, 6687.431568316674, 8797.472151670889, 8976.147266009719, 9090.090990900922, 8726.607302671364, 8799.912000879973, 8865.867011994826, 8901.421407608517, 8912.064233255513, 6734.292899245557, 6881.65591720417, 8655.134486551358, 8799.340049496313, 8859.06979767128, 6552.410283074499, 8712.607932643046, 8979.14698103679, 9050.411723238034, 9055.366124371296, 31499.370012599848, 31504.212394690087, 31614.525782113287, 31693.52459713106, 31945.84027079873, 2241.1035585765826, 2250.3586477853733, 2403.5072810074066, 2429.5748244057218, 2768.0, 21505.354839354688, 21768.238111666014, 22366.2171823987, 22478.0, 23020.194293199656, 1886.415211284506, 1895.573495963411, 1901.6672082385528, 1924.3072493902184, 2000.3398878370103, 207465.0, 207798.0, 207846.0, 209541.0, 210326.0, 44603.0, 46197.53802461999, 46441.0, 46855.0, 46855.0, 39576.80211598924, 54702.45297547053, 54996.45003549993, 55625.0, 55948.16077758837, 12983.805242921364, 13122.60632181036, 13209.40557674907, 13248.40382182804, 13259.801102983463, 10019.849702254473, 10127.949360253298, 10137.898621013843, 10258.692239232834, 10275.897241027644, 15077.396904123932, 15497.922510387376, 15527.689446211012, 15534.45629402988, 15618.84381156174, 5972.970135149383, 6327.3988971047675, 6398.424141827165, 6424.421802037839, 6460.483161347081, 727.8435136445584, 734.2107234722588, 779.3570304498811, 852.1776485691214, 874.3922973533461, 22283.4401591887, 22528.21151259698, 22792.886035569714, 22886.900920400767, 23193.188238411913, 770.5222761887666, 812.6424373275858, 854.5043874552745, 925.8102089071724, 962.7015625156224, 11545.307281563133, 11722.238054526599, 11846.466908989116, 11875.762484750257, 11925.1652384334, 257415.0, 259207.0, 260421.0, 263436.0, 264681.0, 42154.15227248844, 42288.365674514906, 42385.152296953886, 42575.57424425778, 43128.137437251076, 1070.1599244593112, 1074.08166018055, 1083.2363183955292, 1091.5088210305394, 1110.439228189759, 22192.334229973127, 22458.213962511232, 22474.438139046655, 22508.0, 22528.211512597634, 34506.82746586251, 35542.822285888404, 38234.80882595569, 38518.2296354077, 38664.42003370008, 215133.0, 218980.0, 222502.0, 227178.0, 227808.0, 23780.762192377853, 23809.166679166145, 23851.403714907265, 23861.522769544164, 24043.278701638978, 24529.386765331008, 26852.865735671196, 27859.721402786523, 29772.702272976992, 31424.0, 24648.630270546313, 26855.0, 27035.459290814466, 28020.859895700392, 28237.43525129527, 26607.20178394651, 26936.191914242605, 27259.727402726512, 27896.860515698103, 28097.87608495719, 25681.743182567934, 26309.0, 26411.339716507242, 26610.733892660824, 26670.333241669112, 21704.565908681423, 23934.0, 24262.085305687793, 24861.0, 25199.49601007933, 17868.0, 18830.52923676919, 18890.0, 18900.621987560447, 19256.903715481334], "prototype.html": [238.92354446577096, 240.9554232466995, 243.79521202190168, 248.83452504084784, 254.09162244974223, 4894.314795928568, 4948.455669876311, 4950.851474455768, 4958.256261560768, 5005.374328208974, 4674.7428891410955, 4939.554920314449, 4943.975280123604, 4952.380952380952, 4966.155753521901, 3799.1262009737775, 3800.4869342638804, 3805.353089974711, 3808.0479880029993, 3824.8087595620245, 3783.0, 3785.697144228469, 3802.2775672622115, 3810.637989391017, 3816.2939856126704, 3531.8940431787087, 3595.262971090933, 3627.220147668251, 3660.8718694845684, 3753.6246375362516, 3728.5525736911472, 3735.8132093395493, 3738.383166777465, 3777.8111094445444, 3797.886063418102, 3180.236743181643, 3180.6024246969127, 3182.7931184472936, 3183.6657150999044, 3186.7928584641922, 4651.720896746206, 4705.694129881581, 4715.221988371914, 4769.356136921506, 4769.427668679746, 4177.6866734995, 4180.874573762792, 4184.727992680497, 4227.682923780729, 4228.640565551932, 5179.067767801795, 5186.247994040843, 5186.870328241824, 5196.948030519722, 5217.634765566412, 3408.931821363584, 3421.4183588789715, 3439.466882633196, 3445.0, 3449.913752156191, 5184.585233181337, 5316.149416093445, 5346.572274218053, 5457.345118585716, 5461.918071228934, 3452.5684289463816, 3457.2048428861503, 3459.100633835221, 3460.826958652108, 3474.0793689672255, 3513.595936467339, 3523.136831476305, 3549.4498352755363, 3559.60844307126, 3562.76842005274, 4135.0902801383645, 4159.417681524589, 4167.5207351155, 4177.624013838708, 4179.435776170239, 5002.399712034507, 5148.536631703165, 5158.0199762045095, 5201.0, 5202.557782588447, 1232.6363722701824, 1257.7610254051701, 1257.8553466351486, 1262.7600755856358, 1265.5697062998624, 761.1589193940727, 773.6402572803673, 774.7946794099568, 788.1842293226483, 801.0387534958073, 4931.13705101613, 4940.2342636891335, 4968.527989840959, 4972.204447288416, 4993.151164302078, 5354.196870469461, 5367.1680889462195, 5385.5960802939935, 5411.161270003156, 5450.100733379028, 4826.131296366688, 4892.3884514435695, 4926.187179115477, 4960.181570040902, 4964.542551437062, 2810.536261516827, 2873.741363277273, 2911.1121108062243, 2919.1534455008236, 2924.005838015085, 5564.582656300794, 5610.410906854803, 5659.660420374791, 5661.547076233974, 5695.658260504383, 5294.655847369909, 5415.593830462731, 5434.755436005389, 5590.692511911884, 5613.410591887875, 5449.727513624303, 5569.275994120739, 5603.019471592455, 5617.859553511195, 5621.690807005572, 5431.4840090191365, 5446.809361672323, 5468.56251499887, 5472.50747432733, 5491.148871924858, 5305.65513241638, 5316.760745766527, 5334.146536554133, 5352.973235133955, 5355.30381050461, 5452.427495112956, 5591.8881622368135, 5595.832125036255, 5606.607537472338, 5630.88738225225, 3516.5604299462566, 3535.9292814144087, 3548.449990251515, 3554.804485753205, 3565.893023209308, 5435.483629055233, 5451.127819548853, 5464.480874316933, 5468.9179662304305, 5480.150576660624, 5080.745962701924, 5256.4480729524375, 5282.498162674539, 5290.629655924048, 5333.013392522395, 5209.661372010807, 5220.243064755665, 5228.660137091077, 5247.921281180709, 5271.920921186109, 5171.276021357088, 5172.069027575073, 5172.379314482287, 5173.741312934263, 5181.481851814789, 5292.338457692788, 5316.415194328543, 5328.57371410294, 5345.4654534546235, 5364.839054828361, 4989.351384320015, 5161.509656582619, 5186.818461353834, 5193.454687257784, 5199.090159222196], "yui.html": [537.1110811606787, 584.5820238529451, 595.9659989917494, 598.9101634754786, 603.2218438214703, 10343.0, 10641.627543035995, 10678.252522323432, 10694.893051069486, 10698.946505267462, 8606.483610983345, 9579.856302155456, 10033.899661003388, 10091.495425228728, 10262.0, 696.6238231355075, 703.806453225362, 704.6441547018749, 710.4777988178685, 716.3123401534507, 647.6308504152635, 687.8142901416614, 699.2413231643673, 702.6697452197459, 706.9893951590731, 729.9270072992684, 741.8256709673223, 748.7267147491181, 755.7430473638962, 756.4855897989365, 726.1685370251085, 730.9232530584292, 738.4609235258291, 740.0601236429704, 740.1192580828797, 546.7730891679948, 548.5227851768987, 549.2228496677197, 554.6810583914265, 554.9982281981023, 9432.717018489457, 9514.952425237829, 9534.0, 9586.808263834753, 9596.280278979035, 7636.198199189116, 7769.689212431496, 8061.4760040597175, 8223.42436029478, 8350.08149103598, 6910.2744211858035, 6991.126109236346, 6997.615131167784, 7015.754448594325, 7144.642767861586, 2545.6308835218974, 2565.2834935397395, 2589.37854914821, 2656.481986012728, 2737.671479422462, 28799.71200287991, 28861.134165975054, 28865.56701649477, 32802.0, 33460.49809252863, 5360.115580929181, 5431.918521222185, 5493.835184944458, 5662.915056274159, 5691.808653668368, 9263.25893928484, 9324.0, 9379.343445958717, 9412.15290623847, 9459.763505912408, 4760.238361862154, 4786.16242157621, 4824.614030877521, 4840.951590484121, 4881.8535443936735, 2760.4479104179245, 2844.687084420712, 2905.5205891027745, 2965.525515917443, 3052.877884884624, 2079.8856062916684, 2163.8701677899376, 2218.123841082763, 2223.899924503401, 2230.9107635694713, 361.5480649188514, 364.6371859999318, 368.60743308376493, 369.5306960160581, 381.3231514062506, 449.58638052991324, 452.19960669614596, 455.71973236459337, 469.1719115760685, 499.03934925268715, 5756.740946657411, 6091.360407157274, 6124.732729852323, 6171.6297022178815, 6280.183576135073, 367.9006668199571, 404.68030256097353, 423.5936690188544, 442.2415557319213, 494.9059678661115, 2938.4270067337093, 3024.0927721683406, 3033.7572994160855, 3045.497492913689, 3080.4147212029643, 44749.32876006862, 46700.29949550759, 46721.53278467172, 46868.0, 46936.53063469322, 40436.393454098215, 41116.38325425121, 41250.38124428136, 41345.1730965379, 41559.168816623496, 31568.833330031244, 37890.43164352537, 38526.42210366847, 39372.2125557493, 40232.0, 6440.32376600469, 6583.96708016476, 6638.302978187414, 6676.799696008933, 6684.264730879697, 23070.76929230686, 25146.62280065764, 26034.34914127162, 27978.720212797612, 28536.85731571329, 28319.0, 29089.272768180967, 34430.48354274738, 35141.82429087838, 36215.637843621225, 6000.849978750566, 6039.607425517327, 6159.168512250968, 6196.504279657526, 6335.714892829926, 8764.956175219084, 8942.418742781698, 8951.194392504705, 9049.59276832531, 9193.816123677623, 8190.959045204974, 8259.132791056853, 8473.0, 8548.871766923625, 8575.3997220194, 8212.63043163071, 8301.543415111984, 8553.315734741082, 8568.35737319691, 8683.739487815375, 8198.508089514648, 8345.374096942633, 8386.580670966305, 8410.663573456994, 8426.073131955358, 7173.10336207974, 7208.135023796968, 7290.817729556804, 7310.159331676925, 7416.25837416254, 6965.0, 7302.233265507258, 7334.486585938933, 7380.815479613053, 7565.167831538416]}, "summary": {"lowerIsBetter": false, "suite": 5270.887177969953, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5877.776335628103, "unit": "ms", "value": 5877.776335628103}, "dojo.html": {"lowerIsBetter": false, "filtered": 4141.231466213173, "unit": "ms", "value": 4141.231466213173}, "mootools.html": {"lowerIsBetter": false, "filtered": 3411.3106740391336, "unit": "ms", "value": 3411.3106740391336}, "ext.html": {"lowerIsBetter": false, "filtered": 14589.545108654236, "unit": "ms", "value": 14589.545108654236}, "prototype.html": {"lowerIsBetter": false, "filtered": 3871.6320490261655, "unit": "ms", "value": 3871.6320490261655}, "yui.html": {"lowerIsBetter": false, "filtered": 4571.450647352117, "unit": "ms", "value": 4571.450647352117}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0082"}, "testrun": {"date": 1447374798, "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": "20151112151340", "branch": "Firefox", "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f"}}, {"talos_counters": {}, "results": {"audio-dft": [200.0, 207.0, 206.0, 206.0, 205.0, 197.0, 207.0, 206.0, 207.0, 207.0], "ai-astar": [131.0, 142.0, 135.0, 142.0, 140.0, 139.0, 126.0, 139.0, 141.0, 125.0], "imaging-gaussian-blur": [156.0, 149.0, 156.0, 155.0, 149.0, 148.0, 148.0, 141.0, 149.0, 148.0], "audio-beat-detection": [198.0, 166.0, 196.0, 207.0, 165.0, 205.0, 194.0, 164.0, 209.0, 164.0], "json-stringify-tinderbox": [80.0, 82.0, 87.0, 89.0, 88.0, 88.0, 89.0, 88.0, 89.0, 89.0], "stanford-crypto-pbkdf2": [183.0, 200.0, 202.0, 203.0, 202.0, 186.0, 200.0, 191.0, 201.0, 200.0], "json-parse-financial": [68.0, 72.0, 72.0, 75.0, 75.0, 76.0, 75.0, 78.0, 75.0, 76.0], "stanford-crypto-sha256-iterative": [87.0, 87.0, 92.0, 92.0, 93.0, 92.0, 91.0, 91.0, 92.0, 91.0], "audio-fft": [93.0, 97.0, 107.0, 157.0, 85.0, 88.0, 89.0, 90.0, 145.0, 86.0], "imaging-darkroom": [162.0, 163.0, 162.0, 162.0, 163.0, 168.0, 154.0, 162.0, 162.0, 162.0], "stanford-crypto-ccm": [172.0, 162.0, 160.0, 164.0, 172.0, 177.0, 169.0, 165.0, 165.0, 169.0], "audio-oscillator": [120.0, 125.0, 175.0, 115.0, 115.0, 116.0, 162.0, 113.0, 114.0, 162.0], "stanford-crypto-aes": [104.0, 109.0, 110.0, 110.0, 109.0, 109.0, 108.0, 109.0, 122.0, 117.0], "imaging-desaturate": [120.0, 121.0, 130.0, 120.0, 130.0, 119.0, 125.0, 137.0, 125.0, 124.0]}, "summary": {"lowerIsBetter": true, "suite": 1926.9, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 103.7, "unit": "ms", "value": 103.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 196.8, "unit": "ms", "value": 196.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 186.8, "unit": "ms", "value": 186.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 167.5, "unit": "ms", "value": 167.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 162.0, "unit": "ms", "value": 162.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 74.2, "unit": "ms", "value": 74.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 131.7, "unit": "ms", "value": 131.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 136.0, "unit": "ms", "value": 136.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 204.8, "unit": "ms", "value": 204.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 90.8, "unit": "ms", "value": 90.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 86.9, "unit": "ms", "value": 86.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 149.9, "unit": "ms", "value": 149.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 110.7, "unit": "ms", "value": 110.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 125.1, "unit": "ms", "value": 125.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0082"}, "testrun": {"date": 1447374798, "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": "20151112151340", "branch": "Firefox", "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [244.5585717779408], "Encrypt": [405.0222762251924], "NavierStokes": [7360.294117647059], "Decrypt": [7192.857142857143], "Splay": [798.7220447284345], "Richards": [214.73051320592657], "RegExp": [39333.333333333336], "Earley": [1035.1966873706003], "Boyer": [16966.101694915254], "RayTrace": [2414.4578313253014]}, "summary": {"lowerIsBetter": false, "suite": 14539.957411080979, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 270.3565020000001, "unit": "score", "value": 270.3565020000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 657.2008889999998, "unit": "score", "value": 657.2008889999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 201.62237762237774, "unit": "score", "value": 201.62237762237774}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.00629592850049, "unit": "score", "value": 37.00629592850049}, "Splay": {"lowerIsBetter": false, "filtered": 102.02673199999995, "unit": "score", "value": 102.02673199999995}, "RegExp": {"lowerIsBetter": false, "filtered": 23.16063559322033, "unit": "score", "value": 23.16063559322033}, "Richards": {"lowerIsBetter": false, "filtered": 164.40141399999996, "unit": "score", "value": 164.40141399999996}, "Earley": {"lowerIsBetter": false, "filtered": 643.8032579999998, "unit": "score", "value": 643.8032579999998}, "Boyer": {"lowerIsBetter": false, "filtered": 39.282034965034974, "unit": "score", "value": 39.282034965034974}, "RayTrace": {"lowerIsBetter": false, "filtered": 306.4824700598802, "unit": "score", "value": 306.4824700598802}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0082"}, "testrun": {"date": 1447374798, "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": "20151112151340", "branch": "Firefox", "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f"}}] 16:53:42 INFO - RETURN: dromaeo_css: 5270.89 16:53:42 INFO - RETURN: kraken: 1926.90 16:53:42 INFO - RETURN: v8_7: 14539.96 16:53:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "14539.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1926.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5270.89"}}} 16:53:42 INFO - Return code: 0 16:53:42 INFO - # TBPL SUCCESS # 16:53:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:53:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:53:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:53:42 INFO - 2015-11-12 16:53:42.884 screenresolution[2229:17524] starting screenresolution argv=screenresolution get 16:53:42 INFO - 2015-11-12 16:53:42.888 screenresolution[2229:17524] Display 0: 1600x1200x32@60 16:53:42 INFO - 2015-11-12 16:53:42.895 screenresolution[2230:17527] starting screenresolution argv=screenresolution list 16:53:42 INFO - Available Modes on Display 0 16:53:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:53:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:53:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:53:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:53:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:53:43 INFO - Intel HD Graphics 3000: 16:53:43 INFO - Chipset Model: Intel HD Graphics 3000 16:53:43 INFO - Type: GPU 16:53:43 INFO - Bus: Built-In 16:53:43 INFO - VRAM (Total): 512 MB 16:53:43 INFO - VRAM (Dynamic, Max): 10 16:53:43 INFO - Vendor: Intel (0x8086) 16:53:43 INFO - Device ID: 0x0116 16:53:43 INFO - Revision ID: 0x0009 16:53:43 INFO - Displays: 16:53:43 INFO - Display: 16:53:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:53:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:53:43 INFO - Display Serial Number: 1600x1200 60 16:53:43 INFO - Main Display: Yes 16:53:43 INFO - Mirror: Off 16:53:43 INFO - Online: Yes 16:53:43 INFO - Rotation: Supported 16:53:43 INFO - Return code: 0 16:53:43 INFO - Running post-action listener: _resource_record_post_action 16:53:43 INFO - Running post-run listener: _resource_record_post_run 16:53:44 INFO - Total resource usage - Wall time: 1270s; CPU: 30.0%; Read bytes: 2551808; Write bytes: 687401984; Read time: 949; Write time: 99236 16:53:44 INFO - install - Wall time: 45s; CPU: 30.0%; Read bytes: 334455296; Write bytes: 334833664; Read time: 38471; Write time: 7454 16:53:44 INFO - run-tests - Wall time: 1225s; CPU: 30.0%; Read bytes: 2547712; Write bytes: 342201344; Read time: 933; Write time: 90814 16:53:44 INFO - Running post-run listener: _upload_blobber_files 16:53:44 INFO - Blob upload gear active. 16:53:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:53:44 INFO - Copying logs to upload dir... 16:53:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1337.995487 ========= master_lag: 3.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-12 16:53:47.696331) ========= ========= Started set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-12 16:53:47.705668) ========= 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.7UeluwetHM/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.R2LbzzgVTk/Listeners TMPDIR=/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 2.10 ========= ========= Finished set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-12 16:53:49.813578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 19 secs) (at 2015-11-12 16:53:49.813998) ========= 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.7UeluwetHM/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.R2LbzzgVTk/Listeners TMPDIR=/var/folders/58/d7k_38t159vddkvmcmgk1vx000000w/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.005796 ========= master_lag: 19.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 19 secs) (at 2015-11-12 16:54:09.174146) ========= ========= Started reboot skipped (results: 3, elapsed: 25 secs) (at 2015-11-12 16:54:09.174472) ========= ========= Finished reboot skipped (results: 3, elapsed: 25 secs) (at 2015-11-12 16:54:34.815861) ========= ========= Total master_lag: 24.97 =========