builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0010 starttime: 1447374684.76 results: success (0) buildid: 20151112151340 builduid: 1be7cd81ed6541ca873eca115d0ef3cc revision: 285852de5cd54891d8f3b1ddbff179e4c9c7ca5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.759557) ========= 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:24.760099) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.760484) ========= 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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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.006215 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.786159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.786521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.831374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.831785) ========= 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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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.005505 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.888080) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.888440) ========= 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:24.888868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:24.889182) ========= 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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25, :: Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-11-12 16:31:25 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.420412 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.328951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.329289) ========= 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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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.019922 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:25.378557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-12 16:31:25.378959) ========= 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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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,454 truncating revision to first 12 chars 2015-11-12 16:31:25,454 Setting DEBUG logging. 2015-11-12 16:31:25,454 attempt 1/10 2015-11-12 16:31:25,454 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,504 unpacking tar archive at: mozilla-central-285852de5cd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.314976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-12 16:31:26.711974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:26.712347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:26.727800) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 16:31:26.728120) ========= 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.728572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2015-11-12 16:31:26.728919) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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-e10s --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-e10s', 16:31:26 INFO - 'system_bits': '64', 16:31:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:26 INFO - 'title': 't-yosemite-r5-0010', 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:29 INFO - Running post-action listener: _resource_record_post_action 16:31:29 INFO - ##### 16:31:29 INFO - ##### Running read-buildbot-config step. 16:31:29 INFO - ##### 16:31:29 INFO - Running pre-action listener: _resource_record_pre_action 16:31:29 INFO - Running main action method: read_buildbot_config 16:31:29 INFO - Using buildbot properties: 16:31:29 INFO - { 16:31:29 INFO - "properties": { 16:31:29 INFO - "buildnumber": 11, 16:31:29 INFO - "product": "firefox", 16:31:29 INFO - "script_repo_revision": "production", 16:31:29 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 16:31:29 INFO - "repository": "", 16:31:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 16:31:29 INFO - "buildid": "20151112151340", 16:31:29 INFO - "slavename": "t-yosemite-r5-0010", 16:31:29 INFO - "pgo_build": "False", 16:31:29 INFO - "basedir": "/builds/slave/test", 16:31:29 INFO - "project": "", 16:31:29 INFO - "platform": "yosemite", 16:31:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:31:29 INFO - "slavebuilddir": "test", 16:31:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:31:29 INFO - "branch": "mozilla-central", 16:31:29 INFO - "repo_path": "mozilla-central", 16:31:29 INFO - "stage_platform": "macosx64", 16:31:29 INFO - "builduid": "1be7cd81ed6541ca873eca115d0ef3cc", 16:31:29 INFO - "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f" 16:31:29 INFO - }, 16:31:29 INFO - "sourcestamp": { 16:31:29 INFO - "repository": "", 16:31:29 INFO - "hasPatch": false, 16:31:29 INFO - "project": "", 16:31:29 INFO - "branch": "mozilla-central-macosx64-talos", 16:31:29 INFO - "changes": [ 16:31:29 INFO - { 16:31:29 INFO - "category": null, 16:31:29 INFO - "files": [ 16:31:29 INFO - { 16:31:29 INFO - "url": null, 16:31:29 INFO - "name": "https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:31:29 INFO - } 16:31:29 INFO - ], 16:31:29 INFO - "repository": "", 16:31:29 INFO - "rev": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f", 16:31:29 INFO - "who": "kwierso@gmail.com", 16:31:29 INFO - "when": 1447374680, 16:31:29 INFO - "number": 6655420, 16:31:29 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:29 INFO - "project": "", 16:31:29 INFO - "at": "Thu 12 Nov 2015 16:31:20", 16:31:29 INFO - "branch": "mozilla-central-macosx64-talos", 16:31:29 INFO - "revlink": "", 16:31:29 INFO - "properties": [ 16:31:29 INFO - [ 16:31:29 INFO - "buildid", 16:31:29 INFO - "20151112151340", 16:31:29 INFO - "Change" 16:31:29 INFO - ], 16:31:29 INFO - [ 16:31:29 INFO - "builduid", 16:31:29 INFO - "1be7cd81ed6541ca873eca115d0ef3cc", 16:31:29 INFO - "Change" 16:31:29 INFO - ], 16:31:29 INFO - [ 16:31:29 INFO - "pgo_build", 16:31:29 INFO - "False", 16:31:29 INFO - "Change" 16:31:29 INFO - ] 16:31:29 INFO - ], 16:31:29 INFO - "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f" 16:31:29 INFO - } 16:31:29 INFO - ], 16:31:29 INFO - "revision": "285852de5cd54891d8f3b1ddbff179e4c9c7ca5f" 16:31:29 INFO - } 16:31:29 INFO - } 16:31:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:31:29 INFO - Running post-action listener: _resource_record_post_action 16:31:29 INFO - ##### 16:31:29 INFO - ##### Running download-and-extract step. 16:31:29 INFO - ##### 16:31:29 INFO - Running pre-action listener: _resource_record_pre_action 16:31:29 INFO - Running main action method: download_and_extract 16:31:29 INFO - mkdir: /builds/slave/test/build/tests 16:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:29 INFO - https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:31:29 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:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/test_packages.json 16:31:29 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:29 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:29 INFO - Downloaded 1149 bytes. 16:31:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:31:29 INFO - Using the following test package requirements: 16:31:29 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:29 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:29 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:31:29 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:29 INFO - u'jsshell-mac.zip'], 16:31:29 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:29 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:31:29 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:29 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:29 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:31:29 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:29 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:31:29 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:29 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:31:29 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:29 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:29 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:31:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:29 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:29 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:29 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:29 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:29 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:30 INFO - Downloaded 17459743 bytes. 16:31:30 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:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:30 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:35 INFO - Return code: 0 16:31:35 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:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:35 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:35 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:35 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:35 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:35 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:37 INFO - Downloaded 17459743 bytes. 16:31:37 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:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:37 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:43 INFO - Return code: 0 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:43 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:43 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:43 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:43 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:43 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:45 INFO - Downloaded 11131693 bytes. 16:31:45 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:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:31:45 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:46 INFO - Return code: 0 16:31:46 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:46 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:46 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:46 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:46 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:46 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:50 INFO - Downloaded 108714702 bytes. 16:31:50 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:50 INFO - mkdir: /builds/slave/test/properties 16:31:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:50 INFO - Contents: 16:31:50 INFO - build_url:https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:50 INFO - Running post-action listener: _resource_record_post_action 16:31:50 INFO - Running post-action listener: set_extra_try_arguments 16:31:50 INFO - ##### 16:31:50 INFO - ##### Running populate-webroot step. 16:31:50 INFO - ##### 16:31:50 INFO - Running pre-action listener: _resource_record_pre_action 16:31:50 INFO - Running main action method: populate_webroot 16:31:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:31:50 INFO - '../fennec_ids.txt'], 16:31:50 INFO - 'tests': ['tcheck2']}, 16:31:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:50 INFO - '--tppagecycles', 16:31:50 INFO - '7'], 16:31:50 INFO - 'tests': ['tsvgm']}}, 16:31:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:31:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:31:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:31:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:50 INFO - 'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:50 INFO - 'tests': ['damp', 'tps']}, 16:31:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:50 INFO - 'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['damp', 'tps']}, 16:31:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:31:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:50 INFO - 'other': {'tests': ['a11yr', 16:31:50 INFO - 'ts_paint', 16:31:50 INFO - 'tpaint', 16:31:50 INFO - 'sessionrestore', 16:31:50 INFO - 'sessionrestore_no_auto_restore']}, 16:31:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['a11yr', 16:31:50 INFO - 'ts_paint', 16:31:50 INFO - 'tpaint', 16:31:50 INFO - 'sessionrestore', 16:31:50 INFO - 'sessionrestore_no_auto_restore']}, 16:31:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['a11yr', 16:31:50 INFO - 'ts_paint', 16:31:50 INFO - 'tpaint', 16:31:50 INFO - 'sessionrestore', 16:31:50 INFO - 'sessionrestore_no_auto_restore']}, 16:31:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['a11yr', 16:31:50 INFO - 'ts_paint', 16:31:50 INFO - 'tpaint', 16:31:50 INFO - 'sessionrestore', 16:31:50 INFO - 'sessionrestore_no_auto_restore']}, 16:31:50 INFO - 'other_l64': {'tests': ['a11yr', 16:31:50 INFO - 'ts_paint', 16:31:50 INFO - 'tpaint', 16:31:50 INFO - 'sessionrestore', 16:31:50 INFO - 'sessionrestore_no_auto_restore']}, 16:31:50 INFO - 'other_nol64': {'tests': ['a11yr', 16:31:50 INFO - 'ts_paint', 16:31:50 INFO - 'tpaint', 16:31:50 INFO - 'sessionrestore', 16:31:50 INFO - 'sessionrestore_no_auto_restore']}, 16:31:50 INFO - 'svgr': {'tests': ['tsvgx', 16:31:50 INFO - 'tsvgr_opacity', 16:31:50 INFO - 'tart', 16:31:50 INFO - 'tscrollx', 16:31:50 INFO - 'cart']}, 16:31:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['tsvgx', 16:31:50 INFO - 'tsvgr_opacity', 16:31:50 INFO - 'tart', 16:31:50 INFO - 'tscrollx', 16:31:50 INFO - 'cart']}, 16:31:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:50 INFO - 'tests': ['tp5o']}, 16:31:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:50 INFO - 'talos_options': ['--e10s'], 16:31:50 INFO - 'tests': ['tp5o']}, 16:31:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:50 INFO - 'talos_options': ['--xperf_path', 16:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:50 INFO - 'tests': ['tp5n']}, 16:31:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:50 INFO - 'talos_options': ['--e10s', 16:31:50 INFO - '--xperf_path', 16:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:50 INFO - 'tests': ['tp5n']}}, 16:31:50 INFO - 'talos.zip': {'path': '', 16:31:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:50 INFO - Running post-action listener: _resource_record_post_action 16:31:50 INFO - ##### 16:31:50 INFO - ##### Running create-virtualenv step. 16:31:50 INFO - ##### 16:31:50 INFO - Running pre-action listener: _resource_record_pre_action 16:31:50 INFO - Running main action method: create_virtualenv 16:31:50 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:50 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:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:50 INFO - Using real prefix '/tools/python27' 16:31:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:55 INFO - Installing pip.................done. 16:31:55 INFO - Return code: 0 16:31:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10d187490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d164228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b953df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0aa9f0>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09e8c8>, '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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:31:55 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:31:55 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:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQQG2KzkAC/Render', 16:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:55 INFO - 'HOME': '/Users/cltbld', 16:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:55 INFO - 'LOGNAME': 'cltbld', 16:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:55 INFO - 'MOZ_NO_REMOTE': '1', 16:31:55 INFO - 'NO_EM_RESTART': '1', 16:31:55 INFO - 'PAGER': '/bin/cat', 16:31:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:55 INFO - 'PWD': '/builds/slave/test', 16:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:55 INFO - 'SHELL': '/bin/bash', 16:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ia5gMGr6Vd/Listeners', 16:31:55 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 16:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:55 INFO - 'USER': 'cltbld', 16:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:55 INFO - 'XPC_FLAGS': '0x0', 16:31:55 INFO - 'XPC_SERVICE_NAME': '0', 16:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:55 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:31:55 INFO - Cleaning up... 16:31:55 INFO - Return code: 0 16:31:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10d187490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d164228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b953df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0aa9f0>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09e8c8>, '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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:31:55 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:31:55 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:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQQG2KzkAC/Render', 16:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:55 INFO - 'HOME': '/Users/cltbld', 16:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:55 INFO - 'LOGNAME': 'cltbld', 16:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:55 INFO - 'MOZ_NO_REMOTE': '1', 16:31:55 INFO - 'NO_EM_RESTART': '1', 16:31:55 INFO - 'PAGER': '/bin/cat', 16:31:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:55 INFO - 'PWD': '/builds/slave/test', 16:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:55 INFO - 'SHELL': '/bin/bash', 16:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ia5gMGr6Vd/Listeners', 16:31:55 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 16:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:55 INFO - 'USER': 'cltbld', 16:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:55 INFO - 'XPC_FLAGS': '0x0', 16:31:55 INFO - 'XPC_SERVICE_NAME': '0', 16:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:56 INFO - Downloading/unpacking psutil>=0.7.1 16:31:56 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:31:56 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:31:56 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:31:56 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:31:56 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:31:56 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:31:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:31:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:58 INFO - Installing collected packages: psutil 16:31:58 INFO - Running setup.py install for psutil 16:31:58 INFO - building 'psutil._psutil_osx' extension 16:31:58 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:31:59 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:31:59 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:31:59 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:31:59 INFO - building 'psutil._psutil_posix' extension 16:31:59 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:31:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:31:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:31:59 INFO - ^ 16:31:59 INFO - 1 warning generated. 16:31:59 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:31:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:59 INFO - Successfully installed psutil 16:31:59 INFO - Cleaning up... 16:31:59 INFO - Return code: 0 16:31:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:31:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:59 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 0x10d187490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d164228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b953df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0aa9f0>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09e8c8>, '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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:31:59 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:31:59 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:31:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQQG2KzkAC/Render', 16:31:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:59 INFO - 'HOME': '/Users/cltbld', 16:31:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:59 INFO - 'LOGNAME': 'cltbld', 16:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:59 INFO - 'MOZ_NO_REMOTE': '1', 16:31:59 INFO - 'NO_EM_RESTART': '1', 16:31:59 INFO - 'PAGER': '/bin/cat', 16:31:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:59 INFO - 'PWD': '/builds/slave/test', 16:31:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:59 INFO - 'SHELL': '/bin/bash', 16:31:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ia5gMGr6Vd/Listeners', 16:31:59 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 16:31:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:59 INFO - 'USER': 'cltbld', 16:31:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:59 INFO - 'XPC_FLAGS': '0x0', 16:31:59 INFO - 'XPC_SERVICE_NAME': '0', 16:31:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:32:00 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:00 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:00 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:00 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:00 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:00 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:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:32:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:02 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:02 INFO - Installing collected packages: mozsystemmonitor 16:32:02 INFO - Running setup.py install for mozsystemmonitor 16:32:02 INFO - Successfully installed mozsystemmonitor 16:32:02 INFO - Cleaning up... 16:32:02 INFO - Return code: 0 16:32:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:02 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:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:02 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:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:02 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 0x10d187490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d164228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b953df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0aa9f0>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09e8c8>, '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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:02 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:02 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:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQQG2KzkAC/Render', 16:32:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:02 INFO - 'HOME': '/Users/cltbld', 16:32:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:02 INFO - 'LOGNAME': 'cltbld', 16:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:02 INFO - 'MOZ_NO_REMOTE': '1', 16:32:02 INFO - 'NO_EM_RESTART': '1', 16:32:02 INFO - 'PAGER': '/bin/cat', 16:32:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:02 INFO - 'PWD': '/builds/slave/test', 16:32:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:02 INFO - 'SHELL': '/bin/bash', 16:32:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ia5gMGr6Vd/Listeners', 16:32:02 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 16:32:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:02 INFO - 'USER': 'cltbld', 16:32:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:02 INFO - 'XPC_FLAGS': '0x0', 16:32:02 INFO - 'XPC_SERVICE_NAME': '0', 16:32:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:03 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:03 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:03 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:03 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:03 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:03 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:03 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 - Downloading blobuploader-1.2.4.tar.gz 16:32:05 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:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:06 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32:06 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:06 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:06 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:06 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:06 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:06 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:06 INFO - Downloading docopt-0.6.1.tar.gz 16:32:06 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:06 INFO - Running setup.py install for blobuploader 16:32:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:07 INFO - Running setup.py install for requests 16:32:07 INFO - Running setup.py install for docopt 16:32:07 INFO - Successfully installed blobuploader requests docopt 16:32:07 INFO - Cleaning up... 16:32:07 INFO - Return code: 0 16:32:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:07 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 0x10d187490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d164228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b953df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0aa9f0>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09e8c8>, '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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:07 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:07 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:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQQG2KzkAC/Render', 16:32:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:07 INFO - 'HOME': '/Users/cltbld', 16:32:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:07 INFO - 'LOGNAME': 'cltbld', 16:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:07 INFO - 'MOZ_NO_REMOTE': '1', 16:32:07 INFO - 'NO_EM_RESTART': '1', 16:32:07 INFO - 'PAGER': '/bin/cat', 16:32:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:07 INFO - 'PWD': '/builds/slave/test', 16:32:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:07 INFO - 'SHELL': '/bin/bash', 16:32:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ia5gMGr6Vd/Listeners', 16:32:07 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 16:32:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:07 INFO - 'USER': 'cltbld', 16:32:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:07 INFO - 'XPC_FLAGS': '0x0', 16:32:07 INFO - 'XPC_SERVICE_NAME': '0', 16:32:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:08 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-JtU4X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:08 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-jRnrJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:08 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-NaMNPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:08 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-zUOuf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:08 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-cx16Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:08 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-ZLLJGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:08 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-JrchNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:08 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-6JmGDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-gNS8HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-nUZJGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-0N4muE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-ORtbvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-mdHKV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-OLfvQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-bA6VZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-9_TeDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-AizzrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:10 INFO - Running setup.py install for manifestparser 16:32:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:10 INFO - Running setup.py install for mozcrash 16:32:10 INFO - Running setup.py install for mozdebug 16:32:10 INFO - Running setup.py install for mozdevice 16:32:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:32:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:10 INFO - Running setup.py install for mozfile 16:32:11 INFO - Running setup.py install for mozhttpd 16:32:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:11 INFO - Running setup.py install for mozinfo 16:32:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:11 INFO - Running setup.py install for mozInstall 16:32:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:11 INFO - Running setup.py install for mozleak 16:32:11 INFO - Running setup.py install for mozlog 16:32:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:11 INFO - Running setup.py install for moznetwork 16:32:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:12 INFO - Running setup.py install for mozprocess 16:32:12 INFO - Running setup.py install for mozprofile 16:32:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:12 INFO - Running setup.py install for mozrunner 16:32:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:12 INFO - Running setup.py install for mozscreenshot 16:32:12 INFO - Running setup.py install for moztest 16:32:12 INFO - Running setup.py install for mozversion 16:32:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:13 INFO - Cleaning up... 16:32:13 INFO - Return code: 0 16:32:13 INFO - Installing None 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', '-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 0x10d187490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d164228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b953df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0aa9f0>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09e8c8>, '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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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', '-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:13 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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners', 16:32:13 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:13 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-bCP1oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:13 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-_a1goK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:13 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-T9y1Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:13 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-9GaO1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:13 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-QWkSWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:14 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-QBNSCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:14 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-o8L9XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:14 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-Ma0jZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:14 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-FTJNXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:14 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-nYgheX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:14 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-Ezu2ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:14 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-txw2xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:14 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-s9RlsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:15 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-geSy2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:15 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-SG1WnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:15 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-ETTZ6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:15 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-h44DBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:15 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:15 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:15 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:15 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:15 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:15 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:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:17 INFO - Downloading blessings-1.5.1.tar.gz 16:32:17 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:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:18 INFO - Installing collected packages: blessings 16:32:18 INFO - Running setup.py install for blessings 16:32:18 INFO - Successfully installed blessings 16:32:18 INFO - Cleaning up... 16:32:18 INFO - Return code: 0 16:32:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:18 INFO - Reading from file tmpfile_stdout 16:32:18 INFO - Current package versions: 16:32:18 INFO - blessings == 1.5.1 16:32:18 INFO - blobuploader == 1.2.4 16:32:18 INFO - docopt == 0.6.1 16:32:18 INFO - manifestparser == 1.1 16:32:18 INFO - mozInstall == 1.12 16:32:18 INFO - mozcrash == 0.16 16:32:18 INFO - mozdebug == 0.1 16:32:18 INFO - mozdevice == 0.47 16:32:18 INFO - mozfile == 1.2 16:32:18 INFO - mozhttpd == 0.7 16:32:18 INFO - mozinfo == 0.9 16:32:18 INFO - mozleak == 0.1 16:32:18 INFO - mozlog == 3.0 16:32:18 INFO - moznetwork == 0.27 16:32:18 INFO - mozprocess == 0.22 16:32:18 INFO - mozprofile == 0.27 16:32:18 INFO - mozrunner == 6.11 16:32:18 INFO - mozscreenshot == 0.1 16:32:18 INFO - mozsystemmonitor == 0.0 16:32:18 INFO - moztest == 0.7 16:32:18 INFO - mozversion == 1.4 16:32:18 INFO - psutil == 3.1.1 16:32:18 INFO - requests == 1.2.3 16:32:18 INFO - wsgiref == 0.1.2 16:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32: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:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:18 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 0x10d187490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d164228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b953df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0aa9f0>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09e8c8>, '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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:18 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:18 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:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQQG2KzkAC/Render', 16:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:18 INFO - 'HOME': '/Users/cltbld', 16:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:18 INFO - 'LOGNAME': 'cltbld', 16:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:18 INFO - 'MOZ_NO_REMOTE': '1', 16:32:18 INFO - 'NO_EM_RESTART': '1', 16:32:18 INFO - 'PAGER': '/bin/cat', 16:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:18 INFO - 'PWD': '/builds/slave/test', 16:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:18 INFO - 'SHELL': '/bin/bash', 16:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ia5gMGr6Vd/Listeners', 16:32:18 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 16:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:18 INFO - 'USER': 'cltbld', 16:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:18 INFO - 'XPC_FLAGS': '0x0', 16:32:18 INFO - 'XPC_SERVICE_NAME': '0', 16:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:18 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:18 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:18 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:18 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:18 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:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Cleaning up... 16:32:18 INFO - Return code: 0 16:32:18 INFO - Running post-action listener: _resource_record_post_action 16:32:18 INFO - Running post-action listener: _start_resource_monitoring 16:32:19 INFO - Starting resource monitoring. 16:32:19 INFO - ##### 16:32:19 INFO - ##### Running install step. 16:32:19 INFO - ##### 16:32:19 INFO - Running pre-action listener: _resource_record_pre_action 16:32:19 INFO - Running main action method: install 16:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:19 INFO - Reading from file tmpfile_stdout 16:32:19 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:19 INFO - Reading from file tmpfile_stdout 16:32:19 INFO - Output received: 16:32:19 INFO - Usage: mozinstall [options] installer 16:32:19 INFO - Options: 16:32:19 INFO - -h, --help show this help message and exit 16:32:19 INFO - -d DEST, --destination=DEST 16:32:19 INFO - Directory to install application into. [default: 16:32:19 INFO - "/builds/slave/test"] 16:32:19 INFO - --app=APP Application being installed. [default: firefox] 16:32:19 INFO - mkdir: /builds/slave/test/build/application 16:32:19 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:19 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:32:57 INFO - Reading from file tmpfile_stdout 16:32:57 INFO - Output received: 16:32:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:32:57 INFO - Running post-action listener: _resource_record_post_action 16:32:57 INFO - ##### 16:32:57 INFO - ##### Running run-tests step. 16:32:57 INFO - ##### 16:32:57 INFO - Running pre-action listener: _resource_record_pre_action 16:32:57 INFO - Running main action method: run_tests 16:32:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:32:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:32:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:32:57 INFO - 2015-11-12 16:32:57.177 screenresolution[2266:21685] starting screenresolution argv=screenresolution get 16:32:57 INFO - 2015-11-12 16:32:57.181 screenresolution[2266:21685] Display 0: 1600x1200x32@60 16:32:57 INFO - 2015-11-12 16:32:57.187 screenresolution[2267:21687] starting screenresolution argv=screenresolution list 16:32:57 INFO - Available Modes on Display 0 16:32:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:32:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:32:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:32:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:32:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:32:57 INFO - Intel HD Graphics 3000: 16:32:57 INFO - Chipset Model: Intel HD Graphics 3000 16:32:57 INFO - Type: GPU 16:32:57 INFO - Bus: Built-In 16:32:57 INFO - VRAM (Total): 512 MB 16:32:57 INFO - VRAM (Dynamic, Max): 10 16:32:57 INFO - Vendor: Intel (0x8086) 16:32:57 INFO - Device ID: 0x0116 16:32:57 INFO - Revision ID: 0x0009 16:32:57 INFO - Displays: 16:32:57 INFO - Display: 16:32:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:32:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:32:57 INFO - Display Serial Number: 1600x1200 60 16:32:57 INFO - Main Display: Yes 16:32:57 INFO - Mirror: Off 16:32:57 INFO - Online: Yes 16:32:57 INFO - Rotation: Supported 16:32:57 INFO - Return code: 0 16:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:57 INFO - Python 2.7.3 16:32:57 INFO - Return code: 0 16:32:57 INFO - grabbing minidump binary from tooltool 16:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:57 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 0x10d0aa9f0>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09e8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:57 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:32:57 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:32:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:57 INFO - Return code: 0 16:32:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:32:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:32:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:57 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-e10s', '--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-0010', '--webServer', 'localhost'] in /builds/slave/test/build 16:32:57 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-e10s --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-0010 --webServer localhost 16:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kQQG2KzkAC/Render', 16:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:57 INFO - 'HOME': '/Users/cltbld', 16:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:57 INFO - 'LOGNAME': 'cltbld', 16:32:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:57 INFO - 'MOZ_NO_REMOTE': '1', 16:32:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:57 INFO - 'NO_EM_RESTART': '1', 16:32:57 INFO - 'PAGER': '/bin/cat', 16:32:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:57 INFO - 'PWD': '/builds/slave/test', 16:32:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:57 INFO - 'SHELL': '/bin/bash', 16:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ia5gMGr6Vd/Listeners', 16:32:57 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 16:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:57 INFO - 'USER': 'cltbld', 16:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:57 INFO - 'XPC_FLAGS': '0x0', 16:32:57 INFO - 'XPC_SERVICE_NAME': '0', 16:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:32:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--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-0010', '--webServer', 'localhost'] with output_timeout 3600 16:32:57 INFO - mozversion INFO | application_buildid: 20151112151340 16:32:57 INFO - mozversion INFO | application_changeset: 285852de5cd54891d8f3b1ddbff179e4c9c7ca5f 16:32:57 INFO - mozversion INFO | application_display_name: Nightly 16:32:57 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:57 INFO - mozversion INFO | application_name: Firefox 16:32:57 INFO - mozversion INFO | application_remotingname: firefox 16:32:57 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 16:32:57 INFO - mozversion INFO | application_vendor: Mozilla 16:32:57 INFO - mozversion INFO | application_version: 45.0a1 16:32:57 INFO - mozversion INFO | platform_buildid: 20151112151340 16:32:57 INFO - mozversion INFO | platform_changeset: 285852de5cd54891d8f3b1ddbff179e4c9c7ca5f 16:32:57 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 16:32:57 INFO - mozversion INFO | platform_version: 45.0a1 16:32:57 INFO - 2015-11-12 16:32:57,804 DEBUG : using testdate: 1447374777 16:32:57 INFO - 2015-11-12 16:32:57,804 DEBUG : actual date: 1447374777 16:32:57 INFO - 2015-11-12 16:32:57,882 INFO : starting webserver on 'localhost:51678' 16:32:57 INFO - 2015-11-12 16:32:57,884 INFO : Starting test suite t-yosemite-r5-0010.e 16:32:57 INFO - 2015-11-12 16:32:57,884 INFO : Starting test dromaeo_css 16:32:57 INFO - 2015-11-12 16:32:57,884 DEBUG : operating with platform_type : mac_ 16:32:57 INFO - 2015-11-12 16:32:57,885 INFO : Initialising browser for dromaeo_css test... 16:32:57 INFO - 2015-11-12 16:32:57,912 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmp8W365q/profile http://localhost:51678/getInfo.html 16:33:01 INFO - 2015-11-12 16:33:01,444 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:33:01 INFO - 2015-11-12 16:33:01,444 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:33:01 INFO - 2015-11-12 16:33:01,444 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:33:01 INFO - 2015-11-12 16:33:01,444 DEBUG : BROWSER_OUTPUT: __metrics 16:33:02 INFO - 2015-11-12 16:33:02,109 INFO : Browser initialized. 16:33:02 INFO - 2015-11-12 16:33:02,109 INFO : Running cycle 1/1 for dromaeo_css test... 16:33:02 INFO - 2015-11-12 16:33:02,109 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmp8W365q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:33:14 INFO - 2015-11-12 16:33:14,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 240865280 16:33:14 INFO - 2015-11-12 16:33:14,204 DEBUG : BROWSER_OUTPUT: 16:34:03 INFO - 2015-11-12 16:34:03,931 DEBUG : BROWSER_OUTPUT: 1447374843930 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:14 INFO - 2015-11-12 16:36:14,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51678/tests/dromaeo/cssquery-ext.html) 16:36:15 INFO - 2015-11-12 16:36:15,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 264003584 16:36:15 INFO - 2015-11-12 16:36:15,408 DEBUG : BROWSER_OUTPUT: 16:39:17 INFO - 2015-11-12 16:39:17,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/dromaeo/cssquery-ext.html (next: http://localhost:51678/tests/dromaeo/cssquery-jquery.html) 16:39:18 INFO - 2015-11-12 16:39:18,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 270942208 16:39:18 INFO - 2015-11-12 16:39:18,051 DEBUG : BROWSER_OUTPUT: 16:42:19 INFO - 2015-11-12 16:42:19,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51678/tests/dromaeo/cssquery-mootools.html) 16:42:20 INFO - 2015-11-12 16:42:20,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 272998400 16:42:20 INFO - 2015-11-12 16:42:20,309 DEBUG : BROWSER_OUTPUT: 16:45:21 INFO - 2015-11-12 16:45:21,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51678/tests/dromaeo/cssquery-prototype.html) 16:45:22 INFO - 2015-11-12 16:45:22,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 278220800 16:45:22 INFO - 2015-11-12 16:45:22,575 DEBUG : BROWSER_OUTPUT: 16:48:25 INFO - 2015-11-12 16:48:25,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51678/tests/dromaeo/cssquery-yui.html) 16:48:25 INFO - 2015-11-12 16:48:25,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 283246592 16:48:25 INFO - 2015-11-12 16:48:25,680 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/dromaeo/cssquery-yui.html (next: http://localhost:51678/tests/dromaeo/cssquery-dojo.html) 16:51:28 INFO - 2015-11-12 16:51:28,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 287993856 16:51:28 INFO - 2015-11-12 16:51:28,255 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,255 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:51:28 INFO - 2015-11-12 16:51:28,256 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:51:28 INFO - 2015-11-12 16:51:28,256 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:51:28 INFO - 2015-11-12 16:51:28,257 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:51:28 INFO - 2015-11-12 16:51:28,258 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2980.4486170058526;3074.4465996120703;3148.748100151988;3172.7461803055758;3285.507173923912;4904.362432883725;4960.131976904041;4969.8012079516775;5017.2474128880685;5053.974730126349;4865.513448655132;4885.291632713254;4905.730184839832;4948.331975183349;5184.585233181346;4585.564371384713;4656.790444430008;4660.813567457298;4698.342232087511;4791.448983366922;756.1275723769475;4652.511486293941;4675.719456832601;4698.530146985308;4744.97627511862;4631.907361852778;4664.790084446208;4674.509176536466;4756.976215118937;4811.759412029384;4701.858944231679;4716.551927566876;4724.929126063077;4753;4760.1907675694865;4578.51925547816;4594.356790049395;4658.394408726844;4696.624270058387;4821.855344339676;4685.367475390813;4836.51634836517;4964.404271487445;5012;5038.773255203525;5178.948210517884;5290.523852853224;5292.338457692788;5295.31160949078;5299.231611416323;5117.181250999822;5356.54469370104;5404.32445944257;5490.835274941758;5557.888842223133;5030.622703297194;5032.4967503249745;5035.597152227813;5051.797928082872;5091.745412729349;5373.301470808769;5568.832935011957;5587.469190426903;5597.468240517144;5604;5115.335006449138;5177.767000484987;5219.947800521946;5248.711320877388;5259.368875734936;5473.28847249855;5491.450854914557;5494.230807686927;5513.09034009384;5579.163125531203;4933.950660493421;5086.796528138907;5385.623006389594;5401.918971215435;5408.675479471244;5297.231901374279;5332.9733351333;5371.597130215171;5374;5416.10634245353;4167.708260421741;4200.957990420118;4204;4206.20082184384;4242.44848169736;3721.5906250312446;3752.962470375261;3824.827882745283;3879.262940041383;3882.320593896057;5046.041252162077;5077.238414237894;5080.542751152414;5083.8983220335385;5093.796248150033;5458.563314934796;5462.453754624506;5482.643628164236;5490.6431081979545;5524.779008839601;4873.26900964851;4976.925346119811;5024.346834911438;5053.938672878663;5106.4893510648635;4779.02030083832;4803.471618122004;4836.806527738851;4839.612830973514;4879.926801097987;5598.412166722517;5622.128570071563;5637.520810731134;5640.097584386561;5640.210370548045;5285.656432331886;5404.108322126962;5404.378496472798;5462.562994960314;5505.724713764215;5585.245991791056;5588.441155884379;5613.1860880171325;5623.493885550321;5636.126400407943;5126.282320475211;5341.75962081715;5413.10683737179;5442.809501667422;5450.781968721207;5397.649152805055;5422.728863556727;5450.1007333789485;5451.509364157245;5478.890422191614;5339.199120132012;5349.652272602269;5384.353877534721;5403.243545903498;5463.699496527729;5041.1430056889685;5141.691498510101;5205.5835533158015;5340.065488539568;5361;5069.467705890828;5134.922976155435;5137.8972420550635;5153.6907785532985;5189.558887494454;5150.793968241228;5447.373552041566;5456.0451920914475;5482.753276102505;5488.231647569263;4990.80036798524;5128.948710512847;5130.384353877409;5235.450277720937;5299.44355842631 16:51:28 INFO - 2015-11-12 16:51:28,261 DEBUG : BROWSER_OUTPUT: |1;ext.html;520.8046982381609;546.3362015151591;551.253052114385;552.5689961829775;559.7229371461127;33931.321373572515;34526;34675;34763.30473390531;34968.82515587425;40023.199536009335;40098.7995060025;40195.99999999993;40551.39172912409;40756.592434075654;8766.51784151873;8873.733787986339;8942.86585701215;8948.194662480375;9004.909950900505;8670.263027642657;8784.38509304349;8828.602712877935;8837.160469755396;8916.420432671855;8741.519216443094;8813.823723525526;8838.33712471564;8898.110188981114;8900.065493123226;8772.605232764508;8842.911570884273;8869.600867960926;8943.686970956018;8989.640414383417;8571.828563428759;8717.607707653171;8731.781705457352;8747.737567872973;8895.866562001574;36164.276714465566;36642.81678591617;36754;36907.26185476276;36999.260014799554;2329.394357467054;2535.0508581078325;2595.9870200648875;2853.657561092682;3339.964610970607;25260.49479010428;25441.236762897144;25866.094686685876;26644.33389165267;26721;2309.988450057756;2318.420394901275;2346.1905642553293;2364.491634298634;2492.090387008747;227070;231177.9999999983;231279;231429;232384;51618;52090;59524.70237648784;60191.09713354303;60991.69504152451;54588;55108.724456378266;55526;55691.44308556862;55731.721341393844;14972.625684357978;15161.469348572748;15169.620759481102;15204.543863684106;15206.16366099853;11475.139364547525;11509.424528773696;11519.48162332697;11715.4142292885;11793;17928.372506962194;17945.371911983017;18005.459836204936;18005.639887202182;18266.908665456587;8162;8463.449875758057;8473.915260847436;8476.576171191417;8502.532360720219;899.1997122560927;933.6172169410509;976.8046390721884;1107.734143805481;1120.3166068698088;24156.51686966286;25531;25711;25911.611325830127;26163.215103546925;963.1572374172599;969.7575606098476;997.3195166145068;1000.4197565412044;1003.8042581696645;13518.459261629621;13520.12119212248;13540.901160320167;13549.932250338685;13675.24786136772;295984;300966;306430;306438;306464;50327;51457;51470.485295147315;51495.48504514982;52191.73904130455;1338.1770211319968;1346.1721041559567;1352.8444228913604;1362.5231169090937;1365.7473367427058;25070.74929250757;25541.3614659635;25661.871690641427;25866.741332587186;25891;43213;43474.34788478112;43570.78214608907;43608;43645.781771090944;271629;273894.9357785341;275019;275982;276134;28944;28998.275043123245;29675.109746707632;29868.551971720877;30086.849565752033;35578.644213557534;36036.639633604376;36073.45889811603;36207;36548.81725591355;30678.84660576772;31200.531992019685;32507.512387314684;33379.666203338624;33396.49905251375;30849.0745277642;30895.69104309018;30922.85647705109;31011.224719382197;31351.21621959469;32322.191945201557;32689.836550817094;32856.178595534344;33282.33435331231;33772.15569610681;27221.59167612527;29340;29369.412611748074;29377.412451751272;29679.703202967696;22166.778332216472;22403.21588744386;22595.5480890378;22613.773862261165;22622.886885565465 16:51:28 INFO - 2015-11-12 16:51:28,262 DEBUG : BROWSER_OUTPUT: |2;jquery.html;317.32726619566523;321.6397634649193;321.91308346746376;324.8424514110657;337.239524871415;10943.56225750971;11335.489902954367;17286.13569321535;17477.475675729733;18008.819911800878;11114.49984750686;11237.887621123786;11331.546738130486;11369.204155709083;11500.942495287532;4077.2864748669012;4103.281925663012;4236.97881510592;4241.172971270604;4288.099499105192;4207.957920420788;4248.723832950848;4385.693001489897;4513.796879140446;4524.728516289017;4288.892777680568;4457.509673935864;4459.308807134883;4483.4843992940905;4496.415465989433;4416.668749843775;4417.22698527758;4423.137488189805;4434.113177364524;4481.641468682497;3735.794531300777;3768.491253680773;3864.053306939818;3882.592327805568;3900.395438707005;10713.196510261761;11412.972832445119;11891;11901.523939042429;11945.940270298679;1722.4918648998575;1761.8854774439749;1818.1727314072198;1818.5908170661496;1919.0596607662285;8953.149450802164;9129.589168487433;9170.358074934757;9403.388779729295;9420.528973551294;1425.5937057938438;1440.4886265375746;1492.7163838870688;1523.7104950059454;1538.261634415487;56275.71862140663;57669;57719.42280577183;58592.414075859124;59101;6026.9095963560585;6187.969060154761;6219.284782250009;6257.124002639634;6274.560780745395;7072;7077.681504332214;7090.936359546109;7121.857562848714;7151.213366529678;5182.041322355376;5190.870228244324;5208.921866172011;5213.383851006124;5225.973870130625;5168.328117344721;5200.92198617021;5241.292425522582;5435.945640543623;5531.668099914018;2741.6984131745494;2770.5290100682932;2782.220978126128;2800.0619792369785;2817.225263052677;982.6020461713018;988.8269552828226;991.6628346362127;996.9651062212788;1043.5982146873357;380.6250842919777;381.0131758744809;387.44014898471437;408.9100397912454;419.7963987466077;9270.629174833066;9872.802543949081;10015.799684006279;10130.341527800669;10164.949175254076;386.75827607745157;387.986420475282;389.3789405897645;394.52656811825926;408.07367276282673;5384.380796208487;5491.780328786884;5513.779448822002;5525.640833345819;5542.584306177053;513837;533499;535823;539483;578614;66650.66674666596;67011.3298867005;67034.32965670379;67545.66227168833;67623;410.23286454330594;410.8911138548287;411.6871177904754;412.10573056467535;412.579169247366;9255.305852061258;9273.67542136022;9414.340996130206;9430.387024843363;9435.433873967584;29826.85086574553;31017.689823102384;31209.531857022615;31234.062978110695;31545.36909261848;42997.785011074746;43010.13979720451;43392;43846.34230486481;44094.77952610217;5600.747966341443;5819.214406055128;5824.534037276923;5829.280362293219;5894.852628684317;10976.067034302174;11159.832602511131;11168.329900206014;11190.608328708782;11295;9143.908560914306;9276;9415.105564971316;9503.19222866064;9608.087231712976;9184.49485278316;9240.168384845396;9496.097870702271;9529.857052144085;9565.952170239105;9483.525823708926;9776.608935642495;9794.902050979399;9943.403395796275;10000.549975250986;5676.68778217202;5808.7095645218415;5950.3454619992635;5976.342602313829;6004.0693692477735;9557.235421166151;9607.711768646952;9663.565139568596;9708.5145742714;9775.75560610962 16:51:28 INFO - 2015-11-12 16:51:28,265 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1431.2056808471293;1660.2528862012093;1688.8311168883113;1706.18103310411;1715.8112607613168;6294.874102517947;6679.499037572177;6760;7183.604901730403;7271.527350722199;7023.1572211334715;7202.96398518008;7313.963430182842;7412.444066694992;7417.962910185455;1981.1382048808778;2006.8193862552369;2016.1632922337212;2031.6546187148147;2042.4995876010398;2057.0640358636783;2078.2206672497814;2115.090511080235;2145.787629989059;2176.6299729046023;2061.8556701030934;2077.698733683615;2086.7182930304366;2092.257248676721;2118.3221369161874;2041.7958204179538;2055.9280425185198;2060.1347434077647;2070.4306315763133;2096.4025252802953;2013.7684166320767;2046.1303945822965;2051.292304155079;2059.155746144074;2066.3284432559326;7305.488615796897;7314.561126332437;7327.9267207327775;7387.150477695081;7420.072490938633;4302.720323178984;4374.846880359204;4399.230134726442;4454.086912182995;4463.910721785579;2744.108164846433;2808.1294798612494;2869.727375899286;2876.8417737024456;2878.251654569806;878.8725634782985;883.8276536075468;887.7736177274818;897.878786363839;917.3074328881652;9541.952290238505;9690.854637180448;9702.320837541374;9746.610135594568;9774.413535187841;3679;3707.8146092695256;3811.123441608446;3814.5803961564206;3825.9043523912123;7869.48848324857;7881.211878812188;7883.921160788434;7896.960515197387;7985.281324680806;4380.102079073782;4387.188370151533;4424.889377765581;4428.180786554498;4431.202383570988;4045.4336392905016;4077.1234184650443;4094.2220978014084;4107.815148318333;4137.40007698882;3035.8937437189593;3069.7237248647284;3073.615798025247;3085.5217441296636;3119.766017548693;886.7605746448423;890.4345740454858;891.9509426981449;895.4761464543185;900.6307413960376;1232.2914324263584;1242.7079636285466;1256.133268045046;1263.9368031598383;1266.9556565520347;6921.446284297244;6949.965250173818;6964.651767411609;7003.92996070043;7024.01663767073;393.586733929373;403.8828739665464;405.6106138107391;407.1531215072642;409.68249606554565;5390.757415916293;5469.972650136803;5501.642393244426;5502.119660854244;5518.91721624176;7904.20957904205;8024;8508.532030738244;8525.488470691655;8618.741437756877;8576.356773241907;8584.613692383859;8604.268637165786;8641.567921603895;8647.956760216159;6651.567648102858;6680.766173183915;6761.932380676229;6879.89680154788;6906.827329316707;6692.631905245258;6693.732250709917;6740.595564266159;6761.594304341558;6768.627725474949;7486.588237646982;7543.358814500829;7642.847143057219;7673.61631918413;7687.077550693729;7568.810779730551;7709.383249340151;7743.148253692202;7773.533587984739;7869.645865935932;6168.19813424252;6177.258728952374;6182.1345011697495;6182.474489668429;6190.721417536131;6947.652617369213;7046.4715146363205;7056.611886346095;7060.3292687194635;7153.284671532805;6539;6572.572782769104;6640.601563906181;6751.662416879235;6781.050652908695;5954.523638109027;6430.614163150226;6457.61254324742;6481.319461456479;6541.934580654132;6585.506087043586;6593.3736295051895;6601.735930562723;6635.8009259722285;6667.233268174028;5939.406059394026;6007.48936340416;6010.248718910137;6060.818175454743;6067.089936509559;6131.141640170291;6168.25980882297;6170.969145154246;6179.28938172116;6240.750369985331 16:51:28 INFO - 2015-11-12 16:51:28,266 DEBUG : BROWSER_OUTPUT: |4;prototype.html;279.2126204104426;283.6227817003386;295.3767550468511;305.9877604895804;309.32875659818194;6027.578069535134;6077.4530292273685;6156.876862462759;6202.06968954657;6251.0310901810235;6090.847728806771;6120.908186377208;6153.077038444236;6164.876702465948;6172.7530898764;4726.409198850144;4731.4795372509;4744.620430365562;4781.258904869734;4787.257975013861;4725.834595789148;4725.8582242532775;4769.260764581478;4769.833055843046;4808.110499557575;4355.128974205156;4527.275635898257;4564.269716845305;4603.516630753773;4609.70036947599;4542.523035081302;4584.839530616429;4592.632589392841;4593.150267200579;4612.446506419217;3842.231553689245;3853.325668008087;3858.498395208605;3858.9614103858885;3898.3372826619543;5854.238948936653;5931.673757943311;5936.376680448577;5939;5950.976667932923;4976.552110310054;5138.075146473633;5141.665791723526;5179.974100129513;5185.714785686786;6254.6872656366995;6261.24865016201;6313.116163737034;6342.39747224013;6364.936350636481;4189.329707246857;4214.557471465513;4222.725522841006;4224.197402493516;4249.235137675218;6104.175936248594;6555;6700.966495167541;6739.932600673979;6750.426213771835;4246.575342465729;4274.444322238089;4289.806958686867;4342.131573685276;4349.282368409177;4383.715058521249;4389.3635422864145;4397.120575884772;4434.467863856358;4440.533743956903;5016.172331565251;5111.3355263815465;5123.436421993578;5149.485051494896;5191.351081114861;6102.237220347457;6335.018072198816;6358.109864618957;6441.227052753699;6442.549021568539;1510.5015344936144;1532.540237928617;1534.4399294257516;1547.203190356967;1565.2721484509757;964.5322018820866;964.6334392930642;972.0134063925121;977.4184360305607;988.3526290279879;6043.697815109315;6077.027675571887;6085.421884920926;6097.2683278006925;6138.938610613836;6562.901556476657;6630.303818099127;6634.701438435282;6700.262971073178;6732.899006514906;6057.091436284592;6070.696465176812;6093.329733729375;6119.541034422347;6159.81520554384;3484.982575087108;3602.5496812898386;3608.711303095746;3617.4935509028755;3629.491871138043;6864.897026544606;6874.450043996469;6958.443324534025;6977.33715297046;7001.36987671112;6845.418139458202;6892.689828957709;6898;6925.891857302808;6947.444204463631;6684.565503242274;6884.105066341343;6974.476914231453;6988.685509151998;7004.229534751174;6707;6725.9663701681175;6764.492663050192;6789.660516974231;6816.795496135124;6337.90493142594;6536.052272420377;6603.240627327918;6609.570377925419;6642.43539299165;6804.897926531205;6922.619255940972;6933.341332573397;6967.581945083311;7005.124359455068;4307.418498502788;4310.978445107879;4347.934780978225;4351.695381323277;4384.627306678968;6685.933140668531;6754.93245067543;6764.93235067643;6773.661316934035;6793.66031698423;6277.089821975696;6439.356064393523;6466.482681385572;6512.381323774234;6567.835804104936;6443.548951573345;6504.60972341661;6513.706883190173;6519.152510173837;6526.379993900572;6319.46284565817;6324.241091068917;6371.458426033839;6376.39424254695;6399.072134540373;6350.872982540416;6486.383793539606;6513.7068831903625;6533.640649764308;6569.835754106186;6342.429181373698;6348.079528468438;6401.743930242925;6409.262934762562;6418.614883107029 16:51:28 INFO - 2015-11-12 16:51:28,268 DEBUG : BROWSER_OUTPUT: |5;yui.html;572.5677113779096;714.7426926306532;715.9248278930713;729.9744508942184;758.2947858491602;12105.697357566065;12132.636020919364;12262.754744905096;12367.072469564784;12419.56531521397;11382.7154321142;11392.772144557104;11436.485358158881;11508.827367589492;11610.477528511215;845.1464021338462;848.495145388496;860.311750599521;866.4931015355993;870.1168314161132;850.3239924260228;874.2699845628907;874.6064271078009;879.7184900831736;879.8460269452852;890.4301247201796;901.2699713232303;906.5467266366817;906.6600024990629;906.8050369170627;892.7455675132557;893.423741686615;893.6202114101546;894.4230971023718;897.5018864530183;660.8017594721564;661.1240106858384;663.4460225711537;664.3821246240994;665.3446355339986;12318.137730358878;12344.567940122053;12380.690482738004;12384.318862462651;12421.130520863544;11070.501827417705;11125.666230013112;11321.547138114547;11410.315381077162;11513.07895368377;9082.09179082093;9092.8636070459;9145.222656074242;9261.19606433866;9378.85931711025;3197.776155669104;3275.164832967578;3276.541284220211;3310.0566338593385;3355.9664403355896;43333.349999750026;44521.33218001733;47698;47903.76048119772;48055.75972120117;8482;8627.180417860292;8727.65089396417;8745.081766414562;8786.780330491662;18939.33712320062;18988.05059747035;19072.61854762925;19102.52243693891;19113.61772764537;6702.765403210962;6983.546069505466;7062.823429414306;7081.610511421818;7129.215786263507;3407.505911642798;3516.701080408194;3587.192881601671;3590.8922732318074;3597.6941959933697;3043.8173709577054;3064.1879901826032;3080.2915329474345;3086.2901532647616;3100.8139511629374;417.1136335287514;418.9895252618709;425.9403683484315;432.0300924424624;433.6530775379684;464.62365483958104;542.3600151820889;543.6086018066985;554.2434576802635;574.9683767392834;7285.562866228043;7444.813879653052;7956.164602716747;8091.0695270043525;8099.716509922125;433.82213292549903;460.4359659417254;475.1328824894581;523.8297553295195;537.2156651289083;3503.1242189452637;3556.8577256909434;3561.216532362876;3600.6399360063783;3669.559652841676;56033.43966560364;56610.71694641501;56749.71625141848;56977.14534281989;57060.42939570634;49977.25034124491;50940.490595094314;51042.74478627658;51318;51526.74236628793;43433.13133737307;43544;43890.56109438992;44131.55868441275;45552.3167152493;7312.96343518279;7319.926800731924;7335.633218339169;7379.778606641809;7437.330640242404;33256.50115248225;33540;33803.83098084494;34508.48237276392;34575;40006.39990400088;41362.58637413708;44765;46101;46356.07287854292;6753.662316884234;6773.661316934232;6844.657767111724;6862;6887.862242755217;9763.267754918268;9862.85205721929;10005.699829005142;10063.194944404577;10198.18414526851;9088.863667044867;9285.767855803659;9377.249820014518;9519.190868776232;9569.043095690375;9328.486933218737;9504.04959504044;9607.903920960702;9728.610855565981;9817.754556135867;8898.42160259581;8899.332550058642;9014.034004322835;9136.725898223063;9540.189083927666;7880.684772609261;7973.561454120079;7998.520088794691;8076.313513351431;8214.58927053633;8058.274755271819;8115.513069215866;8196.918030819616;8301.46040507365;8361.205685459872 16:51:28 INFO - 2015-11-12 16:51:28,268 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:51:28 INFO - 2015-11-12 16:51:28,268 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:51:28 INFO - 2015-11-12 16:51:28,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,282 16:51:28 INFO - 2015-11-12 16:51:28,268 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:51:28 INFO - 2015-11-12 16:51:28,269 DEBUG : BROWSER_OUTPUT: __startTimestamp1447375888254__endTimestamp 16:51:28 INFO - 2015-11-12 16:51:28,269 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,269 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:51:28 INFO - 2015-11-12 16:51:28,270 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:51:28 INFO - 2015-11-12 16:51:28,270 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,270 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5012.14 Median:5130.38 stddev:623.40 (12.2%) stddev-sans-first:604.60 16:51:28 INFO - 2015-11-12 16:51:28,271 DEBUG : BROWSER_OUTPUT: Values: 2980.4 3074.4 3148.7 3172.7 3285.5 4904.4 4960.1 4969.8 5017.2 5054.0 4865.5 4885.3 4905.7 4948.3 5184.6 4585.6 4656.8 4660.8 4698.3 4791.4 756.1 4652.5 4675.7 4698.5 4745.0 4631.9 4664.8 4674.5 4757.0 4811.8 4701.9 4716.6 4724.9 4753.0 4760.2 4578.5 4594.4 4658.4 4696.6 4821.9 4685.4 4836.5 4964.4 5012.0 5038.8 5178.9 5290.5 5292.3 5295.3 5299.2 5117.2 5356.5 5404.3 5490.8 5557.9 5030.6 5032.5 5035.6 5051.8 5091.7 5373.3 5568.8 5587.5 5597.5 5604.0 5115.3 5177.8 5219.9 5248.7 5259.4 5473.3 5491.5 5494.2 5513.1 5579.2 4934.0 5086.8 5385.6 5401.9 5408.7 5297.2 5333.0 5371.6 5374.0 5416.1 4167.7 4201.0 4204.0 4206.2 4242.4 3721.6 3753.0 3824.8 3879.3 3882.3 5046.0 5077.2 5080.5 5083.9 5093.8 5458.6 5462.5 5482.6 5490.6 5524.8 4873.3 4976.9 5024.3 5053.9 5106.5 4779.0 4803.5 4836.8 4839.6 4879.9 5598.4 5622.1 5637.5 5640.1 5640.2 5285.7 5404.1 5404.4 5462.6 5505.7 5585.2 5588.4 5613.2 5623.5 5636.1 5126.3 5341.8 5413.1 5442.8 5450.8 5397.6 5422.7 5450.1 5451.5 5478.9 5339.2 5349.7 5384.4 5403.2 5463.7 5041.1 5141.7 5205.6 5340.1 5361.0 5069.5 5134.9 5137.9 5153.7 5189.6 5150.8 5447.4 5456.0 5482.8 5488.2 4990.8 5128.9 5130.4 5235.5 5299.4 16:51:28 INFO - 2015-11-12 16:51:28,271 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,272 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42707.11 Median:32414.85 stddev:70881.02 (218.7%) stddev-sans-first:71009.09 16:51:28 INFO - 2015-11-12 16:51:28,273 DEBUG : BROWSER_OUTPUT: Values: 520.8 546.3 551.3 552.6 559.7 33931.3 34526.0 34675.0 34763.3 34968.8 40023.2 40098.8 40196.0 40551.4 40756.6 8766.5 8873.7 8942.9 8948.2 9004.9 8670.3 8784.4 8828.6 8837.2 8916.4 8741.5 8813.8 8838.3 8898.1 8900.1 8772.6 8842.9 8869.6 8943.7 8989.6 8571.8 8717.6 8731.8 8747.7 8895.9 36164.3 36642.8 36754.0 36907.3 36999.3 2329.4 2535.1 2596.0 2853.7 3340.0 25260.5 25441.2 25866.1 26644.3 26721.0 2310.0 2318.4 2346.2 2364.5 2492.1 227070.0 231178.0 231279.0 231429.0 232384.0 51618.0 52090.0 59524.7 60191.1 60991.7 54588.0 55108.7 55526.0 55691.4 55731.7 14972.6 15161.5 15169.6 15204.5 15206.2 11475.1 11509.4 11519.5 11715.4 11793.0 17928.4 17945.4 18005.5 18005.6 18266.9 8162.0 8463.4 8473.9 8476.6 8502.5 899.2 933.6 976.8 1107.7 1120.3 24156.5 25531.0 25711.0 25911.6 26163.2 963.2 969.8 997.3 1000.4 1003.8 13518.5 13520.1 13540.9 13549.9 13675.2 295984.0 300966.0 306430.0 306438.0 306464.0 50327.0 51457.0 51470.5 51495.5 52191.7 1338.2 1346.2 1352.8 1362.5 1365.7 25070.7 25541.4 25661.9 25866.7 25891.0 43213.0 43474.3 43570.8 43608.0 43645.8 271629.0 273894.9 275019.0 275982.0 276134.0 28944.0 28998.3 29675.1 29868.6 30086.8 35578.6 36036.6 36073.5 36207.0 36548.8 30678.8 31200.5 32507.5 33379.7 33396.5 30849.1 30895.7 30922.9 31011.2 31351.2 32322.2 32689.8 32856.2 33282.3 33772.2 27221.6 29340.0 29369.4 29377.4 29679.7 22166.8 22403.2 22595.5 22613.8 22622.9 16:51:28 INFO - 2015-11-12 16:51:28,273 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,273 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25732.16 Median:4482.56 stddev:88563.85 (1975.7%) stddev-sans-first:88791.73 16:51:28 INFO - 2015-11-12 16:51:28,275 DEBUG : BROWSER_OUTPUT: Values: 317.3 321.6 321.9 324.8 337.2 10943.6 11335.5 17286.1 17477.5 18008.8 11114.5 11237.9 11331.5 11369.2 11500.9 4077.3 4103.3 4237.0 4241.2 4288.1 4208.0 4248.7 4385.7 4513.8 4524.7 4288.9 4457.5 4459.3 4483.5 4496.4 4416.7 4417.2 4423.1 4434.1 4481.6 3735.8 3768.5 3864.1 3882.6 3900.4 10713.2 11413.0 11891.0 11901.5 11945.9 1722.5 1761.9 1818.2 1818.6 1919.1 8953.1 9129.6 9170.4 9403.4 9420.5 1425.6 1440.5 1492.7 1523.7 1538.3 56275.7 57669.0 57719.4 58592.4 59101.0 6026.9 6188.0 6219.3 6257.1 6274.6 7072.0 7077.7 7090.9 7121.9 7151.2 5182.0 5190.9 5208.9 5213.4 5226.0 5168.3 5200.9 5241.3 5435.9 5531.7 2741.7 2770.5 2782.2 2800.1 2817.2 982.6 988.8 991.7 997.0 1043.6 380.6 381.0 387.4 408.9 419.8 9270.6 9872.8 10015.8 10130.3 10164.9 386.8 388.0 389.4 394.5 408.1 5384.4 5491.8 5513.8 5525.6 5542.6 513837.0 533499.0 535823.0 539483.0 578614.0 66650.7 67011.3 67034.3 67545.7 67623.0 410.2 410.9 411.7 412.1 412.6 9255.3 9273.7 9414.3 9430.4 9435.4 29826.9 31017.7 31209.5 31234.1 31545.4 42997.8 43010.1 43392.0 43846.3 44094.8 5600.7 5819.2 5824.5 5829.3 5894.9 10976.1 11159.8 11168.3 11190.6 11295.0 9143.9 9276.0 9415.1 9503.2 9608.1 9184.5 9240.2 9496.1 9529.9 9566.0 9483.5 9776.6 9794.9 9943.4 10000.5 5676.7 5808.7 5950.3 5976.3 6004.1 9557.2 9607.7 9663.6 9708.5 9775.8 16:51:28 INFO - 2015-11-12 16:51:28,275 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,275 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5009.75 Median:6267.81 stddev:2607.43 (41.6%) stddev-sans-first:2600.88 16:51:28 INFO - 2015-11-12 16:51:28,275 DEBUG : BROWSER_OUTPUT: Values: 1431.2 1660.3 1688.8 1706.2 1715.8 6294.9 6679.5 6760.0 7183.6 7271.5 7023.2 7203.0 7314.0 7412.4 7418.0 1981.1 2006.8 2016.2 2031.7 2042.5 2057.1 2078.2 2115.1 2145.8 2176.6 2061.9 2077.7 2086.7 2092.3 2118.3 2041.8 2055.9 2060.1 2070.4 2096.4 2013.8 2046.1 2051.3 2059.2 2066.3 7305.5 7314.6 7327.9 7387.2 7420.1 4302.7 4374.8 4399.2 4454.1 4463.9 2744.1 2808.1 2869.7 2876.8 2878.3 878.9 883.8 887.8 897.9 917.3 9542.0 9690.9 9702.3 9746.6 9774.4 3679.0 3707.8 3811.1 3814.6 3825.9 7869.5 7881.2 7883.9 7897.0 7985.3 4380.1 4387.2 4424.9 4428.2 4431.2 4045.4 4077.1 4094.2 4107.8 4137.4 3035.9 3069.7 3073.6 3085.5 3119.8 886.8 890.4 892.0 895.5 900.6 1232.3 1242.7 1256.1 1263.9 1267.0 6921.4 6950.0 6964.7 7003.9 7024.0 393.6 403.9 405.6 407.2 409.7 5390.8 5470.0 5501.6 5502.1 5518.9 7904.2 8024.0 8508.5 8525.5 8618.7 8576.4 8584.6 8604.3 8641.6 8648.0 6651.6 6680.8 6761.9 6879.9 6906.8 6692.6 6693.7 6740.6 6761.6 6768.6 7486.6 7543.4 7642.8 7673.6 7687.1 7568.8 7709.4 7743.1 7773.5 7869.6 6168.2 6177.3 6182.1 6182.5 6190.7 6947.7 7046.5 7056.6 7060.3 7153.3 6539.0 6572.6 6640.6 6751.7 6781.1 5954.5 6430.6 6457.6 6481.3 6541.9 6585.5 6593.4 6601.7 6635.8 6667.2 5939.4 6007.5 6010.2 6060.8 6067.1 6131.1 6168.3 6171.0 6179.3 6240.8 16:51:28 INFO - 2015-11-12 16:51:28,275 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,276 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5349.45 Median:6154.98 stddev:1671.26 (27.2%) stddev-sans-first:1632.05 16:51:28 INFO - 2015-11-12 16:51:28,277 DEBUG : BROWSER_OUTPUT: Values: 279.2 283.6 295.4 306.0 309.3 6027.6 6077.5 6156.9 6202.1 6251.0 6090.8 6120.9 6153.1 6164.9 6172.8 4726.4 4731.5 4744.6 4781.3 4787.3 4725.8 4725.9 4769.3 4769.8 4808.1 4355.1 4527.3 4564.3 4603.5 4609.7 4542.5 4584.8 4592.6 4593.2 4612.4 3842.2 3853.3 3858.5 3859.0 3898.3 5854.2 5931.7 5936.4 5939.0 5951.0 4976.6 5138.1 5141.7 5180.0 5185.7 6254.7 6261.2 6313.1 6342.4 6364.9 4189.3 4214.6 4222.7 4224.2 4249.2 6104.2 6555.0 6701.0 6739.9 6750.4 4246.6 4274.4 4289.8 4342.1 4349.3 4383.7 4389.4 4397.1 4434.5 4440.5 5016.2 5111.3 5123.4 5149.5 5191.4 6102.2 6335.0 6358.1 6441.2 6442.5 1510.5 1532.5 1534.4 1547.2 1565.3 964.5 964.6 972.0 977.4 988.4 6043.7 6077.0 6085.4 6097.3 6138.9 6562.9 6630.3 6634.7 6700.3 6732.9 6057.1 6070.7 6093.3 6119.5 6159.8 3485.0 3602.5 3608.7 3617.5 3629.5 6864.9 6874.5 6958.4 6977.3 7001.4 6845.4 6892.7 6898.0 6925.9 6947.4 6684.6 6884.1 6974.5 6988.7 7004.2 6707.0 6726.0 6764.5 6789.7 6816.8 6337.9 6536.1 6603.2 6609.6 6642.4 6804.9 6922.6 6933.3 6967.6 7005.1 4307.4 4311.0 4347.9 4351.7 4384.6 6685.9 6754.9 6764.9 6773.7 6793.7 6277.1 6439.4 6466.5 6512.4 6567.8 6443.5 6504.6 6513.7 6519.2 6526.4 6319.5 6324.2 6371.5 6376.4 6399.1 6350.9 6486.4 6513.7 6533.6 6569.8 6342.4 6348.1 6401.7 6409.3 6418.6 16:51:28 INFO - 2015-11-12 16:51:28,277 DEBUG : BROWSER_OUTPUT: 16:51:28 INFO - 2015-11-12 16:51:28,277 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12862.33 Median:57018.79 stddev:15730.16 (27.6%) stddev-sans-first:15747.21 16:51:28 INFO - 2015-11-12 16:51:28,278 DEBUG : BROWSER_OUTPUT: Values: 572.6 714.7 715.9 730.0 758.3 12105.7 12132.6 12262.8 12367.1 12419.6 11382.7 11392.8 11436.5 11508.8 11610.5 845.1 848.5 860.3 866.5 870.1 850.3 874.3 874.6 879.7 879.8 890.4 901.3 906.5 906.7 906.8 892.7 893.4 893.6 894.4 897.5 660.8 661.1 663.4 664.4 665.3 12318.1 12344.6 12380.7 12384.3 12421.1 11070.5 11125.7 11321.5 11410.3 11513.1 9082.1 9092.9 9145.2 9261.2 9378.9 3197.8 3275.2 3276.5 3310.1 3356.0 43333.3 44521.3 47698.0 47903.8 48055.8 8482.0 8627.2 8727.7 8745.1 8786.8 18939.3 18988.1 19072.6 19102.5 19113.6 6702.8 6983.5 7062.8 7081.6 7129.2 3407.5 3516.7 3587.2 3590.9 3597.7 3043.8 3064.2 3080.3 3086.3 3100.8 417.1 419.0 425.9 432.0 433.7 464.6 542.4 543.6 554.2 575.0 7285.6 7444.8 7956.2 8091.1 8099.7 433.8 460.4 475.1 523.8 537.2 3503.1 3556.9 3561.2 3600.6 3669.6 56033.4 56610.7 56749.7 56977.1 57060.4 49977.3 50940.5 51042.7 51318.0 51526.7 43433.1 43544.0 43890.6 44131.6 45552.3 7313.0 7319.9 7335.6 7379.8 7437.3 33256.5 33540.0 33803.8 34508.5 34575.0 40006.4 41362.6 44765.0 46101.0 46356.1 6753.7 6773.7 6844.7 6862.0 6887.9 9763.3 9862.9 10005.7 10063.2 10198.2 9088.9 9285.8 9377.2 9519.2 9569.0 9328.5 9504.0 9607.9 9728.6 9817.8 8898.4 8899.3 9014.0 9136.7 9540.2 7880.7 7973.6 7998.5 8076.3 8214.6 8058.3 8115.5 8196.9 8301.5 8361.2 16:51:28 INFO - 2015-11-12 16:51:28,279 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:51:28 INFO - 2015-11-12 16:51:28,279 DEBUG : BROWSER_OUTPUT: 16:51:29 INFO - 2015-11-12 16:51:29,087 INFO : Browser exited with error code: 0 16:51:29 INFO - 2015-11-12 16:51:29,116 INFO : Completed test dromaeo_css (00:18:31) 16:51:29 INFO - 2015-11-12 16:51:29,116 INFO : Starting test kraken 16:51:29 INFO - 2015-11-12 16:51:29,116 DEBUG : operating with platform_type : mac_ 16:51:29 INFO - 2015-11-12 16:51:29,117 INFO : Initialising browser for kraken test... 16:51:29 INFO - 2015-11-12 16:51:29,129 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmp0G0dTs/profile http://localhost:51678/getInfo.html 16:51:31 INFO - 2015-11-12 16:51:31,980 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:51:31 INFO - 2015-11-12 16:51:31,981 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:51:31 INFO - 2015-11-12 16:51:31,981 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:51:31 INFO - 2015-11-12 16:51:31,981 DEBUG : BROWSER_OUTPUT: __metrics 16:51:32 INFO - 2015-11-12 16:51:32,643 INFO : Browser initialized. 16:51:32 INFO - 2015-11-12 16:51:32,644 INFO : Running cycle 1/1 for kraken test... 16:51:32 INFO - 2015-11-12 16:51:32,644 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmp0G0dTs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:51:44 INFO - 2015-11-12 16:51:44,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 241303552 16:51:44 INFO - 2015-11-12 16:51:44,638 DEBUG : BROWSER_OUTPUT: 16:51:47 INFO - 2015-11-12 16:51:47,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51678/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:47 INFO - 2015-11-12 16:51:47,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 258871296 16:51:47 INFO - 2015-11-12 16:51:47,749 DEBUG : BROWSER_OUTPUT: 16:51:50 INFO - 2015-11-12 16:51:50,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51678/tests/kraken/driver.html?testName=audio-dft) 16:51:50 INFO - 2015-11-12 16:51:50,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 267472896 16:51:50 INFO - 2015-11-12 16:51:50,992 DEBUG : BROWSER_OUTPUT: 16:51:53 INFO - 2015-11-12 16:51:53,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51678/tests/kraken/driver.html?testName=audio-fft) 16:51:54 INFO - 2015-11-12 16:51:54,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 268255232 16:51:54 INFO - 2015-11-12 16:51:54,441 DEBUG : BROWSER_OUTPUT: 16:51:56 INFO - 2015-11-12 16:51:56,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51678/tests/kraken/driver.html?testName=audio-oscillator) 16:51:56 INFO - 2015-11-12 16:51:56,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 267636736 16:51:56 INFO - 2015-11-12 16:51:56,990 DEBUG : BROWSER_OUTPUT: 16:51:59 INFO - 2015-11-12 16:51:59,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51678/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:59 INFO - 2015-11-12 16:51:59,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 267022336 16:51:59 INFO - 2015-11-12 16:51:59,701 DEBUG : BROWSER_OUTPUT: 16:52:02 INFO - 2015-11-12 16:52:02,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51678/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:03 INFO - 2015-11-12 16:52:03,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 268865536 16:52:03 INFO - 2015-11-12 16:52:03,350 DEBUG : BROWSER_OUTPUT: 16:52:06 INFO - 2015-11-12 16:52:06,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51678/tests/kraken/driver.html?testName=imaging-desaturate) 16:52:07 INFO - 2015-11-12 16:52:07,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 269139968 16:52:07 INFO - 2015-11-12 16:52:07,143 DEBUG : BROWSER_OUTPUT: 16:52:10 INFO - 2015-11-12 16:52:10,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51678/tests/kraken/driver.html?testName=json-parse-financial) 16:52:10 INFO - 2015-11-12 16:52:10,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 269508608 16:52:10 INFO - 2015-11-12 16:52:10,667 DEBUG : BROWSER_OUTPUT: 16:52:12 INFO - 2015-11-12 16:52:12,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51678/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:12 INFO - 2015-11-12 16:52:12,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 266960896 16:52:12 INFO - 2015-11-12 16:52:12,834 DEBUG : BROWSER_OUTPUT: 16:52:14 INFO - 2015-11-12 16:52:14,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51678/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:15 INFO - 2015-11-12 16:52:15,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 268365824 16:52:15 INFO - 2015-11-12 16:52:15,279 DEBUG : BROWSER_OUTPUT: 16:52:17 INFO - 2015-11-12 16:52:17,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51678/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:17 INFO - 2015-11-12 16:52:17,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 268496896 16:52:17 INFO - 2015-11-12 16:52:17,966 DEBUG : BROWSER_OUTPUT: 16:52:20 INFO - 2015-11-12 16:52:20,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:21 INFO - 2015-11-12 16:52:21,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 268550144 16:52:21 INFO - 2015-11-12 16:52:21,238 DEBUG : BROWSER_OUTPUT: 16:52:23 INFO - 2015-11-12 16:52:23,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:24 INFO - 2015-11-12 16:52:24,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 269471744 16:52:24 INFO - 2015-11-12 16:52:24,517 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51678/tests/kraken/driver.html?testName=ai-astar) 16:52:26 INFO - 2015-11-12 16:52:26,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 268427264 16:52:26 INFO - 2015-11-12 16:52:26,479 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,479 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:52:26 INFO - 2015-11-12 16:52:26,479 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:52:26 INFO - 2015-11-12 16:52:26,479 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:52:26 INFO - 2015-11-12 16:52:26,479 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:52:26 INFO - 2015-11-12 16:52:26,479 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;101;109;108;107;119;110;108;109;110 16:52:26 INFO - 2015-11-12 16:52:26,480 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;132;153;163;130;148;146;131;170;128 16:52:26 INFO - 2015-11-12 16:52:26,480 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;166;164;164;167;167;168;173;170;168 16:52:26 INFO - 2015-11-12 16:52:26,480 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;75;79;66;72;72;71;125;67;69 16:52:26 INFO - 2015-11-12 16:52:26,480 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;128;89;89;91;127;91;89;138 16:52:26 INFO - 2015-11-12 16:52:26,480 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;117;115;115;131;116;125;124;124;124 16:52:26 INFO - 2015-11-12 16:52:26,480 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;128;136;127;128;129;136;137;137;138;137 16:52:26 INFO - 2015-11-12 16:52:26,481 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;108;96;109;105;104;120;107;117;105 16:52:26 INFO - 2015-11-12 16:52:26,481 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;61;63;62;61;66;69;63;65 16:52:26 INFO - 2015-11-12 16:52:26,481 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;72;70;72;69;69;70;69;74;70 16:52:26 INFO - 2015-11-12 16:52:26,481 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;87;87;86;86;86;90;93;94;93 16:52:26 INFO - 2015-11-12 16:52:26,481 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;126;129;131;138;149;153;149;146;150 16:52:26 INFO - 2015-11-12 16:52:26,482 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;157;157;158;162;168;173;160;169;160 16:52:26 INFO - 2015-11-12 16:52:26,482 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;71;71;72;70;71;70;71;72 16:52:26 INFO - 2015-11-12 16:52:26,482 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:52:26 INFO - 2015-11-12 16:52:26,482 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:52:26 INFO - 2015-11-12 16:52:26,482 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,709 16:52:26 INFO - 2015-11-12 16:52:26,482 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:52:26 INFO - 2015-11-12 16:52:26,483 DEBUG : BROWSER_OUTPUT: __startTimestamp1447375946473__endTimestamp 16:52:26 INFO - 2015-11-12 16:52:26,483 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,483 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:52:26 INFO - 2015-11-12 16:52:26,483 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:52:26 INFO - 2015-11-12 16:52:26,483 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,483 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:4.38 (4.0%) stddev-sans-first:4.64 16:52:26 INFO - 2015-11-12 16:52:26,484 DEBUG : BROWSER_OUTPUT: Values: 110.0 101.0 109.0 108.0 107.0 119.0 110.0 108.0 109.0 110.0 16:52:26 INFO - 2015-11-12 16:52:26,484 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,484 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.50 Median:150.50 stddev:14.83 (9.9%) stddev-sans-first:15.41 16:52:26 INFO - 2015-11-12 16:52:26,484 DEBUG : BROWSER_OUTPUT: Values: 154.0 132.0 153.0 163.0 130.0 148.0 146.0 131.0 170.0 128.0 16:52:26 INFO - 2015-11-12 16:52:26,484 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,484 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:167.20 Median:167.50 stddev:2.78 (1.7%) stddev-sans-first:2.83 16:52:26 INFO - 2015-11-12 16:52:26,484 DEBUG : BROWSER_OUTPUT: Values: 165.0 166.0 164.0 164.0 167.0 167.0 168.0 173.0 170.0 168.0 16:52:26 INFO - 2015-11-12 16:52:26,484 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.00 Median:72.00 stddev:17.29 (24.0%) stddev-sans-first:18.31 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 79.0 66.0 72.0 72.0 71.0 125.0 67.0 69.0 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.00 Median:89.00 stddev:20.23 (22.7%) stddev-sans-first:20.91 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 128.0 89.0 89.0 91.0 127.0 91.0 89.0 138.0 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:121.20 Median:124.00 stddev:5.33 (4.3%) stddev-sans-first:5.65 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: Values: 121.0 117.0 115.0 115.0 131.0 116.0 125.0 124.0 124.0 124.0 16:52:26 INFO - 2015-11-12 16:52:26,485 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:133.30 Median:136.50 stddev:4.62 (3.4%) stddev-sans-first:4.48 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: Values: 128.0 136.0 127.0 128.0 129.0 136.0 137.0 137.0 138.0 137.0 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:107.20 Median:108.50 stddev:7.05 (6.5%) stddev-sans-first:7.11 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: Values: 101.0 108.0 96.0 109.0 105.0 104.0 120.0 107.0 117.0 105.0 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:2.55 (4.0%) stddev-sans-first:2.65 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 61.0 63.0 62.0 61.0 66.0 69.0 63.0 65.0 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:1.71 (2.4%) stddev-sans-first:1.74 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 70.0 72.0 69.0 69.0 70.0 69.0 74.0 70.0 16:52:26 INFO - 2015-11-12 16:52:26,486 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:88.50 stddev:3.36 (3.8%) stddev-sans-first:3.41 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 87.0 86.0 86.0 86.0 90.0 93.0 94.0 93.0 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:147.50 stddev:10.74 (7.3%) stddev-sans-first:10.34 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 129.0 131.0 138.0 149.0 153.0 149.0 146.0 150.0 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:161.00 stddev:5.73 (3.6%) stddev-sans-first:5.87 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: Values: 158.0 157.0 157.0 158.0 162.0 168.0 173.0 160.0 169.0 160.0 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:0.82 (1.1%) stddev-sans-first:0.78 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 71.0 71.0 72.0 70.0 71.0 70.0 71.0 72.0 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:52:26 INFO - 2015-11-12 16:52:26,487 DEBUG : BROWSER_OUTPUT: 16:52:27 INFO - 2015-11-12 16:52:27,138 INFO : Browser exited with error code: 0 16:52:27 INFO - 2015-11-12 16:52:27,190 INFO : Completed test kraken (00:00:58) 16:52:27 INFO - 2015-11-12 16:52:27,190 INFO : Starting test v8_7 16:52:27 INFO - 2015-11-12 16:52:27,190 DEBUG : operating with platform_type : mac_ 16:52:27 INFO - 2015-11-12 16:52:27,190 INFO : Initialising browser for v8_7 test... 16:52:27 INFO - 2015-11-12 16:52:27,203 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmpNewkx9/profile http://localhost:51678/getInfo.html 16:52:30 INFO - 2015-11-12 16:52:30,093 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:52:30 INFO - 2015-11-12 16:52:30,094 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:52:30 INFO - 2015-11-12 16:52:30,094 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:52:30 INFO - 2015-11-12 16:52:30,094 DEBUG : BROWSER_OUTPUT: __metrics 16:52:30 INFO - 2015-11-12 16:52:30,728 INFO : Browser initialized. 16:52:30 INFO - 2015-11-12 16:52:30,729 INFO : Running cycle 1/1 for v8_7 test... 16:52:30 INFO - 2015-11-12 16:52:30,729 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmpNewkx9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:52:42 INFO - 2015-11-12 16:52:42,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 239644672 16:52:42 INFO - 2015-11-12 16:52:42,762 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51678/tests/v8_7/run.html (next: http://localhost:51678/tests/v8_7/run.html) 16:53:04 INFO - 2015-11-12 16:53:04,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 260014080 16:53:04 INFO - 2015-11-12 16:53:04,451 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,451 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:53:04 INFO - 2015-11-12 16:53:04,451 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:53:04 INFO - 2015-11-12 16:53:04,452 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:53:04 INFO - 2015-11-12 16:53:04,453 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:53:04 INFO - 2015-11-12 16:53:04,453 DEBUG : BROWSER_OUTPUT: |0;Richards;166.58337497917708 16:53:04 INFO - 2015-11-12 16:53:04,453 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;197.35543714229328 16:53:04 INFO - 2015-11-12 16:53:04,453 DEBUG : BROWSER_OUTPUT: |2;Encrypt;341.29692832764505 16:53:04 INFO - 2015-11-12 16:53:04,453 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5797.687861271676 16:53:04 INFO - 2015-11-12 16:53:04,453 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1146.788990825688 16:53:04 INFO - 2015-11-12 16:53:04,454 DEBUG : BROWSER_OUTPUT: |5;Earley;862.8127696289905 16:53:04 INFO - 2015-11-12 16:53:04,454 DEBUG : BROWSER_OUTPUT: |6;Boyer;13944.444444444445 16:53:04 INFO - 2015-11-12 16:53:04,454 DEBUG : BROWSER_OUTPUT: |7;RegExp;30393.939393939392 16:53:04 INFO - 2015-11-12 16:53:04,454 DEBUG : BROWSER_OUTPUT: |8;Splay;651.8087855297158 16:53:04 INFO - 2015-11-12 16:53:04,454 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5928.994082840237 16:53:04 INFO - 2015-11-12 16:53:04,455 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:53:04 INFO - 2015-11-12 16:53:04,455 DEBUG : BROWSER_OUTPUT: __startTimestamp1447375984451__endTimestamp 16:53:04 INFO - 2015-11-12 16:53:04,455 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,455 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:53:04 INFO - 2015-11-12 16:53:04,455 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:53:04 INFO - 2015-11-12 16:53:04,456 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,456 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.58 Median:166.58 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,456 DEBUG : BROWSER_OUTPUT: Values: 166.6 16:53:04 INFO - 2015-11-12 16:53:04,456 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,456 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:197.36 Median:197.36 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,456 DEBUG : BROWSER_OUTPUT: Values: 197.4 16:53:04 INFO - 2015-11-12 16:53:04,457 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,457 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:341.30 Median:341.30 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,457 DEBUG : BROWSER_OUTPUT: Values: 341.3 16:53:04 INFO - 2015-11-12 16:53:04,457 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,457 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,457 DEBUG : BROWSER_OUTPUT: Values: 5797.7 16:53:04 INFO - 2015-11-12 16:53:04,457 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,458 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1146.79 Median:1146.79 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,459 DEBUG : BROWSER_OUTPUT: Values: 1146.8 16:53:04 INFO - 2015-11-12 16:53:04,459 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,459 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:862.81 Median:862.81 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,459 DEBUG : BROWSER_OUTPUT: Values: 862.8 16:53:04 INFO - 2015-11-12 16:53:04,459 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,459 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13944.44 Median:13944.44 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,459 DEBUG : BROWSER_OUTPUT: Values: 13944.4 16:53:04 INFO - 2015-11-12 16:53:04,459 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,460 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30393.94 Median:30393.94 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,460 DEBUG : BROWSER_OUTPUT: Values: 30393.9 16:53:04 INFO - 2015-11-12 16:53:04,460 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,460 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:651.81 Median:651.81 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,460 DEBUG : BROWSER_OUTPUT: Values: 651.8 16:53:04 INFO - 2015-11-12 16:53:04,460 DEBUG : BROWSER_OUTPUT: 16:53:04 INFO - 2015-11-12 16:53:04,460 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5928.99 Median:5928.99 stddev:0.00 (0.0%) 16:53:04 INFO - 2015-11-12 16:53:04,460 DEBUG : BROWSER_OUTPUT: Values: 5929.0 16:53:04 INFO - 2015-11-12 16:53:04,461 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:53:04 INFO - 2015-11-12 16:53:04,461 DEBUG : BROWSER_OUTPUT: 16:53:05 INFO - 2015-11-12 16:53:05,129 INFO : Browser exited with error code: 0 16:53:05 INFO - 2015-11-12 16:53:05,151 INFO : Completed test v8_7 (00:00:37) 16:53:05 INFO - 2015-11-12 16:53:05,592 INFO : Completed test suite (00:20:07) 16:53:05 INFO - 2015-11-12 16:53:05,593 DEBUG : Working with test: dromaeo_css 16:53:05 INFO - 2015-11-12 16:53:05,593 DEBUG : Generating results file: dromaeo_css 16:53:05 INFO - 2015-11-12 16:53:05,594 DEBUG : Working with test: kraken 16:53:05 INFO - 2015-11-12 16:53:05,594 DEBUG : Generating results file: kraken 16:53:05 INFO - 2015-11-12 16:53:05,594 INFO : javascript benchmark 16:53:05 INFO - 2015-11-12 16:53:05,594 DEBUG : Working with test: v8_7 16:53:05 INFO - 2015-11-12 16:53:05,594 DEBUG : Generating results file: v8_7 16:53:05 INFO - 2015-11-12 16:53:05,594 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:53:05 INFO - 2015-11-12 16:53:05,642 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 16:53:05 INFO - 2015-11-12 16:53:05,643 DEBUG : process_Request line: dromaeo_css 6206.69 graph.html#tests=[[72,1,57]] 16:53:05 INFO - 2015-11-12 16:53:05,643 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:53:05 INFO - 2015-11-12 16:53:05,670 DEBUG : process_Request line: kraken 1558.10 graph.html#tests=[[232,1,57]] 16:53:05 INFO - 2015-11-12 16:53:05,670 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:53:05 INFO - 2015-11-12 16:53:05,707 DEBUG : process_Request line: v8_7 18942.65 graph.html#tests=[[230,1,57]] 16:53:05 INFO - 2015-11-12 16:53:05,708 INFO : javascript benchmark 16:53:05 INFO - 2015-11-12 16:53:05,710 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [317.32726619566523, 321.6397634649193, 321.91308346746376, 324.8424514110657, 337.239524871415, 10943.56225750971, 11335.489902954367, 17286.13569321535, 17477.475675729733, 18008.819911800878, 11114.49984750686, 11237.887621123786, 11331.546738130486, 11369.204155709083, 11500.942495287532, 4077.2864748669012, 4103.281925663012, 4236.97881510592, 4241.172971270604, 4288.099499105192, 4207.957920420788, 4248.723832950848, 4385.693001489897, 4513.796879140446, 4524.728516289017, 4288.892777680568, 4457.509673935864, 4459.308807134883, 4483.4843992940905, 4496.415465989433, 4416.668749843775, 4417.22698527758, 4423.137488189805, 4434.113177364524, 4481.641468682497, 3735.794531300777, 3768.491253680773, 3864.053306939818, 3882.592327805568, 3900.395438707005, 10713.196510261761, 11412.972832445119, 11891.0, 11901.523939042429, 11945.940270298679, 1722.4918648998575, 1761.8854774439749, 1818.1727314072198, 1818.5908170661496, 1919.0596607662285, 8953.149450802164, 9129.589168487433, 9170.358074934757, 9403.388779729295, 9420.528973551294, 1425.5937057938438, 1440.4886265375746, 1492.7163838870688, 1523.7104950059454, 1538.261634415487, 56275.71862140663, 57669.0, 57719.42280577183, 58592.414075859124, 59101.0, 6026.9095963560585, 6187.969060154761, 6219.284782250009, 6257.124002639634, 6274.560780745395, 7072.0, 7077.681504332214, 7090.936359546109, 7121.857562848714, 7151.213366529678, 5182.041322355376, 5190.870228244324, 5208.921866172011, 5213.383851006124, 5225.973870130625, 5168.328117344721, 5200.92198617021, 5241.292425522582, 5435.945640543623, 5531.668099914018, 2741.6984131745494, 2770.5290100682932, 2782.220978126128, 2800.0619792369785, 2817.225263052677, 982.6020461713018, 988.8269552828226, 991.6628346362127, 996.9651062212788, 1043.5982146873357, 380.6250842919777, 381.0131758744809, 387.44014898471437, 408.9100397912454, 419.7963987466077, 9270.629174833066, 9872.802543949081, 10015.799684006279, 10130.341527800669, 10164.949175254076, 386.75827607745157, 387.986420475282, 389.3789405897645, 394.52656811825926, 408.07367276282673, 5384.380796208487, 5491.780328786884, 5513.779448822002, 5525.640833345819, 5542.584306177053, 513837.0, 533499.0, 535823.0, 539483.0, 578614.0, 66650.66674666596, 67011.3298867005, 67034.32965670379, 67545.66227168833, 67623.0, 410.23286454330594, 410.8911138548287, 411.6871177904754, 412.10573056467535, 412.579169247366, 9255.305852061258, 9273.67542136022, 9414.340996130206, 9430.387024843363, 9435.433873967584, 29826.85086574553, 31017.689823102384, 31209.531857022615, 31234.062978110695, 31545.36909261848, 42997.785011074746, 43010.13979720451, 43392.0, 43846.34230486481, 44094.77952610217, 5600.747966341443, 5819.214406055128, 5824.534037276923, 5829.280362293219, 5894.852628684317, 10976.067034302174, 11159.832602511131, 11168.329900206014, 11190.608328708782, 11295.0, 9143.908560914306, 9276.0, 9415.105564971316, 9503.19222866064, 9608.087231712976, 9184.49485278316, 9240.168384845396, 9496.097870702271, 9529.857052144085, 9565.952170239105, 9483.525823708926, 9776.608935642495, 9794.902050979399, 9943.403395796275, 10000.549975250986, 5676.68778217202, 5808.7095645218415, 5950.3454619992635, 5976.342602313829, 6004.0693692477735, 9557.235421166151, 9607.711768646952, 9663.565139568596, 9708.5145742714, 9775.75560610962], "dojo.html": [2980.4486170058526, 3074.4465996120703, 3148.748100151988, 3172.7461803055758, 3285.507173923912, 4904.362432883725, 4960.131976904041, 4969.8012079516775, 5017.2474128880685, 5053.974730126349, 4865.513448655132, 4885.291632713254, 4905.730184839832, 4948.331975183349, 5184.585233181346, 4585.564371384713, 4656.790444430008, 4660.813567457298, 4698.342232087511, 4791.448983366922, 756.1275723769475, 4652.511486293941, 4675.719456832601, 4698.530146985308, 4744.97627511862, 4631.907361852778, 4664.790084446208, 4674.509176536466, 4756.976215118937, 4811.759412029384, 4701.858944231679, 4716.551927566876, 4724.929126063077, 4753.0, 4760.1907675694865, 4578.51925547816, 4594.356790049395, 4658.394408726844, 4696.624270058387, 4821.855344339676, 4685.367475390813, 4836.51634836517, 4964.404271487445, 5012.0, 5038.773255203525, 5178.948210517884, 5290.523852853224, 5292.338457692788, 5295.31160949078, 5299.231611416323, 5117.181250999822, 5356.54469370104, 5404.32445944257, 5490.835274941758, 5557.888842223133, 5030.622703297194, 5032.4967503249745, 5035.597152227813, 5051.797928082872, 5091.745412729349, 5373.301470808769, 5568.832935011957, 5587.469190426903, 5597.468240517144, 5604.0, 5115.335006449138, 5177.767000484987, 5219.947800521946, 5248.711320877388, 5259.368875734936, 5473.28847249855, 5491.450854914557, 5494.230807686927, 5513.09034009384, 5579.163125531203, 4933.950660493421, 5086.796528138907, 5385.623006389594, 5401.918971215435, 5408.675479471244, 5297.231901374279, 5332.9733351333, 5371.597130215171, 5374.0, 5416.10634245353, 4167.708260421741, 4200.957990420118, 4204.0, 4206.20082184384, 4242.44848169736, 3721.5906250312446, 3752.962470375261, 3824.827882745283, 3879.262940041383, 3882.320593896057, 5046.041252162077, 5077.238414237894, 5080.542751152414, 5083.8983220335385, 5093.796248150033, 5458.563314934796, 5462.453754624506, 5482.643628164236, 5490.6431081979545, 5524.779008839601, 4873.26900964851, 4976.925346119811, 5024.346834911438, 5053.938672878663, 5106.4893510648635, 4779.02030083832, 4803.471618122004, 4836.806527738851, 4839.612830973514, 4879.926801097987, 5598.412166722517, 5622.128570071563, 5637.520810731134, 5640.097584386561, 5640.210370548045, 5285.656432331886, 5404.108322126962, 5404.378496472798, 5462.562994960314, 5505.724713764215, 5585.245991791056, 5588.441155884379, 5613.1860880171325, 5623.493885550321, 5636.126400407943, 5126.282320475211, 5341.75962081715, 5413.10683737179, 5442.809501667422, 5450.781968721207, 5397.649152805055, 5422.728863556727, 5450.1007333789485, 5451.509364157245, 5478.890422191614, 5339.199120132012, 5349.652272602269, 5384.353877534721, 5403.243545903498, 5463.699496527729, 5041.1430056889685, 5141.691498510101, 5205.5835533158015, 5340.065488539568, 5361.0, 5069.467705890828, 5134.922976155435, 5137.8972420550635, 5153.6907785532985, 5189.558887494454, 5150.793968241228, 5447.373552041566, 5456.0451920914475, 5482.753276102505, 5488.231647569263, 4990.80036798524, 5128.948710512847, 5130.384353877409, 5235.450277720937, 5299.44355842631], "mootools.html": [1431.2056808471293, 1660.2528862012093, 1688.8311168883113, 1706.18103310411, 1715.8112607613168, 6294.874102517947, 6679.499037572177, 6760.0, 7183.604901730403, 7271.527350722199, 7023.1572211334715, 7202.96398518008, 7313.963430182842, 7412.444066694992, 7417.962910185455, 1981.1382048808778, 2006.8193862552369, 2016.1632922337212, 2031.6546187148147, 2042.4995876010398, 2057.0640358636783, 2078.2206672497814, 2115.090511080235, 2145.787629989059, 2176.6299729046023, 2061.8556701030934, 2077.698733683615, 2086.7182930304366, 2092.257248676721, 2118.3221369161874, 2041.7958204179538, 2055.9280425185198, 2060.1347434077647, 2070.4306315763133, 2096.4025252802953, 2013.7684166320767, 2046.1303945822965, 2051.292304155079, 2059.155746144074, 2066.3284432559326, 7305.488615796897, 7314.561126332437, 7327.9267207327775, 7387.150477695081, 7420.072490938633, 4302.720323178984, 4374.846880359204, 4399.230134726442, 4454.086912182995, 4463.910721785579, 2744.108164846433, 2808.1294798612494, 2869.727375899286, 2876.8417737024456, 2878.251654569806, 878.8725634782985, 883.8276536075468, 887.7736177274818, 897.878786363839, 917.3074328881652, 9541.952290238505, 9690.854637180448, 9702.320837541374, 9746.610135594568, 9774.413535187841, 3679.0, 3707.8146092695256, 3811.123441608446, 3814.5803961564206, 3825.9043523912123, 7869.48848324857, 7881.211878812188, 7883.921160788434, 7896.960515197387, 7985.281324680806, 4380.102079073782, 4387.188370151533, 4424.889377765581, 4428.180786554498, 4431.202383570988, 4045.4336392905016, 4077.1234184650443, 4094.2220978014084, 4107.815148318333, 4137.40007698882, 3035.8937437189593, 3069.7237248647284, 3073.615798025247, 3085.5217441296636, 3119.766017548693, 886.7605746448423, 890.4345740454858, 891.9509426981449, 895.4761464543185, 900.6307413960376, 1232.2914324263584, 1242.7079636285466, 1256.133268045046, 1263.9368031598383, 1266.9556565520347, 6921.446284297244, 6949.965250173818, 6964.651767411609, 7003.92996070043, 7024.01663767073, 393.586733929373, 403.8828739665464, 405.6106138107391, 407.1531215072642, 409.68249606554565, 5390.757415916293, 5469.972650136803, 5501.642393244426, 5502.119660854244, 5518.91721624176, 7904.20957904205, 8024.0, 8508.532030738244, 8525.488470691655, 8618.741437756877, 8576.356773241907, 8584.613692383859, 8604.268637165786, 8641.567921603895, 8647.956760216159, 6651.567648102858, 6680.766173183915, 6761.932380676229, 6879.89680154788, 6906.827329316707, 6692.631905245258, 6693.732250709917, 6740.595564266159, 6761.594304341558, 6768.627725474949, 7486.588237646982, 7543.358814500829, 7642.847143057219, 7673.61631918413, 7687.077550693729, 7568.810779730551, 7709.383249340151, 7743.148253692202, 7773.533587984739, 7869.645865935932, 6168.19813424252, 6177.258728952374, 6182.1345011697495, 6182.474489668429, 6190.721417536131, 6947.652617369213, 7046.4715146363205, 7056.611886346095, 7060.3292687194635, 7153.284671532805, 6539.0, 6572.572782769104, 6640.601563906181, 6751.662416879235, 6781.050652908695, 5954.523638109027, 6430.614163150226, 6457.61254324742, 6481.319461456479, 6541.934580654132, 6585.506087043586, 6593.3736295051895, 6601.735930562723, 6635.8009259722285, 6667.233268174028, 5939.406059394026, 6007.48936340416, 6010.248718910137, 6060.818175454743, 6067.089936509559, 6131.141640170291, 6168.25980882297, 6170.969145154246, 6179.28938172116, 6240.750369985331], "ext.html": [520.8046982381609, 546.3362015151591, 551.253052114385, 552.5689961829775, 559.7229371461127, 33931.321373572515, 34526.0, 34675.0, 34763.30473390531, 34968.82515587425, 40023.199536009335, 40098.7995060025, 40195.99999999993, 40551.39172912409, 40756.592434075654, 8766.51784151873, 8873.733787986339, 8942.86585701215, 8948.194662480375, 9004.909950900505, 8670.263027642657, 8784.38509304349, 8828.602712877935, 8837.160469755396, 8916.420432671855, 8741.519216443094, 8813.823723525526, 8838.33712471564, 8898.110188981114, 8900.065493123226, 8772.605232764508, 8842.911570884273, 8869.600867960926, 8943.686970956018, 8989.640414383417, 8571.828563428759, 8717.607707653171, 8731.781705457352, 8747.737567872973, 8895.866562001574, 36164.276714465566, 36642.81678591617, 36754.0, 36907.26185476276, 36999.260014799554, 2329.394357467054, 2535.0508581078325, 2595.9870200648875, 2853.657561092682, 3339.964610970607, 25260.49479010428, 25441.236762897144, 25866.094686685876, 26644.33389165267, 26721.0, 2309.988450057756, 2318.420394901275, 2346.1905642553293, 2364.491634298634, 2492.090387008747, 227070.0, 231177.9999999983, 231279.0, 231429.0, 232384.0, 51618.0, 52090.0, 59524.70237648784, 60191.09713354303, 60991.69504152451, 54588.0, 55108.724456378266, 55526.0, 55691.44308556862, 55731.721341393844, 14972.625684357978, 15161.469348572748, 15169.620759481102, 15204.543863684106, 15206.16366099853, 11475.139364547525, 11509.424528773696, 11519.48162332697, 11715.4142292885, 11793.0, 17928.372506962194, 17945.371911983017, 18005.459836204936, 18005.639887202182, 18266.908665456587, 8162.0, 8463.449875758057, 8473.915260847436, 8476.576171191417, 8502.532360720219, 899.1997122560927, 933.6172169410509, 976.8046390721884, 1107.734143805481, 1120.3166068698088, 24156.51686966286, 25531.0, 25711.0, 25911.611325830127, 26163.215103546925, 963.1572374172599, 969.7575606098476, 997.3195166145068, 1000.4197565412044, 1003.8042581696645, 13518.459261629621, 13520.12119212248, 13540.901160320167, 13549.932250338685, 13675.24786136772, 295984.0, 300966.0, 306430.0, 306438.0, 306464.0, 50327.0, 51457.0, 51470.485295147315, 51495.48504514982, 52191.73904130455, 1338.1770211319968, 1346.1721041559567, 1352.8444228913604, 1362.5231169090937, 1365.7473367427058, 25070.74929250757, 25541.3614659635, 25661.871690641427, 25866.741332587186, 25891.0, 43213.0, 43474.34788478112, 43570.78214608907, 43608.0, 43645.781771090944, 271629.0, 273894.9357785341, 275019.0, 275982.0, 276134.0, 28944.0, 28998.275043123245, 29675.109746707632, 29868.551971720877, 30086.849565752033, 35578.644213557534, 36036.639633604376, 36073.45889811603, 36207.0, 36548.81725591355, 30678.84660576772, 31200.531992019685, 32507.512387314684, 33379.666203338624, 33396.49905251375, 30849.0745277642, 30895.69104309018, 30922.85647705109, 31011.224719382197, 31351.21621959469, 32322.191945201557, 32689.836550817094, 32856.178595534344, 33282.33435331231, 33772.15569610681, 27221.59167612527, 29340.0, 29369.412611748074, 29377.412451751272, 29679.703202967696, 22166.778332216472, 22403.21588744386, 22595.5480890378, 22613.773862261165, 22622.886885565465], "prototype.html": [279.2126204104426, 283.6227817003386, 295.3767550468511, 305.9877604895804, 309.32875659818194, 6027.578069535134, 6077.4530292273685, 6156.876862462759, 6202.06968954657, 6251.0310901810235, 6090.847728806771, 6120.908186377208, 6153.077038444236, 6164.876702465948, 6172.7530898764, 4726.409198850144, 4731.4795372509, 4744.620430365562, 4781.258904869734, 4787.257975013861, 4725.834595789148, 4725.8582242532775, 4769.260764581478, 4769.833055843046, 4808.110499557575, 4355.128974205156, 4527.275635898257, 4564.269716845305, 4603.516630753773, 4609.70036947599, 4542.523035081302, 4584.839530616429, 4592.632589392841, 4593.150267200579, 4612.446506419217, 3842.231553689245, 3853.325668008087, 3858.498395208605, 3858.9614103858885, 3898.3372826619543, 5854.238948936653, 5931.673757943311, 5936.376680448577, 5939.0, 5950.976667932923, 4976.552110310054, 5138.075146473633, 5141.665791723526, 5179.974100129513, 5185.714785686786, 6254.6872656366995, 6261.24865016201, 6313.116163737034, 6342.39747224013, 6364.936350636481, 4189.329707246857, 4214.557471465513, 4222.725522841006, 4224.197402493516, 4249.235137675218, 6104.175936248594, 6555.0, 6700.966495167541, 6739.932600673979, 6750.426213771835, 4246.575342465729, 4274.444322238089, 4289.806958686867, 4342.131573685276, 4349.282368409177, 4383.715058521249, 4389.3635422864145, 4397.120575884772, 4434.467863856358, 4440.533743956903, 5016.172331565251, 5111.3355263815465, 5123.436421993578, 5149.485051494896, 5191.351081114861, 6102.237220347457, 6335.018072198816, 6358.109864618957, 6441.227052753699, 6442.549021568539, 1510.5015344936144, 1532.540237928617, 1534.4399294257516, 1547.203190356967, 1565.2721484509757, 964.5322018820866, 964.6334392930642, 972.0134063925121, 977.4184360305607, 988.3526290279879, 6043.697815109315, 6077.027675571887, 6085.421884920926, 6097.2683278006925, 6138.938610613836, 6562.901556476657, 6630.303818099127, 6634.701438435282, 6700.262971073178, 6732.899006514906, 6057.091436284592, 6070.696465176812, 6093.329733729375, 6119.541034422347, 6159.81520554384, 3484.982575087108, 3602.5496812898386, 3608.711303095746, 3617.4935509028755, 3629.491871138043, 6864.897026544606, 6874.450043996469, 6958.443324534025, 6977.33715297046, 7001.36987671112, 6845.418139458202, 6892.689828957709, 6898.0, 6925.891857302808, 6947.444204463631, 6684.565503242274, 6884.105066341343, 6974.476914231453, 6988.685509151998, 7004.229534751174, 6707.0, 6725.9663701681175, 6764.492663050192, 6789.660516974231, 6816.795496135124, 6337.90493142594, 6536.052272420377, 6603.240627327918, 6609.570377925419, 6642.43539299165, 6804.897926531205, 6922.619255940972, 6933.341332573397, 6967.581945083311, 7005.124359455068, 4307.418498502788, 4310.978445107879, 4347.934780978225, 4351.695381323277, 4384.627306678968, 6685.933140668531, 6754.93245067543, 6764.93235067643, 6773.661316934035, 6793.66031698423, 6277.089821975696, 6439.356064393523, 6466.482681385572, 6512.381323774234, 6567.835804104936, 6443.548951573345, 6504.60972341661, 6513.706883190173, 6519.152510173837, 6526.379993900572, 6319.46284565817, 6324.241091068917, 6371.458426033839, 6376.39424254695, 6399.072134540373, 6350.872982540416, 6486.383793539606, 6513.7068831903625, 6533.640649764308, 6569.835754106186, 6342.429181373698, 6348.079528468438, 6401.743930242925, 6409.262934762562, 6418.614883107029], "yui.html": [572.5677113779096, 714.7426926306532, 715.9248278930713, 729.9744508942184, 758.2947858491602, 12105.697357566065, 12132.636020919364, 12262.754744905096, 12367.072469564784, 12419.56531521397, 11382.7154321142, 11392.772144557104, 11436.485358158881, 11508.827367589492, 11610.477528511215, 845.1464021338462, 848.495145388496, 860.311750599521, 866.4931015355993, 870.1168314161132, 850.3239924260228, 874.2699845628907, 874.6064271078009, 879.7184900831736, 879.8460269452852, 890.4301247201796, 901.2699713232303, 906.5467266366817, 906.6600024990629, 906.8050369170627, 892.7455675132557, 893.423741686615, 893.6202114101546, 894.4230971023718, 897.5018864530183, 660.8017594721564, 661.1240106858384, 663.4460225711537, 664.3821246240994, 665.3446355339986, 12318.137730358878, 12344.567940122053, 12380.690482738004, 12384.318862462651, 12421.130520863544, 11070.501827417705, 11125.666230013112, 11321.547138114547, 11410.315381077162, 11513.07895368377, 9082.09179082093, 9092.8636070459, 9145.222656074242, 9261.19606433866, 9378.85931711025, 3197.776155669104, 3275.164832967578, 3276.541284220211, 3310.0566338593385, 3355.9664403355896, 43333.349999750026, 44521.33218001733, 47698.0, 47903.76048119772, 48055.75972120117, 8482.0, 8627.180417860292, 8727.65089396417, 8745.081766414562, 8786.780330491662, 18939.33712320062, 18988.05059747035, 19072.61854762925, 19102.52243693891, 19113.61772764537, 6702.765403210962, 6983.546069505466, 7062.823429414306, 7081.610511421818, 7129.215786263507, 3407.505911642798, 3516.701080408194, 3587.192881601671, 3590.8922732318074, 3597.6941959933697, 3043.8173709577054, 3064.1879901826032, 3080.2915329474345, 3086.2901532647616, 3100.8139511629374, 417.1136335287514, 418.9895252618709, 425.9403683484315, 432.0300924424624, 433.6530775379684, 464.62365483958104, 542.3600151820889, 543.6086018066985, 554.2434576802635, 574.9683767392834, 7285.562866228043, 7444.813879653052, 7956.164602716747, 8091.0695270043525, 8099.716509922125, 433.82213292549903, 460.4359659417254, 475.1328824894581, 523.8297553295195, 537.2156651289083, 3503.1242189452637, 3556.8577256909434, 3561.216532362876, 3600.6399360063783, 3669.559652841676, 56033.43966560364, 56610.71694641501, 56749.71625141848, 56977.14534281989, 57060.42939570634, 49977.25034124491, 50940.490595094314, 51042.74478627658, 51318.0, 51526.74236628793, 43433.13133737307, 43544.0, 43890.56109438992, 44131.55868441275, 45552.3167152493, 7312.96343518279, 7319.926800731924, 7335.633218339169, 7379.778606641809, 7437.330640242404, 33256.50115248225, 33540.0, 33803.83098084494, 34508.48237276392, 34575.0, 40006.39990400088, 41362.58637413708, 44765.0, 46101.0, 46356.07287854292, 6753.662316884234, 6773.661316934232, 6844.657767111724, 6862.0, 6887.862242755217, 9763.267754918268, 9862.85205721929, 10005.699829005142, 10063.194944404577, 10198.18414526851, 9088.863667044867, 9285.767855803659, 9377.249820014518, 9519.190868776232, 9569.043095690375, 9328.486933218737, 9504.04959504044, 9607.903920960702, 9728.610855565981, 9817.754556135867, 8898.42160259581, 8899.332550058642, 9014.034004322835, 9136.725898223063, 9540.189083927666, 7880.684772609261, 7973.561454120079, 7998.520088794691, 8076.313513351431, 8214.58927053633, 8058.274755271819, 8115.513069215866, 8196.918030819616, 8301.46040507365, 8361.205685459872]}, "summary": {"lowerIsBetter": false, "suite": 6206.693869302706, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6126.37130859678, "unit": "ms", "value": 6126.37130859678}, "dojo.html": {"lowerIsBetter": false, "filtered": 4976.822670358476, "unit": "ms", "value": 4976.822670358476}, "mootools.html": {"lowerIsBetter": false, "filtered": 4028.5185021088914, "unit": "ms", "value": 4028.5185021088914}, "ext.html": {"lowerIsBetter": false, "filtered": 17109.137522962432, "unit": "ms", "value": 17109.137522962432}, "prototype.html": {"lowerIsBetter": false, "filtered": 4780.098735427086, "unit": "ms", "value": 4780.098735427086}, "yui.html": {"lowerIsBetter": false, "filtered": 5690.5920377043, "unit": "ms", "value": 5690.5920377043}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0010.e"}, "testrun": {"date": 1447374777, "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": [165.0, 166.0, 164.0, 164.0, 167.0, 167.0, 168.0, 173.0, 170.0, 168.0], "ai-astar": [110.0, 101.0, 109.0, 108.0, 107.0, 119.0, 110.0, 108.0, 109.0, 110.0], "imaging-gaussian-blur": [121.0, 117.0, 115.0, 115.0, 131.0, 116.0, 125.0, 124.0, 124.0, 124.0], "audio-beat-detection": [154.0, 132.0, 153.0, 163.0, 130.0, 148.0, 146.0, 131.0, 170.0, 128.0], "json-stringify-tinderbox": [69.0, 72.0, 70.0, 72.0, 69.0, 69.0, 70.0, 69.0, 74.0, 70.0], "stanford-crypto-pbkdf2": [158.0, 157.0, 157.0, 158.0, 162.0, 168.0, 173.0, 160.0, 169.0, 160.0], "json-parse-financial": [62.0, 62.0, 61.0, 63.0, 62.0, 61.0, 66.0, 69.0, 63.0, 65.0], "stanford-crypto-sha256-iterative": [70.0, 72.0, 71.0, 71.0, 72.0, 70.0, 71.0, 70.0, 71.0, 72.0], "audio-fft": [74.0, 75.0, 79.0, 66.0, 72.0, 72.0, 71.0, 125.0, 67.0, 69.0], "imaging-darkroom": [128.0, 136.0, 127.0, 128.0, 129.0, 136.0, 137.0, 137.0, 138.0, 137.0], "stanford-crypto-ccm": [127.0, 126.0, 129.0, 131.0, 138.0, 149.0, 153.0, 149.0, 146.0, 150.0], "audio-oscillator": [89.0, 89.0, 128.0, 89.0, 89.0, 91.0, 127.0, 91.0, 89.0, 138.0], "stanford-crypto-aes": [86.0, 87.0, 87.0, 86.0, 86.0, 86.0, 90.0, 93.0, 94.0, 93.0], "imaging-desaturate": [101.0, 108.0, 96.0, 109.0, 105.0, 104.0, 120.0, 107.0, 117.0, 105.0]}, "summary": {"lowerIsBetter": true, "suite": 1558.1000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 77.0, "unit": "ms", "value": 77.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 162.2, "unit": "ms", "value": 162.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.5, "unit": "ms", "value": 145.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 139.8, "unit": "ms", "value": 139.8}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 133.3, "unit": "ms", "value": 133.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.4, "unit": "ms", "value": 63.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.0, "unit": "ms", "value": 102.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 167.2, "unit": "ms", "value": 167.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.0, "unit": "ms", "value": 71.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.4, "unit": "ms", "value": 70.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 121.2, "unit": "ms", "value": 121.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 88.8, "unit": "ms", "value": 88.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 107.2, "unit": "ms", "value": 107.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0010.e"}, "testrun": {"date": 1447374777, "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": [197.35543714229328], "Encrypt": [341.29692832764505], "NavierStokes": [5928.994082840237], "Decrypt": [5797.687861271676], "Splay": [651.8087855297158], "Richards": [166.58337497917708], "RegExp": [30393.939393939392], "Earley": [862.8127696289905], "Boyer": [13944.444444444445], "RayTrace": [1146.788990825688]}, "summary": {"lowerIsBetter": false, "suite": 18942.647376017703, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 335.019906, "unit": "score", "value": 335.019906}, "Encrypt": {"lowerIsBetter": false, "filtered": 779.9103299999999, "unit": "score", "value": 779.9103299999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 250.29540918163664, "unit": "score", "value": 250.29540918163664}, "Decrypt": {"lowerIsBetter": false, "filtered": 45.91157826520441, "unit": "score", "value": 45.91157826520441}, "Splay": {"lowerIsBetter": false, "filtered": 125.0228622398414, "unit": "score", "value": 125.0228622398414}, "RegExp": {"lowerIsBetter": false, "filtered": 29.972587238285126, "unit": "score", "value": 29.972587238285126}, "Richards": {"lowerIsBetter": false, "filtered": 211.91790600000007, "unit": "score", "value": 211.91790600000007}, "Earley": {"lowerIsBetter": false, "filtered": 772.4306169999998, "unit": "score", "value": 772.4306169999998}, "Boyer": {"lowerIsBetter": false, "filtered": 47.79415936254977, "unit": "score", "value": 47.79415936254977}, "RayTrace": {"lowerIsBetter": false, "filtered": 645.2704079999999, "unit": "score", "value": 645.2704079999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0010.e"}, "testrun": {"date": 1447374777, "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:05 INFO - RETURN: dromaeo_css: 6206.69 16:53:05 INFO - RETURN: kraken: 1558.10 16:53:05 INFO - RETURN: v8_7: 18942.65 16:53:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "18942.65"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1558.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "6206.69"}}} 16:53:05 INFO - Return code: 0 16:53:05 INFO - # TBPL SUCCESS # 16:53:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:53:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:53:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:53:05 INFO - 2015-11-12 16:53:05.837 screenresolution[2299:24583] starting screenresolution argv=screenresolution get 16:53:05 INFO - 2015-11-12 16:53:05.840 screenresolution[2299:24583] Display 0: 1600x1200x32@60 16:53:05 INFO - 2015-11-12 16:53:05.847 screenresolution[2300:24587] starting screenresolution argv=screenresolution list 16:53:05 INFO - Available Modes on Display 0 16:53:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:53:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:53:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:53:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:53:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:53:06 INFO - Intel HD Graphics 3000: 16:53:06 INFO - Chipset Model: Intel HD Graphics 3000 16:53:06 INFO - Type: GPU 16:53:06 INFO - Bus: Built-In 16:53:06 INFO - VRAM (Total): 512 MB 16:53:06 INFO - VRAM (Dynamic, Max): 10 16:53:06 INFO - Vendor: Intel (0x8086) 16:53:06 INFO - Device ID: 0x0116 16:53:06 INFO - Revision ID: 0x0009 16:53:06 INFO - Displays: 16:53:06 INFO - Display: 16:53:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:53:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:53:06 INFO - Display Serial Number: 1600x1200 60 16:53:06 INFO - Main Display: Yes 16:53:06 INFO - Mirror: Off 16:53:06 INFO - Online: Yes 16:53:06 INFO - Rotation: Supported 16:53:06 INFO - Return code: 0 16:53:06 INFO - Running post-action listener: _resource_record_post_action 16:53:06 INFO - Running post-run listener: _resource_record_post_run 16:53:07 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 2273280; Write bytes: 691576832; Read time: 1147; Write time: 81249 16:53:07 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 342155776; Write bytes: 344922112; Read time: 33782; Write time: 10115 16:53:07 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 2224128; Write bytes: 344844288; Read time: 1044; Write time: 71117 16:53:07 INFO - Running post-run listener: _upload_blobber_files 16:53:07 INFO - Blob upload gear active. 16:53:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:53:07 INFO - Copying logs to upload dir... 16:53:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1300.483860 ========= master_lag: 3.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2015-11-12 16:53:10.370190) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 16:53:10.373683) ========= 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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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.010089 build_url: 'https://queue.taskcluster.net/v1/task/B-EcTReJQe6l1yxoSQezkA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 16:53:10.401679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:53:10.402048) ========= 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.kQQG2KzkAC/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.Ia5gMGr6Vd/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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.005149 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 16:53:10.452519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 16:53:10.452876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 16:53:10.453384) ========= ========= Total master_lag: 3.36 =========