builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0039 starttime: 1447176251.87 results: success (0) buildid: 20151110075834 builduid: 2e6c784861f447518b9db736edae7ee9 revision: 348be28b64b62abc5b3b0a45de9575a7f754d5b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:11.872340) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:11.872790) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:11.873082) ========= 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.s0HbaskrWk/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.BNWLj0HsoE/Listeners TMPDIR=/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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.006391 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:11.982018) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:11.982308) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:11.998496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2015-11-10 09:24:11.998783) ========= 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.s0HbaskrWk/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.BNWLj0HsoE/Listeners TMPDIR=/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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.005651 ========= master_lag: 5.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2015-11-10 09:24:17.157032) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:17.157378) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:17.157782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:17.158066) ========= 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.s0HbaskrWk/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.BNWLj0HsoE/Listeners TMPDIR=/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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-10 09:24:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.45M=0.002s 2015-11-10 09:24:17 (7.45 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145105 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:17.327057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:17.327387) ========= 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.s0HbaskrWk/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.BNWLj0HsoE/Listeners TMPDIR=/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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.020945 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:17.376249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-11-10 09:24:17.376611) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 348be28b64b62abc5b3b0a45de9575a7f754d5b6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 348be28b64b62abc5b3b0a45de9575a7f754d5b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s0HbaskrWk/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.BNWLj0HsoE/Listeners TMPDIR=/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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-10 09:24:17,453 truncating revision to first 12 chars 2015-11-10 09:24:17,454 Setting DEBUG logging. 2015-11-10 09:24:17,454 attempt 1/10 2015-11-10 09:24:17,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/348be28b64b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-10 09:24:17,723 unpacking tar archive at: mozilla-aurora-348be28b64b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538836 ========= master_lag: 4.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-11-10 09:24:22.027401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2015-11-10 09:24:22.027733) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2015-11-10 09:24:23.378579) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:23.378907) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 09:24:23.379400) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-10 09:24:23.379715) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s0HbaskrWk/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.BNWLj0HsoE/Listeners TMPDIR=/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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 09:24:23 INFO - MultiFileLogger online at 20151110 09:24:23 in /builds/slave/test 09:24:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:24:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:23 INFO - {'append_to_log': False, 09:24:23 INFO - 'base_work_dir': '/builds/slave/test', 09:24:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:24:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:23 INFO - 'branch': 'Mozilla-Aurora', 09:24:23 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:23 INFO - 'config_files': ('talos/mac_config.py',), 09:24:23 INFO - 'default_actions': ('clobber', 09:24:23 INFO - 'read-buildbot-config', 09:24:23 INFO - 'download-and-extract', 09:24:23 INFO - 'populate-webroot', 09:24:23 INFO - 'create-virtualenv', 09:24:23 INFO - 'install', 09:24:23 INFO - 'run-tests'), 09:24:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:23 INFO - 'download_minidump_stackwalk': True, 09:24:23 INFO - 'download_symbols': 'ondemand', 09:24:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:23 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:23 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:23 INFO - 'installer_path': 'installer.exe', 09:24:23 INFO - 'log_level': 'info', 09:24:23 INFO - 'log_name': 'talos', 09:24:23 INFO - 'log_to_console': True, 09:24:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:24:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:24:23 INFO - 'opt_config_files': (), 09:24:23 INFO - 'pip_index': False, 09:24:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:23 INFO - 'cmd': ('bash', 09:24:23 INFO - '-c', 09:24:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:23 INFO - 'enabled': True, 09:24:23 INFO - 'halt_on_failure': False, 09:24:23 INFO - 'name': 'check_screen_resolution'},), 09:24:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:23 INFO - 'cmd': ('bash', 09:24:23 INFO - '-c', 09:24:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:23 INFO - 'enabled': True, 09:24:23 INFO - 'halt_on_failure': False, 09:24:23 INFO - 'name': 'check_screen_resolution'},), 09:24:23 INFO - 'run_cmd_checks_enabled': True, 09:24:23 INFO - 'sps_profile': False, 09:24:23 INFO - 'sps_profile_interval': 0, 09:24:23 INFO - 'suite': 'dromaeojs', 09:24:23 INFO - 'system_bits': '64', 09:24:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:23 INFO - 'title': 't-yosemite-r5-0039', 09:24:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:23 INFO - 'use_talos_json': True, 09:24:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:23 INFO - 'work_dir': 'build'} 09:24:23 INFO - ##### 09:24:23 INFO - ##### Running clobber step. 09:24:23 INFO - ##### 09:24:23 INFO - Running pre-action listener: _resource_record_pre_action 09:24:23 INFO - Running main action method: clobber 09:24:23 INFO - rmtree: /builds/slave/test/build 09:24:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:25 INFO - Running post-action listener: _resource_record_post_action 09:24:25 INFO - ##### 09:24:25 INFO - ##### Running read-buildbot-config step. 09:24:25 INFO - ##### 09:24:25 INFO - Running pre-action listener: _resource_record_pre_action 09:24:25 INFO - Running main action method: read_buildbot_config 09:24:25 INFO - Using buildbot properties: 09:24:25 INFO - { 09:24:25 INFO - "properties": { 09:24:25 INFO - "buildnumber": 412, 09:24:25 INFO - "product": "firefox", 09:24:25 INFO - "script_repo_revision": "production", 09:24:25 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 09:24:25 INFO - "repository": "", 09:24:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 09:24:25 INFO - "buildid": "20151110075834", 09:24:25 INFO - "slavename": "t-yosemite-r5-0039", 09:24:25 INFO - "pgo_build": "False", 09:24:25 INFO - "basedir": "/builds/slave/test", 09:24:25 INFO - "project": "", 09:24:25 INFO - "platform": "yosemite", 09:24:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:24:25 INFO - "slavebuilddir": "test", 09:24:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:24:25 INFO - "branch": "mozilla-aurora", 09:24:25 INFO - "repo_path": "releases/mozilla-aurora", 09:24:25 INFO - "stage_platform": "macosx64", 09:24:25 INFO - "builduid": "2e6c784861f447518b9db736edae7ee9", 09:24:25 INFO - "revision": "348be28b64b62abc5b3b0a45de9575a7f754d5b6" 09:24:25 INFO - }, 09:24:25 INFO - "sourcestamp": { 09:24:25 INFO - "repository": "", 09:24:25 INFO - "hasPatch": false, 09:24:25 INFO - "project": "", 09:24:25 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:24:25 INFO - "changes": [ 09:24:25 INFO - { 09:24:25 INFO - "category": null, 09:24:25 INFO - "files": [ 09:24:25 INFO - { 09:24:25 INFO - "url": null, 09:24:25 INFO - "name": "https://queue.taskcluster.net/v1/task/cnV2MOr8Tw2P05aiytn23w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 09:24:25 INFO - } 09:24:25 INFO - ], 09:24:25 INFO - "repository": "", 09:24:25 INFO - "rev": "e42e1ac395ae2f1fdd48975966e391914522b545", 09:24:25 INFO - "who": "bkelly@mozilla.com", 09:24:25 INFO - "when": 1447175777, 09:24:25 INFO - "number": 6643500, 09:24:25 INFO - "comments": "Bug 1202085 - Part 6: Clear the entries in the image cache belonging to a controlled document when it gets destroyed; r=seth a=ritu", 09:24:25 INFO - "project": "", 09:24:25 INFO - "at": "Tue 10 Nov 2015 09:16:17", 09:24:25 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:24:25 INFO - "revlink": "", 09:24:25 INFO - "properties": [ 09:24:25 INFO - [ 09:24:25 INFO - "buildid", 09:24:25 INFO - "20151110075232", 09:24:25 INFO - "Change" 09:24:25 INFO - ], 09:24:25 INFO - [ 09:24:25 INFO - "builduid", 09:24:25 INFO - "a124a0aaddfc4a3dbc952f110651138e", 09:24:25 INFO - "Change" 09:24:25 INFO - ], 09:24:25 INFO - [ 09:24:25 INFO - "pgo_build", 09:24:25 INFO - "False", 09:24:25 INFO - "Change" 09:24:25 INFO - ] 09:24:25 INFO - ], 09:24:25 INFO - "revision": "e42e1ac395ae2f1fdd48975966e391914522b545" 09:24:25 INFO - }, 09:24:25 INFO - { 09:24:25 INFO - "category": null, 09:24:25 INFO - "files": [ 09:24:25 INFO - { 09:24:25 INFO - "url": null, 09:24:25 INFO - "name": "https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 09:24:25 INFO - } 09:24:25 INFO - ], 09:24:25 INFO - "repository": "", 09:24:25 INFO - "rev": "348be28b64b62abc5b3b0a45de9575a7f754d5b6", 09:24:25 INFO - "who": "cbook@mozilla.com", 09:24:25 INFO - "when": 1447175954, 09:24:25 INFO - "number": 6643515, 09:24:25 INFO - "comments": "Bug 1205704 - Show an icon and tooltip when animations are running on the compositor; r=tromey, a=ritu", 09:24:25 INFO - "project": "", 09:24:25 INFO - "at": "Tue 10 Nov 2015 09:19:14", 09:24:25 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:24:25 INFO - "revlink": "", 09:24:25 INFO - "properties": [ 09:24:25 INFO - [ 09:24:25 INFO - "buildid", 09:24:25 INFO - "20151110075834", 09:24:25 INFO - "Change" 09:24:25 INFO - ], 09:24:25 INFO - [ 09:24:25 INFO - "builduid", 09:24:25 INFO - "2e6c784861f447518b9db736edae7ee9", 09:24:25 INFO - "Change" 09:24:25 INFO - ], 09:24:25 INFO - [ 09:24:25 INFO - "pgo_build", 09:24:25 INFO - "False", 09:24:25 INFO - "Change" 09:24:25 INFO - ] 09:24:25 INFO - ], 09:24:25 INFO - "revision": "348be28b64b62abc5b3b0a45de9575a7f754d5b6" 09:24:25 INFO - } 09:24:25 INFO - ], 09:24:25 INFO - "revision": "348be28b64b62abc5b3b0a45de9575a7f754d5b6" 09:24:25 INFO - } 09:24:25 INFO - } 09:24:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 09:24:25 INFO - Running post-action listener: _resource_record_post_action 09:24:25 INFO - ##### 09:24:25 INFO - ##### Running download-and-extract step. 09:24:25 INFO - ##### 09:24:25 INFO - Running pre-action listener: _resource_record_pre_action 09:24:25 INFO - Running main action method: download_and_extract 09:24:25 INFO - mkdir: /builds/slave/test/build/tests 09:24:25 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')]} 09:24:25 INFO - https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:24:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/test_packages.json 09:24:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/test_packages.json 09:24:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:24:26 INFO - Downloaded 1149 bytes. 09:24:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:24:26 INFO - Using the following test package requirements: 09:24:26 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:24:26 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 09:24:26 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:26 INFO - u'jsshell-mac.zip'], 09:24:26 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 09:24:26 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:24:26 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 09:24:26 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 09:24:26 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 09:24:26 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:24:26 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 09:24:26 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:26 INFO - https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:24:27 INFO - Downloaded 17446194 bytes. 09:24:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:24:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 09:24:33 INFO - Return code: 0 09:24:33 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:33 INFO - https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:24:34 INFO - Downloaded 17446194 bytes. 09:24:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:24:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:24:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 09:24:41 INFO - Return code: 0 09:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:41 INFO - https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:24:42 INFO - Downloaded 11131307 bytes. 09:24:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 09:24:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:24:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:24:42 INFO - Return code: 0 09:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:42 INFO - https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 09:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 09:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 09:24:46 INFO - Downloaded 107699765 bytes. 09:24:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:24:46 INFO - mkdir: /builds/slave/test/properties 09:24:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:46 INFO - Contents: 09:24:46 INFO - build_url:https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:24:46 INFO - Running post-action listener: _resource_record_post_action 09:24:46 INFO - Running post-action listener: set_extra_try_arguments 09:24:46 INFO - ##### 09:24:46 INFO - ##### Running populate-webroot step. 09:24:46 INFO - ##### 09:24:46 INFO - Running pre-action listener: _resource_record_pre_action 09:24:46 INFO - Running main action method: populate_webroot 09:24:46 INFO - Guessing talos json url... 09:24: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')]} 09:24:46 INFO - https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 09:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 09:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 09:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 09:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 09:24:46 INFO - Downloaded 107 bytes. 09:24:46 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 09:24:46 INFO - Contents: 09:24:46 INFO - 20151110075834 09:24:46 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/348be28b64b62abc5b3b0a45de9575a7f754d5b6 09:24: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')]} 09:24:46 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/348be28b64/testing/talos/talos.json 09:24:46 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/348be28b64/testing/talos/talos.json to /builds/slave/test/build/talos.json 09:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/348be28b64/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 09:24:47 INFO - Downloaded 4264 bytes. 09:24:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:24:47 INFO - '../fennec_ids.txt'], 09:24:47 INFO - 'tests': ['tcheck2']}, 09:24:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:47 INFO - '--tppagecycles', 09:24:47 INFO - '7'], 09:24:47 INFO - 'tests': ['tsvgm']}}, 09:24:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:24:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:24:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:24:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:47 INFO - 'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:47 INFO - 'tests': ['damp', 'tps']}, 09:24:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:47 INFO - 'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['damp', 'tps']}, 09:24:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:24:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:47 INFO - 'other': {'tests': ['a11yr', 09:24:47 INFO - 'ts_paint', 09:24:47 INFO - 'tpaint', 09:24:47 INFO - 'sessionrestore', 09:24:47 INFO - 'sessionrestore_no_auto_restore']}, 09:24:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['a11yr', 09:24:47 INFO - 'ts_paint', 09:24:47 INFO - 'tpaint', 09:24:47 INFO - 'sessionrestore', 09:24:47 INFO - 'sessionrestore_no_auto_restore']}, 09:24:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['a11yr', 09:24:47 INFO - 'ts_paint', 09:24:47 INFO - 'tpaint', 09:24:47 INFO - 'sessionrestore', 09:24:47 INFO - 'sessionrestore_no_auto_restore']}, 09:24:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['a11yr', 09:24:47 INFO - 'ts_paint', 09:24:47 INFO - 'tpaint', 09:24:47 INFO - 'sessionrestore', 09:24:47 INFO - 'sessionrestore_no_auto_restore']}, 09:24:47 INFO - 'other_l64': {'tests': ['a11yr', 09:24:47 INFO - 'ts_paint', 09:24:47 INFO - 'tpaint', 09:24:47 INFO - 'sessionrestore', 09:24:47 INFO - 'sessionrestore_no_auto_restore']}, 09:24:47 INFO - 'other_nol64': {'tests': ['a11yr', 09:24:47 INFO - 'ts_paint', 09:24:47 INFO - 'tpaint', 09:24:47 INFO - 'sessionrestore', 09:24:47 INFO - 'sessionrestore_no_auto_restore']}, 09:24:47 INFO - 'svgr': {'tests': ['tsvgx', 09:24:47 INFO - 'tsvgr_opacity', 09:24:47 INFO - 'tart', 09:24:47 INFO - 'tscrollx', 09:24:47 INFO - 'cart']}, 09:24:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['tsvgx', 09:24:47 INFO - 'tsvgr_opacity', 09:24:47 INFO - 'tart', 09:24:47 INFO - 'tscrollx', 09:24:47 INFO - 'cart']}, 09:24:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:47 INFO - 'tests': ['tp5o']}, 09:24:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:47 INFO - 'talos_options': ['--e10s'], 09:24:47 INFO - 'tests': ['tp5o']}, 09:24:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:47 INFO - 'talos_options': ['--xperf_path', 09:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:47 INFO - 'tests': ['tp5n']}, 09:24:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:47 INFO - 'talos_options': ['--e10s', 09:24:47 INFO - '--xperf_path', 09:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 09:24:47 INFO - 'C:/slave/talos-data/talos/xperf.config'], 09:24:47 INFO - 'tests': ['tp5n']}}, 09:24:47 INFO - 'talos.zip': {'path': '', 09:24:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:47 INFO - Running post-action listener: _resource_record_post_action 09:24:47 INFO - ##### 09:24:47 INFO - ##### Running create-virtualenv step. 09:24:47 INFO - ##### 09:24:47 INFO - Running pre-action listener: _resource_record_pre_action 09:24:47 INFO - Running main action method: create_virtualenv 09:24:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:47 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 09:24:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:47 INFO - Using real prefix '/tools/python27' 09:24:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:52 INFO - Installing pip.................done. 09:24:52 INFO - Return code: 0 09:24:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:52 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')]} 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 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')]} 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 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 0x103711a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10377e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb89bd8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c69f0>, '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 0x103425cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103690990>, '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.s0HbaskrWk/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.BNWLj0HsoE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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 09:24:52 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 09:24:52 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 09:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0HbaskrWk/Render', 09:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:52 INFO - 'HOME': '/Users/cltbld', 09:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:52 INFO - 'LOGNAME': 'cltbld', 09:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:52 INFO - 'MOZ_NO_REMOTE': '1', 09:24:52 INFO - 'NO_EM_RESTART': '1', 09:24:52 INFO - 'PAGER': '/bin/cat', 09:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:52 INFO - 'PWD': '/builds/slave/test', 09:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:52 INFO - 'SHELL': '/bin/bash', 09:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BNWLj0HsoE/Listeners', 09:24:52 INFO - 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/', 09:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:52 INFO - 'USER': 'cltbld', 09:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:52 INFO - 'XPC_FLAGS': '0x0', 09:24:52 INFO - 'XPC_SERVICE_NAME': '0', 09:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:52 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 09:24:52 INFO - Cleaning up... 09:24:52 INFO - Return code: 0 09:24:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:24:52 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')]} 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 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')]} 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 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 0x103711a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10377e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb89bd8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c69f0>, '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 0x103425cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103690990>, '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.s0HbaskrWk/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.BNWLj0HsoE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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 09:24:52 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 09:24:52 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 09:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0HbaskrWk/Render', 09:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:52 INFO - 'HOME': '/Users/cltbld', 09:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:52 INFO - 'LOGNAME': 'cltbld', 09:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:52 INFO - 'MOZ_NO_REMOTE': '1', 09:24:52 INFO - 'NO_EM_RESTART': '1', 09:24:52 INFO - 'PAGER': '/bin/cat', 09:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:52 INFO - 'PWD': '/builds/slave/test', 09:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:52 INFO - 'SHELL': '/bin/bash', 09:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BNWLj0HsoE/Listeners', 09:24:52 INFO - 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/', 09:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:52 INFO - 'USER': 'cltbld', 09:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:52 INFO - 'XPC_FLAGS': '0x0', 09:24:52 INFO - 'XPC_SERVICE_NAME': '0', 09:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:52 INFO - Downloading/unpacking psutil>=0.7.1 09:24:52 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 09:24:52 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 09:24:52 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 09:24:52 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 09:24:52 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 09:24:52 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 09:24:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:24:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:55 INFO - Installing collected packages: psutil 09:24:55 INFO - Running setup.py install for psutil 09:24:55 INFO - building 'psutil._psutil_osx' extension 09:24:55 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 09:24:56 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 09:24:56 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 09:24:56 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 09:24:56 INFO - building 'psutil._psutil_posix' extension 09:24:56 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 09:24:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:56 INFO - ^ 09:24:56 INFO - 1 warning generated. 09:24:56 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 09:24:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:56 INFO - Successfully installed psutil 09:24:56 INFO - Cleaning up... 09:24:56 INFO - Return code: 0 09:24:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:24:56 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')]} 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 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')]} 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 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 0x103711a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10377e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb89bd8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c69f0>, '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 0x103425cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103690990>, '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.s0HbaskrWk/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.BNWLj0HsoE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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 09:24:56 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 09:24:56 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 09:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0HbaskrWk/Render', 09:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:56 INFO - 'HOME': '/Users/cltbld', 09:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:56 INFO - 'LOGNAME': 'cltbld', 09:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:56 INFO - 'MOZ_NO_REMOTE': '1', 09:24:56 INFO - 'NO_EM_RESTART': '1', 09:24:56 INFO - 'PAGER': '/bin/cat', 09:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:56 INFO - 'PWD': '/builds/slave/test', 09:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:56 INFO - 'SHELL': '/bin/bash', 09:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BNWLj0HsoE/Listeners', 09:24:56 INFO - 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/', 09:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:56 INFO - 'USER': 'cltbld', 09:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:56 INFO - 'XPC_FLAGS': '0x0', 09:24:56 INFO - 'XPC_SERVICE_NAME': '0', 09:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:24:57 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 09:24:57 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 09:24:57 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 09:24:57 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 09:24:57 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 09:24:57 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 09:24:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:24:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:24:59 INFO - Installing collected packages: mozsystemmonitor 09:24:59 INFO - Running setup.py install for mozsystemmonitor 09:24:59 INFO - Successfully installed mozsystemmonitor 09:24:59 INFO - Cleaning up... 09:24:59 INFO - Return code: 0 09:24:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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', '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 0x103711a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10377e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb89bd8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c69f0>, '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 0x103425cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103690990>, '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.s0HbaskrWk/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.BNWLj0HsoE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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 09:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24: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 blobuploader==1.2.4 09:24:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0HbaskrWk/Render', 09:24:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:59 INFO - 'HOME': '/Users/cltbld', 09:24:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:59 INFO - 'LOGNAME': 'cltbld', 09:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:59 INFO - 'MOZ_NO_REMOTE': '1', 09:24:59 INFO - 'NO_EM_RESTART': '1', 09:24:59 INFO - 'PAGER': '/bin/cat', 09:24:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:59 INFO - 'PWD': '/builds/slave/test', 09:24:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:59 INFO - 'SHELL': '/bin/bash', 09:24:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BNWLj0HsoE/Listeners', 09:24:59 INFO - 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/', 09:24:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:59 INFO - 'USER': 'cltbld', 09:24:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:59 INFO - 'XPC_FLAGS': '0x0', 09:24:59 INFO - 'XPC_SERVICE_NAME': '0', 09:24:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25:02 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 09:25:02 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 09:25:02 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 09:25:02 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 09:25:02 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 09:25:02 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 09:25:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:25:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:04 INFO - Downloading docopt-0.6.1.tar.gz 09:25:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:04 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:04 INFO - Running setup.py install for blobuploader 09:25:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:25:04 INFO - Running setup.py install for requests 09:25:05 INFO - Running setup.py install for docopt 09:25:05 INFO - Successfully installed blobuploader requests docopt 09:25:05 INFO - Cleaning up... 09:25:05 INFO - Return code: 0 09:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:05 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 0x103711a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10377e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb89bd8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c69f0>, '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 0x103425cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103690990>, '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.s0HbaskrWk/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.BNWLj0HsoE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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 09:25:05 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 09:25:05 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 09:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0HbaskrWk/Render', 09:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:05 INFO - 'HOME': '/Users/cltbld', 09:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:05 INFO - 'LOGNAME': 'cltbld', 09:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:05 INFO - 'MOZ_NO_REMOTE': '1', 09:25:05 INFO - 'NO_EM_RESTART': '1', 09:25:05 INFO - 'PAGER': '/bin/cat', 09:25:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:05 INFO - 'PWD': '/builds/slave/test', 09:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:05 INFO - 'SHELL': '/bin/bash', 09:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BNWLj0HsoE/Listeners', 09:25:05 INFO - 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/', 09:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:05 INFO - 'USER': 'cltbld', 09:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:05 INFO - 'XPC_FLAGS': '0x0', 09:25:05 INFO - 'XPC_SERVICE_NAME': '0', 09:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:05 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-zjswte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:05 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-USIGAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:05 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-HDG3Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:06 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-2EZy7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:06 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-5CmQkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:06 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-O7oJBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:06 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-wQxLyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:06 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-MBBOVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:06 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-06RWVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:06 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-nUrT06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:06 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-1rGWA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:07 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-c_zT8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:07 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-OU0bjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:07 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-kKUm1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:07 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-QD1O7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:07 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-IypqvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:07 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-q_fjDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:07 INFO - Running setup.py install for manifestparser 09:25:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:08 INFO - Running setup.py install for mozcrash 09:25:08 INFO - Running setup.py install for mozdebug 09:25:08 INFO - Running setup.py install for mozdevice 09:25:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:08 INFO - Running setup.py install for mozfile 09:25:08 INFO - Running setup.py install for mozhttpd 09:25:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozinfo 09:25:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozInstall 09:25:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozleak 09:25:09 INFO - Running setup.py install for mozlog 09:25:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for moznetwork 09:25:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozprocess 09:25:10 INFO - Running setup.py install for mozprofile 09:25:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Running setup.py install for mozrunner 09:25:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Running setup.py install for mozscreenshot 09:25:10 INFO - Running setup.py install for moztest 09:25:10 INFO - Running setup.py install for mozversion 09:25:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:11 INFO - Cleaning up... 09:25:11 INFO - Return code: 0 09:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:11 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')]} 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:11 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')]} 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:11 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 0x103711a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10377e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb89bd8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c69f0>, '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 0x103425cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103690990>, '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.s0HbaskrWk/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.BNWLj0HsoE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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 09:25:11 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 09:25:11 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 09:25:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0HbaskrWk/Render', 09:25:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:11 INFO - 'HOME': '/Users/cltbld', 09:25:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:11 INFO - 'LOGNAME': 'cltbld', 09:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:11 INFO - 'MOZ_NO_REMOTE': '1', 09:25:11 INFO - 'NO_EM_RESTART': '1', 09:25:11 INFO - 'PAGER': '/bin/cat', 09:25:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:11 INFO - 'PWD': '/builds/slave/test', 09:25:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:11 INFO - 'SHELL': '/bin/bash', 09:25:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BNWLj0HsoE/Listeners', 09:25:11 INFO - 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/', 09:25:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:11 INFO - 'USER': 'cltbld', 09:25:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:11 INFO - 'XPC_FLAGS': '0x0', 09:25:11 INFO - 'XPC_SERVICE_NAME': '0', 09:25:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:11 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-xw9erb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:11 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-RybHc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:11 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-r2mt5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:11 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-Gr_Wlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:12 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-SHKYLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:12 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-KjSnuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:12 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-1FMFpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:12 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-Z0Sw2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:12 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-irZsts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:12 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-fybvYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:12 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-PvmDrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:12 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-Y_FzpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:13 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)) 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:13 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-F0QRG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:13 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)) 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:13 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-yVBfJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:13 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)) 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:13 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-QX9Qxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:13 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)) 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:13 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-ONa0gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:13 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)) 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:13 INFO - Running setup.py (path:/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/pip-DoyH19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:13 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)) 09:25:13 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)) 09:25:13 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)) 09:25:13 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)) 09:25:13 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:25:13 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:25:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:16 INFO - Downloading blessings-1.5.1.tar.gz 09:25:16 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 09:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:16 INFO - Installing collected packages: blessings 09:25:16 INFO - Running setup.py install for blessings 09:25:16 INFO - Successfully installed blessings 09:25:16 INFO - Cleaning up... 09:25:16 INFO - Return code: 0 09:25:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:17 INFO - Reading from file tmpfile_stdout 09:25:17 INFO - Current package versions: 09:25:17 INFO - blessings == 1.5.1 09:25:17 INFO - blobuploader == 1.2.4 09:25:17 INFO - docopt == 0.6.1 09:25:17 INFO - manifestparser == 1.1 09:25:17 INFO - mozInstall == 1.12 09:25:17 INFO - mozcrash == 0.16 09:25:17 INFO - mozdebug == 0.1 09:25:17 INFO - mozdevice == 0.46 09:25:17 INFO - mozfile == 1.2 09:25:17 INFO - mozhttpd == 0.7 09:25:17 INFO - mozinfo == 0.8 09:25:17 INFO - mozleak == 0.1 09:25:17 INFO - mozlog == 3.0 09:25:17 INFO - moznetwork == 0.27 09:25:17 INFO - mozprocess == 0.22 09:25:17 INFO - mozprofile == 0.27 09:25:17 INFO - mozrunner == 6.11 09:25:17 INFO - mozscreenshot == 0.1 09:25:17 INFO - mozsystemmonitor == 0.0 09:25:17 INFO - moztest == 0.7 09:25:17 INFO - mozversion == 1.4 09:25:17 INFO - psutil == 3.1.1 09:25:17 INFO - requests == 1.2.3 09:25:17 INFO - wsgiref == 0.1.2 09:25:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:17 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')]} 09:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:17 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')]} 09:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:17 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 0x103711a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10377e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb89bd8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c69f0>, '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 0x103425cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103690990>, '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.s0HbaskrWk/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.BNWLj0HsoE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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 09:25:17 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 09:25:17 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 09:25:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0HbaskrWk/Render', 09:25:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:17 INFO - 'HOME': '/Users/cltbld', 09:25:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:17 INFO - 'LOGNAME': 'cltbld', 09:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:17 INFO - 'MOZ_NO_REMOTE': '1', 09:25:17 INFO - 'NO_EM_RESTART': '1', 09:25:17 INFO - 'PAGER': '/bin/cat', 09:25:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:17 INFO - 'PWD': '/builds/slave/test', 09:25:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:17 INFO - 'SHELL': '/bin/bash', 09:25:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BNWLj0HsoE/Listeners', 09:25:17 INFO - 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/', 09:25:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:17 INFO - 'USER': 'cltbld', 09:25:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:17 INFO - 'XPC_FLAGS': '0x0', 09:25:17 INFO - 'XPC_SERVICE_NAME': '0', 09:25:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 INFO - Cleaning up... 09:25:17 INFO - Return code: 0 09:25:17 INFO - Running post-action listener: _resource_record_post_action 09:25:17 INFO - Running post-action listener: _start_resource_monitoring 09:25:17 INFO - Starting resource monitoring. 09:25:17 INFO - ##### 09:25:17 INFO - ##### Running install step. 09:25:17 INFO - ##### 09:25:17 INFO - Running pre-action listener: _resource_record_pre_action 09:25:17 INFO - Running main action method: install 09:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:17 INFO - Reading from file tmpfile_stdout 09:25:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:17 INFO - Reading from file tmpfile_stdout 09:25:17 INFO - Output received: 09:25:17 INFO - Usage: mozinstall [options] installer 09:25:17 INFO - Options: 09:25:17 INFO - -h, --help show this help message and exit 09:25:17 INFO - -d DEST, --destination=DEST 09:25:17 INFO - Directory to install application into. [default: 09:25:17 INFO - "/builds/slave/test"] 09:25:17 INFO - --app=APP Application being installed. [default: firefox] 09:25:17 INFO - mkdir: /builds/slave/test/build/application 09:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:25:57 INFO - Reading from file tmpfile_stdout 09:25:57 INFO - Output received: 09:25:57 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:25:57 INFO - Running post-action listener: _resource_record_post_action 09:25:57 INFO - ##### 09:25:57 INFO - ##### Running run-tests step. 09:25:57 INFO - ##### 09:25:57 INFO - Running pre-action listener: _resource_record_pre_action 09:25:57 INFO - Running main action method: run_tests 09:25:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:57 INFO - 2015-11-10 09:25:57.727 screenresolution[1910:11641] starting screenresolution argv=screenresolution get 09:25:57 INFO - 2015-11-10 09:25:57.731 screenresolution[1910:11641] Display 0: 1600x1200x32@60 09:25:57 INFO - 2015-11-10 09:25:57.738 screenresolution[1911:11643] starting screenresolution argv=screenresolution list 09:25:57 INFO - Available Modes on Display 0 09:25:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:58 INFO - Intel HD Graphics 3000: 09:25:58 INFO - Chipset Model: Intel HD Graphics 3000 09:25:58 INFO - Type: GPU 09:25:58 INFO - Bus: Built-In 09:25:58 INFO - VRAM (Total): 512 MB 09:25:58 INFO - VRAM (Dynamic, Max): 10 09:25:58 INFO - Vendor: Intel (0x8086) 09:25:58 INFO - Device ID: 0x0116 09:25:58 INFO - Revision ID: 0x0009 09:25:58 INFO - Displays: 09:25:58 INFO - Display: 09:25:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:58 INFO - Display Serial Number: 1600x1200 60 09:25:58 INFO - Main Display: Yes 09:25:58 INFO - Mirror: Off 09:25:58 INFO - Online: Yes 09:25:58 INFO - Rotation: Supported 09:25:58 INFO - Return code: 0 09:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:58 INFO - Python 2.7.3 09:25:58 INFO - Return code: 0 09:25:58 INFO - grabbing minidump binary from tooltool 09:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:58 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 0x1036c69f0>, '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 0x103425cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103690990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:58 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 09:25:58 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 09:25:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:58 INFO - Return code: 0 09:25:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0039', '--webServer', 'localhost'] in /builds/slave/test/build 09:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0039 --webServer localhost 09:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0HbaskrWk/Render', 09:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:58 INFO - 'HOME': '/Users/cltbld', 09:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:58 INFO - 'LOGNAME': 'cltbld', 09:25:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:58 INFO - 'MOZ_NO_REMOTE': '1', 09:25:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:58 INFO - 'NO_EM_RESTART': '1', 09:25:58 INFO - 'PAGER': '/bin/cat', 09:25:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:58 INFO - 'PWD': '/builds/slave/test', 09:25:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:58 INFO - 'SHELL': '/bin/bash', 09:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BNWLj0HsoE/Listeners', 09:25:58 INFO - 'TMPDIR': '/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/', 09:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:58 INFO - 'USER': 'cltbld', 09:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:58 INFO - 'XPC_FLAGS': '0x0', 09:25:58 INFO - 'XPC_SERVICE_NAME': '0', 09:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:25:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0039', '--webServer', 'localhost'] with output_timeout 3600 09:25:58 INFO - mozversion INFO | application_buildid: 20151110075834 09:25:58 INFO - mozversion INFO | application_changeset: 348be28b64b62abc5b3b0a45de9575a7f754d5b6 09:25:58 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:25:58 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:58 INFO - mozversion INFO | application_name: Firefox 09:25:58 INFO - mozversion INFO | application_remotingname: firefox-dev 09:25:58 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:25:58 INFO - mozversion INFO | application_vendor: Mozilla 09:25:58 INFO - mozversion INFO | application_version: 44.0a2 09:25:58 INFO - mozversion INFO | platform_buildid: 20151110075834 09:25:58 INFO - mozversion INFO | platform_changeset: 348be28b64b62abc5b3b0a45de9575a7f754d5b6 09:25:58 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:25:58 INFO - mozversion INFO | platform_version: 44.0a2 09:25:58 INFO - 2015-11-10 09:25:58,377 DEBUG : using testdate: 1447176358 09:25:58 INFO - 2015-11-10 09:25:58,377 DEBUG : actual date: 1447176358 09:25:58 INFO - 2015-11-10 09:25:58,459 INFO : starting webserver on 'localhost:49638' 09:25:58 INFO - 2015-11-10 09:25:58,460 INFO : Starting test suite t-yosemite-r5-0039 09:25:58 INFO - 2015-11-10 09:25:58,460 INFO : Starting test dromaeo_css 09:25:58 INFO - 2015-11-10 09:25:58,460 DEBUG : operating with platform_type : mac_ 09:25:58 INFO - 2015-11-10 09:25:58,461 INFO : Initialising browser for dromaeo_css test... 09:25:58 INFO - 2015-11-10 09:25:58,491 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/tmpSrlKpX/profile http://localhost:49638/getInfo.html 09:26:01 INFO - 2015-11-10 09:26:01,237 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:26:01 INFO - 2015-11-10 09:26:01,237 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:26:01 INFO - 2015-11-10 09:26:01,238 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:26:01 INFO - 2015-11-10 09:26:01,238 DEBUG : BROWSER_OUTPUT: __metrics 09:26:01 INFO - 2015-11-10 09:26:01,253 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:02 INFO - 2015-11-10 09:26:02,008 INFO : Browser initialized. 09:26:02 INFO - 2015-11-10 09:26:02,009 INFO : Running cycle 1/1 for dromaeo_css test... 09:26:02 INFO - 2015-11-10 09:26:02,009 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/tmpSrlKpX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:26:14 INFO - 2015-11-10 09:26:14,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 200167424 09:26:14 INFO - 2015-11-10 09:26:14,022 DEBUG : BROWSER_OUTPUT: 09:27:05 INFO - 2015-11-10 09:27:05,499 DEBUG : BROWSER_OUTPUT: 1447176425491 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] 09:29:16 INFO - 2015-11-10 09:29:16,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49638/tests/dromaeo/cssquery-ext.html) 09:29:17 INFO - 2015-11-10 09:29:17,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 312946688 09:29:17 INFO - 2015-11-10 09:29:17,309 DEBUG : BROWSER_OUTPUT: 09:32:20 INFO - 2015-11-10 09:32:20,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/dromaeo/cssquery-ext.html (next: http://localhost:49638/tests/dromaeo/cssquery-jquery.html) 09:32:20 INFO - 2015-11-10 09:32:20,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 343175168 09:32:20 INFO - 2015-11-10 09:32:20,603 DEBUG : BROWSER_OUTPUT: 09:35:22 INFO - 2015-11-10 09:35:22,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49638/tests/dromaeo/cssquery-mootools.html) 09:35:23 INFO - 2015-11-10 09:35:23,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 305422336 09:35:23 INFO - 2015-11-10 09:35:23,387 DEBUG : BROWSER_OUTPUT: 09:38:25 INFO - 2015-11-10 09:38:25,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49638/tests/dromaeo/cssquery-prototype.html) 09:38:25 INFO - 2015-11-10 09:38:25,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 300408832 09:38:25 INFO - 2015-11-10 09:38:25,980 DEBUG : BROWSER_OUTPUT: 09:41:29 INFO - 2015-11-10 09:41:29,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49638/tests/dromaeo/cssquery-yui.html) 09:41:29 INFO - 2015-11-10 09:41:29,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 300646400 09:41:29 INFO - 2015-11-10 09:41:29,851 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/dromaeo/cssquery-yui.html (next: http://localhost:49638/tests/dromaeo/cssquery-dojo.html) 09:44:32 INFO - 2015-11-10 09:44:32,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 345509888 09:44:32 INFO - 2015-11-10 09:44:32,714 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,714 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:44:32 INFO - 2015-11-10 09:44:32,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:44:32 INFO - 2015-11-10 09:44:32,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:44:32 INFO - 2015-11-10 09:44:32,715 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:44:32 INFO - 2015-11-10 09:44:32,716 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2792.357757715725;2887.35034617211;2916.810407323524;2919.3285544324817;2948.793584449089;4748.169070412677;4891.902161956763;4913.754312284389;4923.803047878089;4926.679765815219;4859.635527335447;4905.926411103827;4907.460179380265;4929.309896614477;4944.406671199461;4312.698111132222;4412.404325416076;4452.57700518451;4498.910021799562;4571.817127314904;4340.544242854502;4352.695311328208;4372.12557488502;4372.825086996516;4392.846250381222;4400.735955842643;4404.163208990298;4415.911681766363;4422.557744225568;4434.600885920267;4260.297050986584;4320.1143765527995;4354.216241076605;4411.514733379326;4471.441069866267;4342.934855977162;4368.060866913597;4375.299952007664;4376.081022985177;4395.230834603964;4604.654650901162;4653.674242803005;4727.196376615983;4765.475797662289;4774.880627984294;5052.520010598987;5069.087564238435;5085.415177254626;5196.0647083524955;5210.348706411699;5128.538431541142;5131.307273518102;5131.486851314876;5143.871403214912;5153.072446959546;4739.194336962724;4827.8551643450755;4842.612590992712;4860.416749990024;4867.780949857265;5157.819476318311;5196;5236.659617124875;5238.60710446718;5250.7374631268285;5128.820491282861;5166.43169251382;5192.81825136126;5195.558377537952;5212.765425555859;4860.1737704590305;5260.210968354778;5284.497972692588;5298.364196296469;5327.227552004938;4986.800527978913;5050.242463630485;5070.61970352225;5138.434772175057;5148.742562871841;5109.259157422153;5148.588112950955;5153.381594208644;5175.508326708957;5176.7411629418375;3706.2772759311674;4023.597640235953;4033.011912081559;4035.1324465239527;4080.367543030835;3559.394902866519;3602.5136606558303;3630.419132938717;3645.835937382771;3666.3034023535442;4821;4835.323054772264;4837.7581120944515;4839;4845.3216549683075;4886.242632391985;5279.076161671769;5280.392754833167;5284.656497327738;5291.497307755757;4558.612517936012;4586.036932244266;4714.127886340969;4826.6621336506105;4854.2233242681;4483.14820184164;4504.909901801946;4558.635309175258;4558.703684260512;4565.338025986213;4982.327385803015;5194.506521880416;5283.286756287852;5284.048871203144;5300.5759539236;5072.28987941681;5097.2608971698155;5138.537531622172;5217.008768334004;5225.843224703265;5211.0359583477175;5287.4976877196605;5294.391145018218;5303.098473259478;5326.174442961347;4947.579455746302;5174.404943431554;5187.870303242449;5219.921701174561;5249.47505249472;4976.979719157492;4993.15116430215;5125.5899528036925;5212.661177023481;5237.2667826505085;4968.726720030289;4971.676841005323;4986.9251961221335;5002.474740152232;5011.799528018839;4825.9758701207675;4963.10664080469;4969.552740253394;4977.875553111201;5005.99880024004;4856.295837103529;4926.236433352836;4932.950670493393;4942.332785073969;4951.826686066114;5027.4218464877;5085.389753229488;5091.898162036812;5127.46161653021;5133.974330128325;4807.086653535817;4925;5060.165072762953;5061.139606267017;5085.669431486942 09:44:32 INFO - 2015-11-10 09:44:32,717 DEBUG : BROWSER_OUTPUT: |1;ext.html;497.16724486485134;504.38716958894935;516.5660844890293;518.0261109114865;539.0378174957701;30011;31014.689853101463;36376.090597735034;36843.815780921126;36914;38437.23125537488;39015.804920975424;39205.21589568207;39237;39315.803420982855;7610.543367397946;8187.713430029935;8213;8275.834483310331;8326.04250511193;7621.885671714928;9698.903010969905;9978.700638980807;9981.451020193887;9981.550830212622;9057.728268151934;9694.66068687596;9762.316637835354;9774.071463210983;9792.461414622192;7699.615019249015;7880.684772609089;9676.709698709015;9760.755981100458;9785.755356116082;9545.665901693477;9657;9658.613655453773;9696.07887250717;9722.222222222275;35937.281254374764;36287.637123628956;36480;36498.635013649786;36563.268734625155;2591.6889973203147;2631.276398990293;2636.2223144172517;2786.70739572344;3000;25277;25323.62014569783;25520.744792552206;25788;26006.789422899077;2047.5597746484427;2078.9792102079086;2091.905864236113;2120.204923153817;2161.7189765330563;251168;252314;254623;254986;257444;53650;54992.80028798883;56140.43859561352;56531.60810351392;56580.71709641508;65525.67237163784;66202;66751.33248667548;66827.33172668211;67135.66432167905;15042;15141.242937853063;15171;15179.316930738143;15184.088954662755;11844.644660660195;11871.109666775026;11876;11891.108166887518;11899.345535995604;18496.352627658238;18704.438866834018;18709.158087886077;18714;18727.531811704543;7534.585597792174;7775.377969762519;7805.726799562101;7811.921880781233;7851.097123830718;801.6592947997078;852.7015544559355;897.0984160918235;897.3628723606182;954.613381580461;23799.643005354934;23993.760062399153;23995.760042399703;24068;24145.275641730776;921.8893732751978;970.5583959298502;977.4507405761805;985.5811280205884;1060.3690803971624;11786.882131178578;13943;14223.786643200361;14443.927780361031;14481.20353380553;283731;289044;291639;292666;294299;49881.50118498768;50566;50751.49248507542;50754;50790.74604627027;1272.2557303977278;1272.4401263444056;1281.525835440893;1291.0704292908902;1294.3916359311108;26053.08814191494;26154.607680884423;26618.467630647665;26638;26981.460370792083;44244.778776105915;44737.776311118236;44883.326750098124;44894.77552612216;44921.55078449305;264708;264907;265184;266508;266598;24771.87614061918;25342.746572534776;27468.313292167855;27744.58383124295;28181.859090704416;37964;37986.43020354641;37992.24015519619;38514.229715406094;38578.421323680726;29620;30732.84633576818;30791.076267712004;30855;32187.51718724174;26074;29201;29867.850660746557;30455.695443045286;30642.693573064877;30737.231569210948;31043.68956310408;31050;31067.533986990664;31181;24875.378115546533;25927;27994.580081299206;28964.565531516622;30567.694323057374;21726.45683857916;21754.45613859603;21755.238566650725;21875.453113672287;21974.89012554927 09:44:32 INFO - 2015-11-10 09:44:32,721 DEBUG : BROWSER_OUTPUT: |2;jquery.html;304.93901219756054;310.21825000997484;312.1680720878858;316.54891779214626;319.2465780757412;13267.071305008652;13707.314634268272;15338.079715217094;15575.221238938051;15687.686246275081;13635.93182034091;15848.445304414348;15981.680366392666;16346.673066538662;16574.41989530367;4477.552244775529;4564.9087018259615;4628.375169352128;4631.976840115812;4637.258038713807;3613.22315702124;3736.0473079364724;4677.766111694419;4698.201305778026;5089.389273287211;5122.15484445068;5164.6384753067305;5179.2749015137915;5213.739313034352;5222.373315202181;5051.44434112251;5178.300929374562;5182.378114626231;5194.454582268845;5225.6864588124645;4490.146872094324;4490.169318676023;4506.752128632924;4508.639308855317;4508.684392092555;10715.892841071567;11107.222494425394;11117.610883619116;11120.666380008613;19750;1574.6929348776994;1614.636706740974;1629.1609820942224;1732.8613710903098;1928.7685477742762;7857.489263197874;8138.918610813876;8287.50274983503;8318.875216871751;8321.417500774949;1287.9549215777404;1324.251797734277;1340.0150889096506;1341.6511706956262;1427.1009264163615;49640;51779.96440071215;52530;53309.7334513325;55051.17423238655;5506.504414602705;5564.137558678412;5573.804916827891;5699.430056994351;5741.684207368635;6626.7017984190825;6653.4677225821815;6662.167229096363;6663.200415950117;6668.766593169215;4709.740964246999;4718.834840780556;4740.051989602093;4746.28805679144;4755.524447555286;5005.499450054966;5150.098732721759;5287.550558202596;5300.04599172145;5326.360836699543;2577.1237779154803;2577.8839952202197;2585.75435333643;2599.6620439342764;2605.843649381043;891.8350105230553;899.6311512279934;943.0428115462811;954.9734035911423;970.7184916374173;350.441046530783;356.6968077134467;375.2944464406952;377.1871616666089;379.3910773209015;9853.605855765833;9936.751581210528;10036.447995360326;10224.079832815083;10270.948645256725;338.8068800783579;363.12486906555074;363.9199376137246;380.38187944590044;383.4937881995739;4791.976040119846;5140.40885298188;5408.729563521808;5455.8363249102595;5486.753096110685;527746;531543;539054;544875;545391;66087;68453;69765.30234697588;70191;71601;364.6062252767058;371.95722491913233;372.4060124102053;373.68050316979134;378.27182673353684;8671.132886711279;9010.639574417211;9110.043445438134;9121.315901307296;9296.95351523238;30125.69874301229;30520.542191866694;31191.84404077965;31770.841145794122;31985.520217196296;39496;40169.59830401659;40501.39247911225;40950.59049409468;41031;1987.9006049697168;5257.7371131442505;5346.278252435872;5347.224652425454;5393.946060539502;9642.42145471274;9704.514774261117;9757.024297570186;9807.558659860466;9860.06329398706;8326.50040997542;8467.195616416431;8615.784605384915;8618.439801412887;8649.264812491008;8179;8256.050554186346;8283.792905177177;8284.958575207085;8453.450525715809;7564.130125035471;7949.960250198943;8712.78218044554;8820.382573219813;8972.327075469497;5455.663362476219;5606.775728970795;5607.831765047055;5608.7195640217005;5612.7754889803955;8763.780905477413;8779.824403512022;8922.821543568962;8988.325875559229;9030.593623286837 09:44:32 INFO - 2015-11-10 09:44:32,722 DEBUG : BROWSER_OUTPUT: |3;mootools.html;764.6367975211772;1244.3342811595796;1252.09223313098;1286.401823152234;1621.0597853245113;6459.3217712140195;6695.096162018126;6850.794476165716;6975.337342952412;6975.372216500514;6791.898121528168;6848.828779280508;6891.965540172305;6907.171139463258;6920.65396730164;1933.9226430942745;1950.9414717558495;1955.1983686688461;1955.9902200489048;1958.3341663834294;1930.9613807723838;1942.815432533907;1947.4157752674212;1973.792751761066;1976.940691779249;1969.350114462224;1982.6530357187507;1996.291316582614;1999.210311926788;1999.7400337956046;1962.13665986966;1972.2998335590946;1976.7627884653862;1976.901154942247;1983.514039060425;1916.7891531931477;1946.1047917957615;1958.177565422526;1966.5083729067733;1976.170008596393;6215.098810672473;6942.618156001418;6949;6953.860922781567;6967.756128535477;3826.579076301605;4124.154548317588;4216.325387937915;4224.176285624305;4292.914141717149;2354.5173239485866;2358.4929240213437;2406.8074554035634;2427.8664673442954;2433.7444568320248;720.495653042872;731.3417923868508;739.3604532079767;742.6658003898214;754.031070074951;9021.548922553846;9028.232600228988;9055.592498337524;9059.909400906039;9192.816143677155;3674.1365779041903;3710.239400922804;3760.7743535387963;3815.389537673959;3828.2152158807376;7909.327707144842;7939.603019848984;7944.44388892772;7987.800304992305;8014.639341229658;4288.935665965013;4290.099079193405;4295.72077814941;4313.0726893718;4313.698041137153;3887.436321733333;3896.9610303897166;3897.4738410314812;3902.3951287550476;3903.1608204236227;3055.15983104648;3064.417760625474;3077.261457250244;3079.92300192497;3101.7673674474054;964.8359778837614;968.5835090910836;971.7133445633555;973.2262851033446;980.3333733061587;1089.3899416326883;1114.7603265298;1121.1311233793713;1125.0380924309598;1181.7341098252996;6505.60966342021;6582.670866456658;6645.302243264484;6718.260991290954;6740.427063699641;366.21629712415455;367.6599145790187;369.8557562550607;371.5652686356915;373.0375630872343;5238.1618940969265;5321.255024296602;5322.3879253885525;5326.520613144836;5337.599680024014;7616.504927179715;7751.651175697107;8018.198180182052;8228.30059444942;8236.794080148044;8116.959415203004;8162.265396114378;8168.754937351889;8189.426740128253;8190.8771368429525;6468.579542329733;6528.608283503005;6557.836054098686;6627.768028118992;6630.734770609218;6027.095935609694;6034.7284372202475;6052.90920636182;6058.3335833057445;6090.208272924491;7222.169450513258;7449.6275186241555;7511;7522.285382888617;7529.247075292427;7488.737894173678;7678.654460549177;7719.845603087794;7775.183605721544;7804.9219507806465;6145.692715364304;6174.536909731698;6177.660228687465;6192.907106393318;6198.2252218472695;6013.699315034319;6389.073584330339;6395.072714456471;6397.712102955285;6400.327965563735;6092.75628974836;6137.693115344304;6152.046432802923;6216.285127210248;6221.564490485623;5985.25184351956;5998.4601385875485;6090.604110732788;6093.512518998558;6119.877602448015;6188.164597779242;6199.442050215503;6217.4715149211015;6229.875402491834;6245.750169993149;5629.802956896489;5641.8589535261945;5648.209250704823;5649.661020338793;5651.773929042793;5688.601797874275;5698.20225168485;5740.598158128891;5741.368449470639;5746.856328591819 09:44:32 INFO - 2015-11-10 09:44:32,723 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.86206896551727;280.2531254207536;286.4828983684449;298.5357768669719;302.05306364547164;5386.1920711893235;5422.4306447823;5455.236266922629;5455.809046683366;5521.751521181546;5350.063738845696;5406.08096623574;5407.783688652449;5411.702356370398;5431.674099554029;4161.542230354658;4162.417261583373;4164.646005089571;4168.687348448863;4203.7687927164;3998.920021599566;4088.121053973395;4101.774402407867;4177.540470548237;4188.204241194163;4086.8773936781945;4121.443605113302;4132.979335103335;4143.958560414388;4163.68772342074;3960.089179488734;4036.1725846201457;4128.62842344189;4130.545639979599;4151.086760912624;3467.8439470223902;3489.6859282664427;3490.8603655853735;3503.807290599016;3512.929741405183;5221.530062294411;5222.73886305687;5229.424763276036;5256.342957130359;5266.104762190398;4600.654950878664;4618.307253911907;4620.3069539569;4623.86128416148;4623.9075218495445;5437.945620543784;5564.554835613141;5615.101583746622;5616.269884914976;5623.887522249573;3805.162864169878;3808;3808.733388662795;3810.3522401191863;3826.196498735241;5776.711164441761;5810.273715785527;5911.142884281755;5943.138244954457;5948;4002;4033.4756481657196;4044;4044.6157615026527;4056.5740597236863;4060.9796951015055;4068.6948478864206;4085.0604360996545;4090.4865199876235;4090.6727461802984;4516.277395616686;4672.859814205579;4685.437747470257;4688.57802797743;4692.671512994126;5622.746976386073;5624.100143976944;5632.408597097246;5641.153826925994;5646.350669672958;1466.6846627975037;1484.0872863189277;1492;1492.835788063312;1495.0506428418032;928.9907100929039;932.9253659707207;949.8670186173941;951.3578334624101;978.7014960436993;5353.598480114007;5360.383555891122;5360.981413531416;5366.114591092504;5385.299911011622;5834;5850.473457388855;5918.201042859159;5933.169356290123;5970.313413957364;5333.013392522395;5334.3865455473115;5344.6258761887075;5346.518813306743;5350.5987050971335;3163.0194639661777;3184.8407579620925;3232.563603913489;3255.088575198948;3260.951085733716;5823.475887170175;5828.184054232411;5926.7925622603;5929.229200204032;5952.76188952437;5976.5218782497295;6011.0382338825575;6023.27720673522;6027.547933904887;6028.638281703112;5934.703264836828;5946.048632218911;5950.19672344228;5961.344252132262;5982.73077711504;5713.571482138773;5897.64614123154;5903.852403689943;5913.526917846648;6004.939950600613;5830.5044071254415;5831.8833623326445;5845.09401042839;5859;5881.529477641864;6015.428534289235;6031.819045428644;6036.879262414815;6074.90887636677;6080.908786368296;3703.833327500323;3788.3749181384765;3820.4842346282894;3824.7322687411615;3854.575996640311;5940.61386009908;5941.0494320910175;5961.463468287875;5962.761489540369;5991.490723288569;5819.650820950587;5825.3883342248455;5825.70871456434;5854.063349864001;5869.325027621708;5625.240592519957;5774.56690748204;5783.768649254151;5806.65160090396;5807.564432667482;5638.5771067170945;5640.182173584889;5655.660660360391;5671.773129074791;5709.743061562157;5734.799282025109;5742.397048309867;5756.856078598069;5770.6249093808765;5785.681787501728;5493.121100623881;5563.582731295088;5612.5509959202345;5626.409227031103;5658.547316214611 09:44:32 INFO - 2015-11-10 09:44:32,727 DEBUG : BROWSER_OUTPUT: |5;yui.html;594.934557198708;595.8540157661373;600.3696119074971;683.5181197255935;693.3309356471004;12308.692282692937;12598.307093109886;12610.117291789567;12620.873791262085;12663;11650.184487085908;11724.589639362624;11765.058795296378;11775.823362649568;11789.587364442224;650.8958566629341;675.5372569789686;787.5471603827793;796.3788245168748;807.8222790985974;813.0243707550933;818.6111596991411;820.5076953827715;820.6471217376555;822.411975437562;664.5713514782963;831.9168083191663;833.3374966901328;836.6946064686407;841.0202114536557;666.6500087454101;821.2116368286422;830.8462934357163;833.2417500074903;834.8914641096619;595.910613407988;600.8768202518517;603.1375133559009;603.2218438214697;604.8729766748988;11757.176997610171;11841.703957401047;11851.703707407298;11872.52509899603;11877.940610296893;7797.883031754528;7979.640916158787;8175.223353781381;8227.670893164266;8364.916350836535;7997.320227780588;8053.476524025919;8109.4323397362205;8447.95776021116;8718.17177368149;2530.4433024734712;2584.8966041358512;2595.2733234694315;2598.1555994301925;2613.830101043426;42305.153896922195;42398;42456.150876982596;42686.78656606728;43153.35269970921;5950.434708702666;6130.754769809158;6227.221597300338;6231.875362492725;6272.109858944679;9913;9915.900840991642;9923.751906202402;9935.65225217114;9986.950065249772;5442.102053161263;5463.9180412293845;5473.370562385297;5625.09998400254;5699.230603868425;3265.7387409007224;3348.68187522185;3376.12220822583;3442.4836274558515;3446.6897979181995;2366.3847399675865;2375.0618505690154;2395.0778950103986;2398.928032159038;2407.1334319644916;358.0368807906723;362.44726791642955;362.45812510297276;402.3281120528724;421.23335529336316;408.8875559221238;427.9358096285582;491.2582001178247;497.01590850116247;537.8677883056189;7000.26497217795;7033.191183013917;7126.35862772353;7226.6386680665755;7236.96381518089;435.5709626018433;506.187568951827;516.1947362115112;520.2846086630883;530.6948504609865;3370.410178218802;3501.7373696972827;3532.4701294805473;3698.223373091681;3851.4607954886337;48376.758116209196;48609.27086093711;48617.27074093891;48747.512524875005;49393.259101113515;41338.586614134074;42510.362344564855;42750.78624606857;43202.351964720554;43301.35047974283;40620.593794062275;41299.38050929239;41859;41975.1604967899;42333.99999999938;7161.534500257467;7544.585047822423;7597.962010190135;7601.3918886490055;7767;31010.379792404477;31052;31268.530972034983;31655.52516712297;31663.20841978969;39444.60555394409;41645.79177104095;41912.580874192085;42377;42477;6426.196725409324;6451.838704032437;6690.29751876046;6765.86468270622;6842.521023528305;9738.659146929824;9752.804943901225;9786.75533111678;10105.696829095139;10378.117859981685;9083.409578377385;9317.16145546904;9408.200302974325;9499.715008549754;9855.556499957376;8818.941726992802;8958;9093.318001149808;9141.080373121453;9152.993170751346;9379.953100234456;9430.151286384258;9434.245260379015;9453;9803.166730827674;7719.112302085332;7772.650230739743;7885;8081.757547273356;8351.707690230813;7852.332551733167;8166.387520935835;8270.710525131592;8343.624536895733;8421.873671894804 09:44:32 INFO - 2015-11-10 09:44:32,727 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:44:32 INFO - 2015-11-10 09:44:32,727 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:44:32 INFO - 2015-11-10 09:44:32,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,854 09:44:32 INFO - 2015-11-10 09:44:32,728 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:44:32 INFO - 2015-11-10 09:44:32,728 DEBUG : BROWSER_OUTPUT: __startTimestamp1447177472712__endTimestamp 09:44:32 INFO - 2015-11-10 09:44:32,728 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,728 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:44:32 INFO - 2015-11-10 09:44:32,728 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:44:32 INFO - 2015-11-10 09:44:32,728 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,729 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4787.96 Median:4942.33 stddev:519.17 (10.5%) stddev-sans-first:496.60 09:44:32 INFO - 2015-11-10 09:44:32,729 DEBUG : BROWSER_OUTPUT: Values: 2792.4 2887.4 2916.8 2919.3 2948.8 4748.2 4891.9 4913.8 4923.8 4926.7 4859.6 4905.9 4907.5 4929.3 4944.4 4312.7 4412.4 4452.6 4498.9 4571.8 4340.5 4352.7 4372.1 4372.8 4392.8 4400.7 4404.2 4415.9 4422.6 4434.6 4260.3 4320.1 4354.2 4411.5 4471.4 4342.9 4368.1 4375.3 4376.1 4395.2 4604.7 4653.7 4727.2 4765.5 4774.9 5052.5 5069.1 5085.4 5196.1 5210.3 5128.5 5131.3 5131.5 5143.9 5153.1 4739.2 4827.9 4842.6 4860.4 4867.8 5157.8 5196.0 5236.7 5238.6 5250.7 5128.8 5166.4 5192.8 5195.6 5212.8 4860.2 5260.2 5284.5 5298.4 5327.2 4986.8 5050.2 5070.6 5138.4 5148.7 5109.3 5148.6 5153.4 5175.5 5176.7 3706.3 4023.6 4033.0 4035.1 4080.4 3559.4 3602.5 3630.4 3645.8 3666.3 4821.0 4835.3 4837.8 4839.0 4845.3 4886.2 5279.1 5280.4 5284.7 5291.5 4558.6 4586.0 4714.1 4826.7 4854.2 4483.1 4504.9 4558.6 4558.7 4565.3 4982.3 5194.5 5283.3 5284.0 5300.6 5072.3 5097.3 5138.5 5217.0 5225.8 5211.0 5287.5 5294.4 5303.1 5326.2 4947.6 5174.4 5187.9 5219.9 5249.5 4977.0 4993.2 5125.6 5212.7 5237.3 4968.7 4971.7 4986.9 5002.5 5011.8 4826.0 4963.1 4969.6 4977.9 5006.0 4856.3 4926.2 4933.0 4942.3 4951.8 5027.4 5085.4 5091.9 5127.5 5134.0 4807.1 4925.0 5060.2 5061.1 5085.7 09:44:32 INFO - 2015-11-10 09:44:32,729 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,729 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42778.63 Median:30823.04 stddev:70736.53 (229.5%) stddev-sans-first:70863.72 09:44:32 INFO - 2015-11-10 09:44:32,730 DEBUG : BROWSER_OUTPUT: Values: 497.2 504.4 516.6 518.0 539.0 30011.0 31014.7 36376.1 36843.8 36914.0 38437.2 39015.8 39205.2 39237.0 39315.8 7610.5 8187.7 8213.0 8275.8 8326.0 7621.9 9698.9 9978.7 9981.5 9981.6 9057.7 9694.7 9762.3 9774.1 9792.5 7699.6 7880.7 9676.7 9760.8 9785.8 9545.7 9657.0 9658.6 9696.1 9722.2 35937.3 36287.6 36480.0 36498.6 36563.3 2591.7 2631.3 2636.2 2786.7 3000.0 25277.0 25323.6 25520.7 25788.0 26006.8 2047.6 2079.0 2091.9 2120.2 2161.7 251168.0 252314.0 254623.0 254986.0 257444.0 53650.0 54992.8 56140.4 56531.6 56580.7 65525.7 66202.0 66751.3 66827.3 67135.7 15042.0 15141.2 15171.0 15179.3 15184.1 11844.6 11871.1 11876.0 11891.1 11899.3 18496.4 18704.4 18709.2 18714.0 18727.5 7534.6 7775.4 7805.7 7811.9 7851.1 801.7 852.7 897.1 897.4 954.6 23799.6 23993.8 23995.8 24068.0 24145.3 921.9 970.6 977.5 985.6 1060.4 11786.9 13943.0 14223.8 14443.9 14481.2 283731.0 289044.0 291639.0 292666.0 294299.0 49881.5 50566.0 50751.5 50754.0 50790.7 1272.3 1272.4 1281.5 1291.1 1294.4 26053.1 26154.6 26618.5 26638.0 26981.5 44244.8 44737.8 44883.3 44894.8 44921.6 264708.0 264907.0 265184.0 266508.0 266598.0 24771.9 25342.7 27468.3 27744.6 28181.9 37964.0 37986.4 37992.2 38514.2 38578.4 29620.0 30732.8 30791.1 30855.0 32187.5 26074.0 29201.0 29867.9 30455.7 30642.7 30737.2 31043.7 31050.0 31067.5 31181.0 24875.4 25927.0 27994.6 28964.6 30567.7 21726.5 21754.5 21755.2 21875.5 21974.9 09:44:32 INFO - 2015-11-10 09:44:32,731 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,731 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25410.57 Median:5157.37 stddev:88076.11 (1707.8%) stddev-sans-first:88303.01 09:44:32 INFO - 2015-11-10 09:44:32,732 DEBUG : BROWSER_OUTPUT: Values: 304.9 310.2 312.2 316.5 319.2 13267.1 13707.3 15338.1 15575.2 15687.7 13635.9 15848.4 15981.7 16346.7 16574.4 4477.6 4564.9 4628.4 4632.0 4637.3 3613.2 3736.0 4677.8 4698.2 5089.4 5122.2 5164.6 5179.3 5213.7 5222.4 5051.4 5178.3 5182.4 5194.5 5225.7 4490.1 4490.2 4506.8 4508.6 4508.7 10715.9 11107.2 11117.6 11120.7 19750.0 1574.7 1614.6 1629.2 1732.9 1928.8 7857.5 8138.9 8287.5 8318.9 8321.4 1288.0 1324.3 1340.0 1341.7 1427.1 49640.0 51780.0 52530.0 53309.7 55051.2 5506.5 5564.1 5573.8 5699.4 5741.7 6626.7 6653.5 6662.2 6663.2 6668.8 4709.7 4718.8 4740.1 4746.3 4755.5 5005.5 5150.1 5287.6 5300.0 5326.4 2577.1 2577.9 2585.8 2599.7 2605.8 891.8 899.6 943.0 955.0 970.7 350.4 356.7 375.3 377.2 379.4 9853.6 9936.8 10036.4 10224.1 10270.9 338.8 363.1 363.9 380.4 383.5 4792.0 5140.4 5408.7 5455.8 5486.8 527746.0 531543.0 539054.0 544875.0 545391.0 66087.0 68453.0 69765.3 70191.0 71601.0 364.6 372.0 372.4 373.7 378.3 8671.1 9010.6 9110.0 9121.3 9297.0 30125.7 30520.5 31191.8 31770.8 31985.5 39496.0 40169.6 40501.4 40950.6 41031.0 1987.9 5257.7 5346.3 5347.2 5393.9 9642.4 9704.5 9757.0 9807.6 9860.1 8326.5 8467.2 8615.8 8618.4 8649.3 8179.0 8256.1 8283.8 8285.0 8453.5 7564.1 7950.0 8712.8 8820.4 8972.3 5455.7 5606.8 5607.8 5608.7 5612.8 8763.8 8779.8 8922.8 8988.3 9030.6 09:44:32 INFO - 2015-11-10 09:44:32,732 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,732 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4762.96 Median:6074.27 stddev:2510.71 (41.3%) stddev-sans-first:2499.75 09:44:32 INFO - 2015-11-10 09:44:32,734 DEBUG : BROWSER_OUTPUT: Values: 764.6 1244.3 1252.1 1286.4 1621.1 6459.3 6695.1 6850.8 6975.3 6975.4 6791.9 6848.8 6892.0 6907.2 6920.7 1933.9 1950.9 1955.2 1956.0 1958.3 1931.0 1942.8 1947.4 1973.8 1976.9 1969.4 1982.7 1996.3 1999.2 1999.7 1962.1 1972.3 1976.8 1976.9 1983.5 1916.8 1946.1 1958.2 1966.5 1976.2 6215.1 6942.6 6949.0 6953.9 6967.8 3826.6 4124.2 4216.3 4224.2 4292.9 2354.5 2358.5 2406.8 2427.9 2433.7 720.5 731.3 739.4 742.7 754.0 9021.5 9028.2 9055.6 9059.9 9192.8 3674.1 3710.2 3760.8 3815.4 3828.2 7909.3 7939.6 7944.4 7987.8 8014.6 4288.9 4290.1 4295.7 4313.1 4313.7 3887.4 3897.0 3897.5 3902.4 3903.2 3055.2 3064.4 3077.3 3079.9 3101.8 964.8 968.6 971.7 973.2 980.3 1089.4 1114.8 1121.1 1125.0 1181.7 6505.6 6582.7 6645.3 6718.3 6740.4 366.2 367.7 369.9 371.6 373.0 5238.2 5321.3 5322.4 5326.5 5337.6 7616.5 7751.7 8018.2 8228.3 8236.8 8117.0 8162.3 8168.8 8189.4 8190.9 6468.6 6528.6 6557.8 6627.8 6630.7 6027.1 6034.7 6052.9 6058.3 6090.2 7222.2 7449.6 7511.0 7522.3 7529.2 7488.7 7678.7 7719.8 7775.2 7804.9 6145.7 6174.5 6177.7 6192.9 6198.2 6013.7 6389.1 6395.1 6397.7 6400.3 6092.8 6137.7 6152.0 6216.3 6221.6 5985.3 5998.5 6090.6 6093.5 6119.9 6188.2 6199.4 6217.5 6229.9 6245.8 5629.8 5641.9 5648.2 5649.7 5651.8 5688.6 5698.2 5740.6 5741.4 5746.9 09:44:32 INFO - 2015-11-10 09:44:32,734 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,734 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4747.74 Median:5427.05 stddev:1438.06 (26.5%) stddev-sans-first:1402.38 09:44:32 INFO - 2015-11-10 09:44:32,734 DEBUG : BROWSER_OUTPUT: Values: 275.9 280.3 286.5 298.5 302.1 5386.2 5422.4 5455.2 5455.8 5521.8 5350.1 5406.1 5407.8 5411.7 5431.7 4161.5 4162.4 4164.6 4168.7 4203.8 3998.9 4088.1 4101.8 4177.5 4188.2 4086.9 4121.4 4133.0 4144.0 4163.7 3960.1 4036.2 4128.6 4130.5 4151.1 3467.8 3489.7 3490.9 3503.8 3512.9 5221.5 5222.7 5229.4 5256.3 5266.1 4600.7 4618.3 4620.3 4623.9 4623.9 5437.9 5564.6 5615.1 5616.3 5623.9 3805.2 3808.0 3808.7 3810.4 3826.2 5776.7 5810.3 5911.1 5943.1 5948.0 4002.0 4033.5 4044.0 4044.6 4056.6 4061.0 4068.7 4085.1 4090.5 4090.7 4516.3 4672.9 4685.4 4688.6 4692.7 5622.7 5624.1 5632.4 5641.2 5646.4 1466.7 1484.1 1492.0 1492.8 1495.1 929.0 932.9 949.9 951.4 978.7 5353.6 5360.4 5361.0 5366.1 5385.3 5834.0 5850.5 5918.2 5933.2 5970.3 5333.0 5334.4 5344.6 5346.5 5350.6 3163.0 3184.8 3232.6 3255.1 3261.0 5823.5 5828.2 5926.8 5929.2 5952.8 5976.5 6011.0 6023.3 6027.5 6028.6 5934.7 5946.0 5950.2 5961.3 5982.7 5713.6 5897.6 5903.9 5913.5 6004.9 5830.5 5831.9 5845.1 5859.0 5881.5 6015.4 6031.8 6036.9 6074.9 6080.9 3703.8 3788.4 3820.5 3824.7 3854.6 5940.6 5941.0 5961.5 5962.8 5991.5 5819.7 5825.4 5825.7 5854.1 5869.3 5625.2 5774.6 5783.8 5806.7 5807.6 5638.6 5640.2 5655.7 5671.8 5709.7 5734.8 5742.4 5756.9 5770.6 5785.7 5493.1 5563.6 5612.6 5626.4 5658.5 09:44:32 INFO - 2015-11-10 09:44:32,734 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2015-11-10 09:44:32,735 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11547.79 Median:3275.40 stddev:14054.78 (429.1%) stddev-sans-first:14070.14 09:44:32 INFO - 2015-11-10 09:44:32,736 DEBUG : BROWSER_OUTPUT: Values: 594.9 595.9 600.4 683.5 693.3 12308.7 12598.3 12610.1 12620.9 12663.0 11650.2 11724.6 11765.1 11775.8 11789.6 650.9 675.5 787.5 796.4 807.8 813.0 818.6 820.5 820.6 822.4 664.6 831.9 833.3 836.7 841.0 666.7 821.2 830.8 833.2 834.9 595.9 600.9 603.1 603.2 604.9 11757.2 11841.7 11851.7 11872.5 11877.9 7797.9 7979.6 8175.2 8227.7 8364.9 7997.3 8053.5 8109.4 8448.0 8718.2 2530.4 2584.9 2595.3 2598.2 2613.8 42305.2 42398.0 42456.2 42686.8 43153.4 5950.4 6130.8 6227.2 6231.9 6272.1 9913.0 9915.9 9923.8 9935.7 9987.0 5442.1 5463.9 5473.4 5625.1 5699.2 3265.7 3348.7 3376.1 3442.5 3446.7 2366.4 2375.1 2395.1 2398.9 2407.1 358.0 362.4 362.5 402.3 421.2 408.9 427.9 491.3 497.0 537.9 7000.3 7033.2 7126.4 7226.6 7237.0 435.6 506.2 516.2 520.3 530.7 3370.4 3501.7 3532.5 3698.2 3851.5 48376.8 48609.3 48617.3 48747.5 49393.3 41338.6 42510.4 42750.8 43202.4 43301.4 40620.6 41299.4 41859.0 41975.2 42334.0 7161.5 7544.6 7598.0 7601.4 7767.0 31010.4 31052.0 31268.5 31655.5 31663.2 39444.6 41645.8 41912.6 42377.0 42477.0 6426.2 6451.8 6690.3 6765.9 6842.5 9738.7 9752.8 9786.8 10105.7 10378.1 9083.4 9317.2 9408.2 9499.7 9855.6 8818.9 8958.0 9093.3 9141.1 9153.0 9380.0 9430.2 9434.2 9453.0 9803.2 7719.1 7772.7 7885.0 8081.8 8351.7 7852.3 8166.4 8270.7 8343.6 8421.9 09:44:32 INFO - 2015-11-10 09:44:32,736 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:44:32 INFO - 2015-11-10 09:44:32,736 DEBUG : BROWSER_OUTPUT: 09:44:33 INFO - 2015-11-10 09:44:33,448 INFO : Browser exited with error code: 0 09:44:33 INFO - 2015-11-10 09:44:33,480 INFO : Completed test dromaeo_css (00:18:35) 09:44:33 INFO - 2015-11-10 09:44:33,480 INFO : Starting test kraken 09:44:33 INFO - 2015-11-10 09:44:33,480 DEBUG : operating with platform_type : mac_ 09:44:33 INFO - 2015-11-10 09:44:33,480 INFO : Initialising browser for kraken test... 09:44:33 INFO - 2015-11-10 09:44:33,495 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/tmp189atQ/profile http://localhost:49638/getInfo.html 09:44:35 INFO - 2015-11-10 09:44:35,931 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:44:35 INFO - 2015-11-10 09:44:35,931 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:44:35 INFO - 2015-11-10 09:44:35,931 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:44:35 INFO - 2015-11-10 09:44:35,932 DEBUG : BROWSER_OUTPUT: __metrics 09:44:35 INFO - 2015-11-10 09:44:35,952 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:36 INFO - 2015-11-10 09:44:36,751 INFO : Browser initialized. 09:44:36 INFO - 2015-11-10 09:44:36,752 INFO : Running cycle 1/1 for kraken test... 09:44:36 INFO - 2015-11-10 09:44:36,752 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/tmp189atQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:44:48 INFO - 2015-11-10 09:44:48,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 199766016 09:44:48 INFO - 2015-11-10 09:44:48,759 DEBUG : BROWSER_OUTPUT: 09:44:51 INFO - 2015-11-10 09:44:51,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49638/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:52 INFO - 2015-11-10 09:44:52,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 266973184 09:44:52 INFO - 2015-11-10 09:44:52,184 DEBUG : BROWSER_OUTPUT: 09:44:55 INFO - 2015-11-10 09:44:55,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49638/tests/kraken/driver.html?testName=audio-dft) 09:44:55 INFO - 2015-11-10 09:44:55,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 279207936 09:44:55 INFO - 2015-11-10 09:44:55,725 DEBUG : BROWSER_OUTPUT: 09:44:58 INFO - 2015-11-10 09:44:58,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49638/tests/kraken/driver.html?testName=audio-fft) 09:44:59 INFO - 2015-11-10 09:44:59,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 268840960 09:44:59 INFO - 2015-11-10 09:44:59,440 DEBUG : BROWSER_OUTPUT: 09:45:01 INFO - 2015-11-10 09:45:01,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49638/tests/kraken/driver.html?testName=audio-oscillator) 09:45:02 INFO - 2015-11-10 09:45:02,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 270331904 09:45:02 INFO - 2015-11-10 09:45:02,236 DEBUG : BROWSER_OUTPUT: 09:45:04 INFO - 2015-11-10 09:45:04,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49638/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:45:05 INFO - 2015-11-10 09:45:05,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 269697024 09:45:05 INFO - 2015-11-10 09:45:05,231 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-10 09:45:08,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49638/tests/kraken/driver.html?testName=imaging-darkroom) 09:45:09 INFO - 2015-11-10 09:45:09,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 270729216 09:45:09 INFO - 2015-11-10 09:45:09,223 DEBUG : BROWSER_OUTPUT: 09:45:12 INFO - 2015-11-10 09:45:12,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49638/tests/kraken/driver.html?testName=imaging-desaturate) 09:45:13 INFO - 2015-11-10 09:45:13,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 268431360 09:45:13 INFO - 2015-11-10 09:45:13,302 DEBUG : BROWSER_OUTPUT: 09:45:16 INFO - 2015-11-10 09:45:16,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49638/tests/kraken/driver.html?testName=json-parse-financial) 09:45:17 INFO - 2015-11-10 09:45:17,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 267788288 09:45:17 INFO - 2015-11-10 09:45:17,093 DEBUG : BROWSER_OUTPUT: 09:45:18 INFO - 2015-11-10 09:45:18,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49638/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:19 INFO - 2015-11-10 09:45:19,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 299573248 09:45:19 INFO - 2015-11-10 09:45:19,422 DEBUG : BROWSER_OUTPUT: 09:45:21 INFO - 2015-11-10 09:45:21,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49638/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:21 INFO - 2015-11-10 09:45:21,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 303243264 09:45:21 INFO - 2015-11-10 09:45:21,988 DEBUG : BROWSER_OUTPUT: 09:45:24 INFO - 2015-11-10 09:45:24,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49638/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:24 INFO - 2015-11-10 09:45:24,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 308490240 09:45:24 INFO - 2015-11-10 09:45:24,834 DEBUG : BROWSER_OUTPUT: 09:45:27 INFO - 2015-11-10 09:45:27,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:28 INFO - 2015-11-10 09:45:28,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 309420032 09:45:28 INFO - 2015-11-10 09:45:28,242 DEBUG : BROWSER_OUTPUT: 09:45:31 INFO - 2015-11-10 09:45:31,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:31 INFO - 2015-11-10 09:45:31,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 310476800 09:45:31 INFO - 2015-11-10 09:45:31,678 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49638/tests/kraken/driver.html?testName=ai-astar) 09:45:33 INFO - 2015-11-10 09:45:33,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 368193536 09:45:33 INFO - 2015-11-10 09:45:33,814 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,814 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:45:33 INFO - 2015-11-10 09:45:33,814 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:45:33 INFO - 2015-11-10 09:45:33,814 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:45:33 INFO - 2015-11-10 09:45:33,814 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:45:33 INFO - 2015-11-10 09:45:33,814 DEBUG : BROWSER_OUTPUT: |0;ai-astar;122;127;125;124;128;123;135;127;126;125 09:45:33 INFO - 2015-11-10 09:45:33,815 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;180;149;177;185;149;179;178;144;188;144 09:45:33 INFO - 2015-11-10 09:45:33,815 DEBUG : BROWSER_OUTPUT: |2;audio-dft;185;186;186;181;181;189;189;188;181;185 09:45:33 INFO - 2015-11-10 09:45:33,815 DEBUG : BROWSER_OUTPUT: |3;audio-fft;90;94;91;143;76;80;81;81;134;78 09:45:33 INFO - 2015-11-10 09:45:33,815 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;114;116;161;102;104;105;145;103;103;142 09:45:33 INFO - 2015-11-10 09:45:33,815 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;142;136;135;131;129;141;135;142;132 09:45:33 INFO - 2015-11-10 09:45:33,816 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;148;145;141;146;146;147;144;140 09:45:33 INFO - 2015-11-10 09:45:33,816 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;117;118;119;117;118;119;119;116;117 09:45:33 INFO - 2015-11-10 09:45:33,816 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;69;69;72;72;73;72;83;66;68 09:45:33 INFO - 2015-11-10 09:45:33,816 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;72;72;77;76;76;76;76;73;74 09:45:33 INFO - 2015-11-10 09:45:33,816 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;95;96;96;97;94;95;96;96;101 09:45:33 INFO - 2015-11-10 09:45:33,816 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;138;141;141;142;150;136;138;140;145;144 09:45:33 INFO - 2015-11-10 09:45:33,817 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;165;169;173;170;171;163;167;173;170;156 09:45:33 INFO - 2015-11-10 09:45:33,817 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;77;82;83;81;82;81;81;82;80 09:45:33 INFO - 2015-11-10 09:45:33,817 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:45:33 INFO - 2015-11-10 09:45:33,817 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:45:33 INFO - 2015-11-10 09:45:33,817 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,932 09:45:33 INFO - 2015-11-10 09:45:33,817 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:45:33 INFO - 2015-11-10 09:45:33,818 DEBUG : BROWSER_OUTPUT: __startTimestamp1447177533810__endTimestamp 09:45:33 INFO - 2015-11-10 09:45:33,818 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,818 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:45:33 INFO - 2015-11-10 09:45:33,818 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:45:33 INFO - 2015-11-10 09:45:33,818 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,819 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:126.20 Median:126.50 stddev:3.61 (2.9%) stddev-sans-first:3.50 09:45:33 INFO - 2015-11-10 09:45:33,819 DEBUG : BROWSER_OUTPUT: Values: 122.0 127.0 125.0 124.0 128.0 123.0 135.0 127.0 126.0 125.0 09:45:33 INFO - 2015-11-10 09:45:33,819 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,819 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:167.30 Median:178.50 stddev:18.27 (10.2%) stddev-sans-first:18.79 09:45:33 INFO - 2015-11-10 09:45:33,819 DEBUG : BROWSER_OUTPUT: Values: 180.0 149.0 177.0 185.0 149.0 179.0 178.0 144.0 188.0 144.0 09:45:33 INFO - 2015-11-10 09:45:33,819 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,820 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:185.10 Median:186.00 stddev:3.18 (1.7%) stddev-sans-first:3.37 09:45:33 INFO - 2015-11-10 09:45:33,820 DEBUG : BROWSER_OUTPUT: Values: 185.0 186.0 186.0 181.0 181.0 189.0 189.0 188.0 181.0 185.0 09:45:33 INFO - 2015-11-10 09:45:33,820 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,820 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:94.80 Median:81.00 stddev:23.88 (29.5%) stddev-sans-first:25.27 09:45:33 INFO - 2015-11-10 09:45:33,820 DEBUG : BROWSER_OUTPUT: Values: 90.0 94.0 91.0 143.0 76.0 80.0 81.0 81.0 134.0 78.0 09:45:33 INFO - 2015-11-10 09:45:33,821 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,821 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.50 Median:115.00 stddev:21.66 (18.8%) stddev-sans-first:22.88 09:45:33 INFO - 2015-11-10 09:45:33,822 DEBUG : BROWSER_OUTPUT: Values: 114.0 116.0 161.0 102.0 104.0 105.0 145.0 103.0 103.0 142.0 09:45:33 INFO - 2015-11-10 09:45:33,822 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,822 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:135.90 Median:136.00 stddev:4.58 (3.4%) stddev-sans-first:4.86 09:45:33 INFO - 2015-11-10 09:45:33,823 DEBUG : BROWSER_OUTPUT: Values: 136.0 142.0 136.0 135.0 131.0 129.0 141.0 135.0 142.0 132.0 09:45:33 INFO - 2015-11-10 09:45:33,823 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,823 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.90 Median:146.00 stddev:2.56 (1.8%) stddev-sans-first:2.68 09:45:33 INFO - 2015-11-10 09:45:33,823 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 148.0 145.0 141.0 146.0 146.0 147.0 144.0 140.0 09:45:33 INFO - 2015-11-10 09:45:33,823 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,823 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.80 Median:118.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 09:45:33 INFO - 2015-11-10 09:45:33,823 DEBUG : BROWSER_OUTPUT: Values: 118.0 117.0 118.0 119.0 117.0 118.0 119.0 119.0 116.0 117.0 09:45:33 INFO - 2015-11-10 09:45:33,824 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,824 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.70 Median:72.00 stddev:5.33 (7.4%) stddev-sans-first:4.88 09:45:33 INFO - 2015-11-10 09:45:33,824 DEBUG : BROWSER_OUTPUT: Values: 63.0 69.0 69.0 72.0 72.0 73.0 72.0 83.0 66.0 68.0 09:45:33 INFO - 2015-11-10 09:45:33,824 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,824 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.30 Median:76.00 stddev:2.16 (2.8%) stddev-sans-first:1.94 09:45:33 INFO - 2015-11-10 09:45:33,825 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 77.0 76.0 76.0 76.0 76.0 73.0 74.0 09:45:33 INFO - 2015-11-10 09:45:33,825 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,825 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:95.70 Median:96.00 stddev:2.50 (2.6%) stddev-sans-first:1.99 09:45:33 INFO - 2015-11-10 09:45:33,825 DEBUG : BROWSER_OUTPUT: Values: 91.0 95.0 96.0 96.0 97.0 94.0 95.0 96.0 96.0 101.0 09:45:33 INFO - 2015-11-10 09:45:33,825 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,825 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:141.50 stddev:4.06 (2.9%) stddev-sans-first:4.11 09:45:33 INFO - 2015-11-10 09:45:33,826 DEBUG : BROWSER_OUTPUT: Values: 138.0 141.0 141.0 142.0 150.0 136.0 138.0 140.0 145.0 144.0 09:45:33 INFO - 2015-11-10 09:45:33,826 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,826 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:170.00 stddev:5.23 (3.1%) stddev-sans-first:5.45 09:45:33 INFO - 2015-11-10 09:45:33,826 DEBUG : BROWSER_OUTPUT: Values: 165.0 169.0 173.0 170.0 171.0 163.0 167.0 173.0 170.0 156.0 09:45:33 INFO - 2015-11-10 09:45:33,826 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-10 09:45:33,828 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.60 Median:81.50 stddev:2.07 (2.5%) stddev-sans-first:1.73 09:45:33 INFO - 2015-11-10 09:45:33,828 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 82.0 83.0 81.0 82.0 81.0 81.0 82.0 80.0 09:45:33 INFO - 2015-11-10 09:45:33,828 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:45:33 INFO - 2015-11-10 09:45:33,828 DEBUG : BROWSER_OUTPUT: 09:45:34 INFO - 2015-11-10 09:45:34,539 INFO : Browser exited with error code: 0 09:45:34 INFO - 2015-11-10 09:45:34,592 INFO : Completed test kraken (00:01:01) 09:45:34 INFO - 2015-11-10 09:45:34,593 INFO : Starting test v8_7 09:45:34 INFO - 2015-11-10 09:45:34,593 DEBUG : operating with platform_type : mac_ 09:45:34 INFO - 2015-11-10 09:45:34,593 INFO : Initialising browser for v8_7 test... 09:45:34 INFO - 2015-11-10 09:45:34,607 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/tmpBkzDV5/profile http://localhost:49638/getInfo.html 09:45:36 INFO - 2015-11-10 09:45:36,994 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:45:36 INFO - 2015-11-10 09:45:36,995 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:45:36 INFO - 2015-11-10 09:45:36,995 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:45:36 INFO - 2015-11-10 09:45:36,995 DEBUG : BROWSER_OUTPUT: __metrics 09:45:37 INFO - 2015-11-10 09:45:37,015 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:45:37 INFO - 2015-11-10 09:45:37,746 INFO : Browser initialized. 09:45:37 INFO - 2015-11-10 09:45:37,747 INFO : Running cycle 1/1 for v8_7 test... 09:45:37 INFO - 2015-11-10 09:45:37,747 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/T/tmpBkzDV5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:45:49 INFO - 2015-11-10 09:45:49,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 199680000 09:45:49 INFO - 2015-11-10 09:45:49,764 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49638/tests/v8_7/run.html (next: http://localhost:49638/tests/v8_7/run.html) 09:46:12 INFO - 2015-11-10 09:46:12,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 508866560 09:46:12 INFO - 2015-11-10 09:46:12,898 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,898 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:46:12 INFO - 2015-11-10 09:46:12,898 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:46:12 INFO - 2015-11-10 09:46:12,898 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:46:12 INFO - 2015-11-10 09:46:12,898 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:46:12 INFO - 2015-11-10 09:46:12,899 DEBUG : BROWSER_OUTPUT: |0;Richards;190.36740909956217 09:46:12 INFO - 2015-11-10 09:46:12,899 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;220.5071664829107 09:46:12 INFO - 2015-11-10 09:46:12,899 DEBUG : BROWSER_OUTPUT: |2;Encrypt;362.4501631025734 09:46:12 INFO - 2015-11-10 09:46:12,899 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6718.120805369127 09:46:12 INFO - 2015-11-10 09:46:12,899 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1179.245283018868 09:46:12 INFO - 2015-11-10 09:46:12,899 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 09:46:12 INFO - 2015-11-10 09:46:12,899 DEBUG : BROWSER_OUTPUT: |6;Boyer;14285.714285714286 09:46:12 INFO - 2015-11-10 09:46:12,899 DEBUG : BROWSER_OUTPUT: |7;RegExp;33583.333333333336 09:46:12 INFO - 2015-11-10 09:46:12,900 DEBUG : BROWSER_OUTPUT: |8;Splay;657.4621959237344 09:46:12 INFO - 2015-11-10 09:46:12,900 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6568.6274509803925 09:46:12 INFO - 2015-11-10 09:46:12,900 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:46:12 INFO - 2015-11-10 09:46:12,900 DEBUG : BROWSER_OUTPUT: __startTimestamp1447177572890__endTimestamp 09:46:12 INFO - 2015-11-10 09:46:12,900 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,900 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:46:12 INFO - 2015-11-10 09:46:12,900 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:46:12 INFO - 2015-11-10 09:46:12,901 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,901 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.37 Median:190.37 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,901 DEBUG : BROWSER_OUTPUT: Values: 190.4 09:46:12 INFO - 2015-11-10 09:46:12,901 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,901 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:220.51 Median:220.51 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,901 DEBUG : BROWSER_OUTPUT: Values: 220.5 09:46:12 INFO - 2015-11-10 09:46:12,902 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,902 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:362.45 Median:362.45 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,902 DEBUG : BROWSER_OUTPUT: Values: 362.5 09:46:12 INFO - 2015-11-10 09:46:12,902 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,902 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6718.12 Median:6718.12 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,902 DEBUG : BROWSER_OUTPUT: Values: 6718.1 09:46:12 INFO - 2015-11-10 09:46:12,902 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,902 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1179.25 Median:1179.25 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: Values: 1179.2 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: Values: 789.9 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14285.71 Median:14285.71 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: Values: 14285.7 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,903 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33583.33 Median:33583.33 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: Values: 33583.3 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:657.46 Median:657.46 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: Values: 657.5 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6568.63 Median:6568.63 stddev:0.00 (0.0%) 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: Values: 6568.6 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:46:12 INFO - 2015-11-10 09:46:12,904 DEBUG : BROWSER_OUTPUT: 09:46:13 INFO - 2015-11-10 09:46:13,616 INFO : Browser exited with error code: 0 09:46:13 INFO - 2015-11-10 09:46:13,638 INFO : Completed test v8_7 (00:00:39) 09:46:14 INFO - 2015-11-10 09:46:14,096 INFO : Completed test suite (00:20:15) 09:46:14 INFO - 2015-11-10 09:46:14,097 DEBUG : Working with test: dromaeo_css 09:46:14 INFO - 2015-11-10 09:46:14,097 DEBUG : Generating results file: dromaeo_css 09:46:14 INFO - 2015-11-10 09:46:14,097 DEBUG : Working with test: kraken 09:46:14 INFO - 2015-11-10 09:46:14,097 DEBUG : Generating results file: kraken 09:46:14 INFO - 2015-11-10 09:46:14,098 INFO : javascript benchmark 09:46:14 INFO - 2015-11-10 09:46:14,098 DEBUG : Working with test: v8_7 09:46:14 INFO - 2015-11-10 09:46:14,098 DEBUG : Generating results file: v8_7 09:46:14 INFO - 2015-11-10 09:46:14,098 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:14 INFO - 2015-11-10 09:46:14,259 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 09:46:14 INFO - 2015-11-10 09:46:14,259 DEBUG : process_Request line: dromaeo_css 5844.43 graph.html#tests=[[72,52,55]] 09:46:14 INFO - 2015-11-10 09:46:14,259 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:14 INFO - 2015-11-10 09:46:14,286 DEBUG : process_Request line: kraken 1722.00 graph.html#tests=[[232,52,55]] 09:46:14 INFO - 2015-11-10 09:46:14,286 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:14 INFO - 2015-11-10 09:46:14,315 DEBUG : process_Request line: v8_7 17801.92 graph.html#tests=[[230,52,55]] 09:46:14 INFO - 2015-11-10 09:46:14,315 INFO : javascript benchmark 09:46:14 INFO - 2015-11-10 09:46:14,317 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [304.93901219756054, 310.21825000997484, 312.1680720878858, 316.54891779214626, 319.2465780757412, 13267.071305008652, 13707.314634268272, 15338.079715217094, 15575.221238938051, 15687.686246275081, 13635.93182034091, 15848.445304414348, 15981.680366392666, 16346.673066538662, 16574.41989530367, 4477.552244775529, 4564.9087018259615, 4628.375169352128, 4631.976840115812, 4637.258038713807, 3613.22315702124, 3736.0473079364724, 4677.766111694419, 4698.201305778026, 5089.389273287211, 5122.15484445068, 5164.6384753067305, 5179.2749015137915, 5213.739313034352, 5222.373315202181, 5051.44434112251, 5178.300929374562, 5182.378114626231, 5194.454582268845, 5225.6864588124645, 4490.146872094324, 4490.169318676023, 4506.752128632924, 4508.639308855317, 4508.684392092555, 10715.892841071567, 11107.222494425394, 11117.610883619116, 11120.666380008613, 19750.0, 1574.6929348776994, 1614.636706740974, 1629.1609820942224, 1732.8613710903098, 1928.7685477742762, 7857.489263197874, 8138.918610813876, 8287.50274983503, 8318.875216871751, 8321.417500774949, 1287.9549215777404, 1324.251797734277, 1340.0150889096506, 1341.6511706956262, 1427.1009264163615, 49640.0, 51779.96440071215, 52530.0, 53309.7334513325, 55051.17423238655, 5506.504414602705, 5564.137558678412, 5573.804916827891, 5699.430056994351, 5741.684207368635, 6626.7017984190825, 6653.4677225821815, 6662.167229096363, 6663.200415950117, 6668.766593169215, 4709.740964246999, 4718.834840780556, 4740.051989602093, 4746.28805679144, 4755.524447555286, 5005.499450054966, 5150.098732721759, 5287.550558202596, 5300.04599172145, 5326.360836699543, 2577.1237779154803, 2577.8839952202197, 2585.75435333643, 2599.6620439342764, 2605.843649381043, 891.8350105230553, 899.6311512279934, 943.0428115462811, 954.9734035911423, 970.7184916374173, 350.441046530783, 356.6968077134467, 375.2944464406952, 377.1871616666089, 379.3910773209015, 9853.605855765833, 9936.751581210528, 10036.447995360326, 10224.079832815083, 10270.948645256725, 338.8068800783579, 363.12486906555074, 363.9199376137246, 380.38187944590044, 383.4937881995739, 4791.976040119846, 5140.40885298188, 5408.729563521808, 5455.8363249102595, 5486.753096110685, 527746.0, 531543.0, 539054.0, 544875.0, 545391.0, 66087.0, 68453.0, 69765.30234697588, 70191.0, 71601.0, 364.6062252767058, 371.95722491913233, 372.4060124102053, 373.68050316979134, 378.27182673353684, 8671.132886711279, 9010.639574417211, 9110.043445438134, 9121.315901307296, 9296.95351523238, 30125.69874301229, 30520.542191866694, 31191.84404077965, 31770.841145794122, 31985.520217196296, 39496.0, 40169.59830401659, 40501.39247911225, 40950.59049409468, 41031.0, 1987.9006049697168, 5257.7371131442505, 5346.278252435872, 5347.224652425454, 5393.946060539502, 9642.42145471274, 9704.514774261117, 9757.024297570186, 9807.558659860466, 9860.06329398706, 8326.50040997542, 8467.195616416431, 8615.784605384915, 8618.439801412887, 8649.264812491008, 8179.0, 8256.050554186346, 8283.792905177177, 8284.958575207085, 8453.450525715809, 7564.130125035471, 7949.960250198943, 8712.78218044554, 8820.382573219813, 8972.327075469497, 5455.663362476219, 5606.775728970795, 5607.831765047055, 5608.7195640217005, 5612.7754889803955, 8763.780905477413, 8779.824403512022, 8922.821543568962, 8988.325875559229, 9030.593623286837], "dojo.html": [2792.357757715725, 2887.35034617211, 2916.810407323524, 2919.3285544324817, 2948.793584449089, 4748.169070412677, 4891.902161956763, 4913.754312284389, 4923.803047878089, 4926.679765815219, 4859.635527335447, 4905.926411103827, 4907.460179380265, 4929.309896614477, 4944.406671199461, 4312.698111132222, 4412.404325416076, 4452.57700518451, 4498.910021799562, 4571.817127314904, 4340.544242854502, 4352.695311328208, 4372.12557488502, 4372.825086996516, 4392.846250381222, 4400.735955842643, 4404.163208990298, 4415.911681766363, 4422.557744225568, 4434.600885920267, 4260.297050986584, 4320.1143765527995, 4354.216241076605, 4411.514733379326, 4471.441069866267, 4342.934855977162, 4368.060866913597, 4375.299952007664, 4376.081022985177, 4395.230834603964, 4604.654650901162, 4653.674242803005, 4727.196376615983, 4765.475797662289, 4774.880627984294, 5052.520010598987, 5069.087564238435, 5085.415177254626, 5196.0647083524955, 5210.348706411699, 5128.538431541142, 5131.307273518102, 5131.486851314876, 5143.871403214912, 5153.072446959546, 4739.194336962724, 4827.8551643450755, 4842.612590992712, 4860.416749990024, 4867.780949857265, 5157.819476318311, 5196.0, 5236.659617124875, 5238.60710446718, 5250.7374631268285, 5128.820491282861, 5166.43169251382, 5192.81825136126, 5195.558377537952, 5212.765425555859, 4860.1737704590305, 5260.210968354778, 5284.497972692588, 5298.364196296469, 5327.227552004938, 4986.800527978913, 5050.242463630485, 5070.61970352225, 5138.434772175057, 5148.742562871841, 5109.259157422153, 5148.588112950955, 5153.381594208644, 5175.508326708957, 5176.7411629418375, 3706.2772759311674, 4023.597640235953, 4033.011912081559, 4035.1324465239527, 4080.367543030835, 3559.394902866519, 3602.5136606558303, 3630.419132938717, 3645.835937382771, 3666.3034023535442, 4821.0, 4835.323054772264, 4837.7581120944515, 4839.0, 4845.3216549683075, 4886.242632391985, 5279.076161671769, 5280.392754833167, 5284.656497327738, 5291.497307755757, 4558.612517936012, 4586.036932244266, 4714.127886340969, 4826.6621336506105, 4854.2233242681, 4483.14820184164, 4504.909901801946, 4558.635309175258, 4558.703684260512, 4565.338025986213, 4982.327385803015, 5194.506521880416, 5283.286756287852, 5284.048871203144, 5300.5759539236, 5072.28987941681, 5097.2608971698155, 5138.537531622172, 5217.008768334004, 5225.843224703265, 5211.0359583477175, 5287.4976877196605, 5294.391145018218, 5303.098473259478, 5326.174442961347, 4947.579455746302, 5174.404943431554, 5187.870303242449, 5219.921701174561, 5249.47505249472, 4976.979719157492, 4993.15116430215, 5125.5899528036925, 5212.661177023481, 5237.2667826505085, 4968.726720030289, 4971.676841005323, 4986.9251961221335, 5002.474740152232, 5011.799528018839, 4825.9758701207675, 4963.10664080469, 4969.552740253394, 4977.875553111201, 5005.99880024004, 4856.295837103529, 4926.236433352836, 4932.950670493393, 4942.332785073969, 4951.826686066114, 5027.4218464877, 5085.389753229488, 5091.898162036812, 5127.46161653021, 5133.974330128325, 4807.086653535817, 4925.0, 5060.165072762953, 5061.139606267017, 5085.669431486942], "mootools.html": [764.6367975211772, 1244.3342811595796, 1252.09223313098, 1286.401823152234, 1621.0597853245113, 6459.3217712140195, 6695.096162018126, 6850.794476165716, 6975.337342952412, 6975.372216500514, 6791.898121528168, 6848.828779280508, 6891.965540172305, 6907.171139463258, 6920.65396730164, 1933.9226430942745, 1950.9414717558495, 1955.1983686688461, 1955.9902200489048, 1958.3341663834294, 1930.9613807723838, 1942.815432533907, 1947.4157752674212, 1973.792751761066, 1976.940691779249, 1969.350114462224, 1982.6530357187507, 1996.291316582614, 1999.210311926788, 1999.7400337956046, 1962.13665986966, 1972.2998335590946, 1976.7627884653862, 1976.901154942247, 1983.514039060425, 1916.7891531931477, 1946.1047917957615, 1958.177565422526, 1966.5083729067733, 1976.170008596393, 6215.098810672473, 6942.618156001418, 6949.0, 6953.860922781567, 6967.756128535477, 3826.579076301605, 4124.154548317588, 4216.325387937915, 4224.176285624305, 4292.914141717149, 2354.5173239485866, 2358.4929240213437, 2406.8074554035634, 2427.8664673442954, 2433.7444568320248, 720.495653042872, 731.3417923868508, 739.3604532079767, 742.6658003898214, 754.031070074951, 9021.548922553846, 9028.232600228988, 9055.592498337524, 9059.909400906039, 9192.816143677155, 3674.1365779041903, 3710.239400922804, 3760.7743535387963, 3815.389537673959, 3828.2152158807376, 7909.327707144842, 7939.603019848984, 7944.44388892772, 7987.800304992305, 8014.639341229658, 4288.935665965013, 4290.099079193405, 4295.72077814941, 4313.0726893718, 4313.698041137153, 3887.436321733333, 3896.9610303897166, 3897.4738410314812, 3902.3951287550476, 3903.1608204236227, 3055.15983104648, 3064.417760625474, 3077.261457250244, 3079.92300192497, 3101.7673674474054, 964.8359778837614, 968.5835090910836, 971.7133445633555, 973.2262851033446, 980.3333733061587, 1089.3899416326883, 1114.7603265298, 1121.1311233793713, 1125.0380924309598, 1181.7341098252996, 6505.60966342021, 6582.670866456658, 6645.302243264484, 6718.260991290954, 6740.427063699641, 366.21629712415455, 367.6599145790187, 369.8557562550607, 371.5652686356915, 373.0375630872343, 5238.1618940969265, 5321.255024296602, 5322.3879253885525, 5326.520613144836, 5337.599680024014, 7616.504927179715, 7751.651175697107, 8018.198180182052, 8228.30059444942, 8236.794080148044, 8116.959415203004, 8162.265396114378, 8168.754937351889, 8189.426740128253, 8190.8771368429525, 6468.579542329733, 6528.608283503005, 6557.836054098686, 6627.768028118992, 6630.734770609218, 6027.095935609694, 6034.7284372202475, 6052.90920636182, 6058.3335833057445, 6090.208272924491, 7222.169450513258, 7449.6275186241555, 7511.0, 7522.285382888617, 7529.247075292427, 7488.737894173678, 7678.654460549177, 7719.845603087794, 7775.183605721544, 7804.9219507806465, 6145.692715364304, 6174.536909731698, 6177.660228687465, 6192.907106393318, 6198.2252218472695, 6013.699315034319, 6389.073584330339, 6395.072714456471, 6397.712102955285, 6400.327965563735, 6092.75628974836, 6137.693115344304, 6152.046432802923, 6216.285127210248, 6221.564490485623, 5985.25184351956, 5998.4601385875485, 6090.604110732788, 6093.512518998558, 6119.877602448015, 6188.164597779242, 6199.442050215503, 6217.4715149211015, 6229.875402491834, 6245.750169993149, 5629.802956896489, 5641.8589535261945, 5648.209250704823, 5649.661020338793, 5651.773929042793, 5688.601797874275, 5698.20225168485, 5740.598158128891, 5741.368449470639, 5746.856328591819], "ext.html": [497.16724486485134, 504.38716958894935, 516.5660844890293, 518.0261109114865, 539.0378174957701, 30011.0, 31014.689853101463, 36376.090597735034, 36843.815780921126, 36914.0, 38437.23125537488, 39015.804920975424, 39205.21589568207, 39237.0, 39315.803420982855, 7610.543367397946, 8187.713430029935, 8213.0, 8275.834483310331, 8326.04250511193, 7621.885671714928, 9698.903010969905, 9978.700638980807, 9981.451020193887, 9981.550830212622, 9057.728268151934, 9694.66068687596, 9762.316637835354, 9774.071463210983, 9792.461414622192, 7699.615019249015, 7880.684772609089, 9676.709698709015, 9760.755981100458, 9785.755356116082, 9545.665901693477, 9657.0, 9658.613655453773, 9696.07887250717, 9722.222222222275, 35937.281254374764, 36287.637123628956, 36480.0, 36498.635013649786, 36563.268734625155, 2591.6889973203147, 2631.276398990293, 2636.2223144172517, 2786.70739572344, 3000.0, 25277.0, 25323.62014569783, 25520.744792552206, 25788.0, 26006.789422899077, 2047.5597746484427, 2078.9792102079086, 2091.905864236113, 2120.204923153817, 2161.7189765330563, 251168.0, 252314.0, 254623.0, 254986.0, 257444.0, 53650.0, 54992.80028798883, 56140.43859561352, 56531.60810351392, 56580.71709641508, 65525.67237163784, 66202.0, 66751.33248667548, 66827.33172668211, 67135.66432167905, 15042.0, 15141.242937853063, 15171.0, 15179.316930738143, 15184.088954662755, 11844.644660660195, 11871.109666775026, 11876.0, 11891.108166887518, 11899.345535995604, 18496.352627658238, 18704.438866834018, 18709.158087886077, 18714.0, 18727.531811704543, 7534.585597792174, 7775.377969762519, 7805.726799562101, 7811.921880781233, 7851.097123830718, 801.6592947997078, 852.7015544559355, 897.0984160918235, 897.3628723606182, 954.613381580461, 23799.643005354934, 23993.760062399153, 23995.760042399703, 24068.0, 24145.275641730776, 921.8893732751978, 970.5583959298502, 977.4507405761805, 985.5811280205884, 1060.3690803971624, 11786.882131178578, 13943.0, 14223.786643200361, 14443.927780361031, 14481.20353380553, 283731.0, 289044.0, 291639.0, 292666.0, 294299.0, 49881.50118498768, 50566.0, 50751.49248507542, 50754.0, 50790.74604627027, 1272.2557303977278, 1272.4401263444056, 1281.525835440893, 1291.0704292908902, 1294.3916359311108, 26053.08814191494, 26154.607680884423, 26618.467630647665, 26638.0, 26981.460370792083, 44244.778776105915, 44737.776311118236, 44883.326750098124, 44894.77552612216, 44921.55078449305, 264708.0, 264907.0, 265184.0, 266508.0, 266598.0, 24771.87614061918, 25342.746572534776, 27468.313292167855, 27744.58383124295, 28181.859090704416, 37964.0, 37986.43020354641, 37992.24015519619, 38514.229715406094, 38578.421323680726, 29620.0, 30732.84633576818, 30791.076267712004, 30855.0, 32187.51718724174, 26074.0, 29201.0, 29867.850660746557, 30455.695443045286, 30642.693573064877, 30737.231569210948, 31043.68956310408, 31050.0, 31067.533986990664, 31181.0, 24875.378115546533, 25927.0, 27994.580081299206, 28964.565531516622, 30567.694323057374, 21726.45683857916, 21754.45613859603, 21755.238566650725, 21875.453113672287, 21974.89012554927], "prototype.html": [275.86206896551727, 280.2531254207536, 286.4828983684449, 298.5357768669719, 302.05306364547164, 5386.1920711893235, 5422.4306447823, 5455.236266922629, 5455.809046683366, 5521.751521181546, 5350.063738845696, 5406.08096623574, 5407.783688652449, 5411.702356370398, 5431.674099554029, 4161.542230354658, 4162.417261583373, 4164.646005089571, 4168.687348448863, 4203.7687927164, 3998.920021599566, 4088.121053973395, 4101.774402407867, 4177.540470548237, 4188.204241194163, 4086.8773936781945, 4121.443605113302, 4132.979335103335, 4143.958560414388, 4163.68772342074, 3960.089179488734, 4036.1725846201457, 4128.62842344189, 4130.545639979599, 4151.086760912624, 3467.8439470223902, 3489.6859282664427, 3490.8603655853735, 3503.807290599016, 3512.929741405183, 5221.530062294411, 5222.73886305687, 5229.424763276036, 5256.342957130359, 5266.104762190398, 4600.654950878664, 4618.307253911907, 4620.3069539569, 4623.86128416148, 4623.9075218495445, 5437.945620543784, 5564.554835613141, 5615.101583746622, 5616.269884914976, 5623.887522249573, 3805.162864169878, 3808.0, 3808.733388662795, 3810.3522401191863, 3826.196498735241, 5776.711164441761, 5810.273715785527, 5911.142884281755, 5943.138244954457, 5948.0, 4002.0, 4033.4756481657196, 4044.0, 4044.6157615026527, 4056.5740597236863, 4060.9796951015055, 4068.6948478864206, 4085.0604360996545, 4090.4865199876235, 4090.6727461802984, 4516.277395616686, 4672.859814205579, 4685.437747470257, 4688.57802797743, 4692.671512994126, 5622.746976386073, 5624.100143976944, 5632.408597097246, 5641.153826925994, 5646.350669672958, 1466.6846627975037, 1484.0872863189277, 1492.0, 1492.835788063312, 1495.0506428418032, 928.9907100929039, 932.9253659707207, 949.8670186173941, 951.3578334624101, 978.7014960436993, 5353.598480114007, 5360.383555891122, 5360.981413531416, 5366.114591092504, 5385.299911011622, 5834.0, 5850.473457388855, 5918.201042859159, 5933.169356290123, 5970.313413957364, 5333.013392522395, 5334.3865455473115, 5344.6258761887075, 5346.518813306743, 5350.5987050971335, 3163.0194639661777, 3184.8407579620925, 3232.563603913489, 3255.088575198948, 3260.951085733716, 5823.475887170175, 5828.184054232411, 5926.7925622603, 5929.229200204032, 5952.76188952437, 5976.5218782497295, 6011.0382338825575, 6023.27720673522, 6027.547933904887, 6028.638281703112, 5934.703264836828, 5946.048632218911, 5950.19672344228, 5961.344252132262, 5982.73077711504, 5713.571482138773, 5897.64614123154, 5903.852403689943, 5913.526917846648, 6004.939950600613, 5830.5044071254415, 5831.8833623326445, 5845.09401042839, 5859.0, 5881.529477641864, 6015.428534289235, 6031.819045428644, 6036.879262414815, 6074.90887636677, 6080.908786368296, 3703.833327500323, 3788.3749181384765, 3820.4842346282894, 3824.7322687411615, 3854.575996640311, 5940.61386009908, 5941.0494320910175, 5961.463468287875, 5962.761489540369, 5991.490723288569, 5819.650820950587, 5825.3883342248455, 5825.70871456434, 5854.063349864001, 5869.325027621708, 5625.240592519957, 5774.56690748204, 5783.768649254151, 5806.65160090396, 5807.564432667482, 5638.5771067170945, 5640.182173584889, 5655.660660360391, 5671.773129074791, 5709.743061562157, 5734.799282025109, 5742.397048309867, 5756.856078598069, 5770.6249093808765, 5785.681787501728, 5493.121100623881, 5563.582731295088, 5612.5509959202345, 5626.409227031103, 5658.547316214611], "yui.html": [594.934557198708, 595.8540157661373, 600.3696119074971, 683.5181197255935, 693.3309356471004, 12308.692282692937, 12598.307093109886, 12610.117291789567, 12620.873791262085, 12663.0, 11650.184487085908, 11724.589639362624, 11765.058795296378, 11775.823362649568, 11789.587364442224, 650.8958566629341, 675.5372569789686, 787.5471603827793, 796.3788245168748, 807.8222790985974, 813.0243707550933, 818.6111596991411, 820.5076953827715, 820.6471217376555, 822.411975437562, 664.5713514782963, 831.9168083191663, 833.3374966901328, 836.6946064686407, 841.0202114536557, 666.6500087454101, 821.2116368286422, 830.8462934357163, 833.2417500074903, 834.8914641096619, 595.910613407988, 600.8768202518517, 603.1375133559009, 603.2218438214697, 604.8729766748988, 11757.176997610171, 11841.703957401047, 11851.703707407298, 11872.52509899603, 11877.940610296893, 7797.883031754528, 7979.640916158787, 8175.223353781381, 8227.670893164266, 8364.916350836535, 7997.320227780588, 8053.476524025919, 8109.4323397362205, 8447.95776021116, 8718.17177368149, 2530.4433024734712, 2584.8966041358512, 2595.2733234694315, 2598.1555994301925, 2613.830101043426, 42305.153896922195, 42398.0, 42456.150876982596, 42686.78656606728, 43153.35269970921, 5950.434708702666, 6130.754769809158, 6227.221597300338, 6231.875362492725, 6272.109858944679, 9913.0, 9915.900840991642, 9923.751906202402, 9935.65225217114, 9986.950065249772, 5442.102053161263, 5463.9180412293845, 5473.370562385297, 5625.09998400254, 5699.230603868425, 3265.7387409007224, 3348.68187522185, 3376.12220822583, 3442.4836274558515, 3446.6897979181995, 2366.3847399675865, 2375.0618505690154, 2395.0778950103986, 2398.928032159038, 2407.1334319644916, 358.0368807906723, 362.44726791642955, 362.45812510297276, 402.3281120528724, 421.23335529336316, 408.8875559221238, 427.9358096285582, 491.2582001178247, 497.01590850116247, 537.8677883056189, 7000.26497217795, 7033.191183013917, 7126.35862772353, 7226.6386680665755, 7236.96381518089, 435.5709626018433, 506.187568951827, 516.1947362115112, 520.2846086630883, 530.6948504609865, 3370.410178218802, 3501.7373696972827, 3532.4701294805473, 3698.223373091681, 3851.4607954886337, 48376.758116209196, 48609.27086093711, 48617.27074093891, 48747.512524875005, 49393.259101113515, 41338.586614134074, 42510.362344564855, 42750.78624606857, 43202.351964720554, 43301.35047974283, 40620.593794062275, 41299.38050929239, 41859.0, 41975.1604967899, 42333.99999999938, 7161.534500257467, 7544.585047822423, 7597.962010190135, 7601.3918886490055, 7767.0, 31010.379792404477, 31052.0, 31268.530972034983, 31655.52516712297, 31663.20841978969, 39444.60555394409, 41645.79177104095, 41912.580874192085, 42377.0, 42477.0, 6426.196725409324, 6451.838704032437, 6690.29751876046, 6765.86468270622, 6842.521023528305, 9738.659146929824, 9752.804943901225, 9786.75533111678, 10105.696829095139, 10378.117859981685, 9083.409578377385, 9317.16145546904, 9408.200302974325, 9499.715008549754, 9855.556499957376, 8818.941726992802, 8958.0, 9093.318001149808, 9141.080373121453, 9152.993170751346, 9379.953100234456, 9430.151286384258, 9434.245260379015, 9453.0, 9803.166730827674, 7719.112302085332, 7772.650230739743, 7885.0, 8081.757547273356, 8351.707690230813, 7852.332551733167, 8166.387520935835, 8270.710525131592, 8343.624536895733, 8421.873671894804]}, "summary": {"suite": 5844.430104175926, "subtests": {"jquery.html": {"filtered": 5944.4684451994135, "value": 5944.4684451994135}, "dojo.html": {"filtered": 4755.453113747242, "value": 4755.453113747242}, "mootools.html": {"filtered": 3797.527690895549, "value": 3797.527690895549}, "ext.html": {"filtered": 16923.823028826577, "value": 16923.823028826577}, "prototype.html": {"filtered": 4276.708375640212, "value": 4276.708375640212}, "yui.html": {"filtered": 5128.545962392412, "value": 5128.545962392412}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0039"}, "testrun": {"date": 1447176358, "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": "44.0a2", "id": "20151110075834", "branch": "Mozilla-Aurora", "revision": "348be28b64b62abc5b3b0a45de9575a7f754d5b6"}}, {"talos_counters": {}, "results": {"audio-dft": [185.0, 186.0, 186.0, 181.0, 181.0, 189.0, 189.0, 188.0, 181.0, 185.0], "ai-astar": [122.0, 127.0, 125.0, 124.0, 128.0, 123.0, 135.0, 127.0, 126.0, 125.0], "imaging-gaussian-blur": [136.0, 142.0, 136.0, 135.0, 131.0, 129.0, 141.0, 135.0, 142.0, 132.0], "audio-beat-detection": [180.0, 149.0, 177.0, 185.0, 149.0, 179.0, 178.0, 144.0, 188.0, 144.0], "json-stringify-tinderbox": [71.0, 72.0, 72.0, 77.0, 76.0, 76.0, 76.0, 76.0, 73.0, 74.0], "stanford-crypto-pbkdf2": [165.0, 169.0, 173.0, 170.0, 171.0, 163.0, 167.0, 173.0, 170.0, 156.0], "json-parse-financial": [63.0, 69.0, 69.0, 72.0, 72.0, 73.0, 72.0, 83.0, 66.0, 68.0], "stanford-crypto-sha256-iterative": [77.0, 77.0, 82.0, 83.0, 81.0, 82.0, 81.0, 81.0, 82.0, 80.0], "audio-fft": [90.0, 94.0, 91.0, 143.0, 76.0, 80.0, 81.0, 81.0, 134.0, 78.0], "imaging-darkroom": [146.0, 146.0, 148.0, 145.0, 141.0, 146.0, 146.0, 147.0, 144.0, 140.0], "stanford-crypto-ccm": [138.0, 141.0, 141.0, 142.0, 150.0, 136.0, 138.0, 140.0, 145.0, 144.0], "audio-oscillator": [114.0, 116.0, 161.0, 102.0, 104.0, 105.0, 145.0, 103.0, 103.0, 142.0], "stanford-crypto-aes": [91.0, 95.0, 96.0, 96.0, 97.0, 94.0, 95.0, 96.0, 96.0, 101.0], "imaging-desaturate": [118.0, 117.0, 118.0, 119.0, 117.0, 118.0, 119.0, 119.0, 116.0, 117.0]}, "summary": {"suite": 1722.0, "subtests": {"audio-fft": {"filtered": 94.8, "value": 94.8}, "stanford-crypto-pbkdf2": {"filtered": 167.7, "value": 167.7}, "audio-beat-detection": {"filtered": 167.3, "value": 167.3}, "stanford-crypto-ccm": {"filtered": 141.5, "value": 141.5}, "imaging-darkroom": {"filtered": 144.9, "value": 144.9}, "json-parse-financial": {"filtered": 70.7, "value": 70.7}, "audio-oscillator": {"filtered": 119.5, "value": 119.5}, "ai-astar": {"filtered": 126.2, "value": 126.2}, "audio-dft": {"filtered": 185.1, "value": 185.1}, "stanford-crypto-sha256-iterative": {"filtered": 80.6, "value": 80.6}, "json-stringify-tinderbox": {"filtered": 74.3, "value": 74.3}, "imaging-gaussian-blur": {"filtered": 135.9, "value": 135.9}, "stanford-crypto-aes": {"filtered": 95.7, "value": 95.7}, "imaging-desaturate": {"filtered": 117.8, "value": 117.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0039"}, "testrun": {"date": 1447176358, "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": "44.0a2", "id": "20151110075834", "branch": "Mozilla-Aurora", "revision": "348be28b64b62abc5b3b0a45de9575a7f754d5b6"}}, {"talos_counters": {}, "results": {"DeltaBlue": [220.5071664829107], "Encrypt": [362.4501631025734], "NavierStokes": [6568.6274509803925], "Decrypt": [6718.120805369127], "Splay": [657.4621959237344], "Richards": [190.36740909956217], "RegExp": [33583.333333333336], "Earley": [789.8894154818325], "Boyer": [14285.714285714286], "RayTrace": [1179.245283018868]}, "summary": {"suite": 17801.92227342409, "subtests": {"DeltaBlue": {"filtered": 299.8451300000001, "value": 299.8451300000001}, "Encrypt": {"filtered": 734.3933790000001, "value": 734.3933790000001}, "NavierStokes": {"filtered": 225.92238805970155, "value": 225.92238805970155}, "Decrypt": {"filtered": 39.62134765234768, "value": 39.62134765234768}, "Splay": {"filtered": 123.94781100000004, "value": 123.94781100000004}, "RegExp": {"filtered": 27.126104218362286, "value": 27.126104218362286}, "Richards": {"filtered": 185.441406, "value": 185.441406}, "Earley": {"filtered": 843.7421580000001, "value": 843.7421580000001}, "Boyer": {"filtered": 46.65241000000003, "value": 46.65241000000003}, "RayTrace": {"filtered": 627.5106720000002, "value": 627.5106720000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0039"}, "testrun": {"date": 1447176358, "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": "44.0a2", "id": "20151110075834", "branch": "Mozilla-Aurora", "revision": "348be28b64b62abc5b3b0a45de9575a7f754d5b6"}}] 09:46:14 INFO - RETURN: dromaeo_css: 5844.43 09:46:14 INFO - RETURN: kraken: 1722.00 09:46:14 INFO - RETURN: v8_7: 17801.92 09:46:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17801.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1722.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5844.43"}}} 09:46:14 INFO - Return code: 0 09:46:14 INFO - # TBPL SUCCESS # 09:46:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:14 INFO - 2015-11-10 09:46:14.435 screenresolution[1938:13711] starting screenresolution argv=screenresolution get 09:46:14 INFO - 2015-11-10 09:46:14.438 screenresolution[1938:13711] Display 0: 1600x1200x32@60 09:46:14 INFO - 2015-11-10 09:46:14.445 screenresolution[1939:13716] starting screenresolution argv=screenresolution list 09:46:14 INFO - Available Modes on Display 0 09:46:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:14 INFO - Intel HD Graphics 3000: 09:46:14 INFO - Chipset Model: Intel HD Graphics 3000 09:46:14 INFO - Type: GPU 09:46:14 INFO - Bus: Built-In 09:46:14 INFO - VRAM (Total): 512 MB 09:46:14 INFO - VRAM (Dynamic, Max): 10 09:46:14 INFO - Vendor: Intel (0x8086) 09:46:14 INFO - Device ID: 0x0116 09:46:14 INFO - Revision ID: 0x0009 09:46:14 INFO - Displays: 09:46:14 INFO - Display: 09:46:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:14 INFO - Display Serial Number: 1600x1200 60 09:46:14 INFO - Main Display: Yes 09:46:14 INFO - Mirror: Off 09:46:14 INFO - Online: Yes 09:46:14 INFO - Rotation: Supported 09:46:14 INFO - Return code: 0 09:46:14 INFO - Running post-action listener: _resource_record_post_action 09:46:14 INFO - Running post-run listener: _resource_record_post_run 09:46:15 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 765952; Write bytes: 688332800; Read time: 471; Write time: 42853 09:46:15 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 339671552; Write bytes: 333850624; Read time: 35558; Write time: 4433 09:46:15 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 765952; Write bytes: 343160832; Read time: 471; Write time: 37884 09:46:15 INFO - Running post-run listener: _upload_blobber_files 09:46:15 INFO - Blob upload gear active. 09:46:15 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:46:15 INFO - Copying logs to upload dir... 09:46:15 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1312.474806 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-10 09:46:15.946873) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 09:46:15.950000) ========= 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.s0HbaskrWk/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.BNWLj0HsoE/Listeners TMPDIR=/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010762 build_url: 'https://queue.taskcluster.net/v1/task/lBCIpGGxSsWbgnI6ap6_Hw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 09:46:15.977896) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 09:46:15.978219) ========= 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.s0HbaskrWk/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.BNWLj0HsoE/Listeners TMPDIR=/var/folders/9_/4nvhy2yx6xncdb1trh116m4r00000w/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.005710 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 09:46:16.027480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 09:46:16.027804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 09:46:16.028187) ========= ========= Total master_lag: 9.57 =========