builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0095 starttime: 1446719343.63 results: success (0) buildid: 20151105005737 builduid: f16c1336cd1a4742bb6ecc41afbc2763 revision: c951580b6f9b81f7dcab62b40d03ad96d666e1ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.633484) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.633952) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.634282) ========= 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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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.006821 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.667111) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.667532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.696613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.697023) ========= 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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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.005813 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.746914) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.747256) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.747987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:03.748304) ========= 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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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-05 02:29:03-- 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.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.67M=0.002s 2015-11-05 02:29:04 (7.67 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.374075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.141550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.141942) ========= 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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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.021670 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.201690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.202229) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c951580b6f9b81f7dcab62b40d03ad96d666e1ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c951580b6f9b81f7dcab62b40d03ad96d666e1ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eHvsjjl4jI/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.XXzPqAEfxg/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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-05 02:29:04,282 truncating revision to first 12 chars 2015-11-05 02:29:04,283 Setting DEBUG logging. 2015-11-05 02:29:04,283 attempt 1/10 2015-11-05 02:29:04,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c951580b6f9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-05 02:29:04,555 unpacking tar archive at: fx-team-c951580b6f9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.770100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.770460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.790116) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.790507) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 02:29:04.791095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-05 02:29:04.791466) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eHvsjjl4jI/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.XXzPqAEfxg/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:29:05 INFO - MultiFileLogger online at 20151105 02:29:05 in /builds/slave/test 02:29:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:29:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:29:05 INFO - {'append_to_log': False, 02:29:05 INFO - 'base_work_dir': '/builds/slave/test', 02:29:05 INFO - 'blob_upload_branch': 'Fx-Team', 02:29:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:29:05 INFO - 'branch': 'Fx-Team', 02:29:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:29:05 INFO - 'config_files': ('talos/mac_config.py',), 02:29:05 INFO - 'default_actions': ('clobber', 02:29:05 INFO - 'read-buildbot-config', 02:29:05 INFO - 'download-and-extract', 02:29:05 INFO - 'populate-webroot', 02:29:05 INFO - 'create-virtualenv', 02:29:05 INFO - 'install', 02:29:05 INFO - 'run-tests'), 02:29:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:29:05 INFO - 'download_minidump_stackwalk': True, 02:29:05 INFO - 'download_symbols': 'ondemand', 02:29:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:29:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:29:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:29:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:29:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:29:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:29:05 INFO - 'installer_path': 'installer.exe', 02:29:05 INFO - 'log_level': 'info', 02:29:05 INFO - 'log_name': 'talos', 02:29:05 INFO - 'log_to_console': True, 02:29:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:29:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:29:05 INFO - 'opt_config_files': (), 02:29:05 INFO - 'pip_index': False, 02:29:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:29:05 INFO - 'cmd': ('bash', 02:29:05 INFO - '-c', 02:29:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:29:05 INFO - 'enabled': True, 02:29:05 INFO - 'halt_on_failure': False, 02:29:05 INFO - 'name': 'check_screen_resolution'},), 02:29:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:29:05 INFO - 'cmd': ('bash', 02:29:05 INFO - '-c', 02:29:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:29:05 INFO - 'enabled': True, 02:29:05 INFO - 'halt_on_failure': False, 02:29:05 INFO - 'name': 'check_screen_resolution'},), 02:29:05 INFO - 'run_cmd_checks_enabled': True, 02:29:05 INFO - 'sps_profile': False, 02:29:05 INFO - 'sps_profile_interval': 0, 02:29:05 INFO - 'suite': 'dromaeojs', 02:29:05 INFO - 'system_bits': '64', 02:29:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:29:05 INFO - 'title': 't-yosemite-r5-0095', 02:29:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:29:05 INFO - 'use_talos_json': True, 02:29:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:29:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:29:05 INFO - 'work_dir': 'build'} 02:29:05 INFO - ##### 02:29:05 INFO - ##### Running clobber step. 02:29:05 INFO - ##### 02:29:05 INFO - Running pre-action listener: _resource_record_pre_action 02:29:05 INFO - Running main action method: clobber 02:29:05 INFO - rmtree: /builds/slave/test/build 02:29:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:29:06 INFO - Running post-action listener: _resource_record_post_action 02:29:06 INFO - ##### 02:29:06 INFO - ##### Running read-buildbot-config step. 02:29:06 INFO - ##### 02:29:06 INFO - Running pre-action listener: _resource_record_pre_action 02:29:06 INFO - Running main action method: read_buildbot_config 02:29:06 INFO - Using buildbot properties: 02:29:06 INFO - { 02:29:06 INFO - "properties": { 02:29:06 INFO - "buildnumber": 1188, 02:29:06 INFO - "product": "firefox", 02:29:06 INFO - "script_repo_revision": "production", 02:29:06 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 02:29:06 INFO - "repository": "", 02:29:06 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 02:29:06 INFO - "buildid": "20151105005737", 02:29:06 INFO - "slavename": "t-yosemite-r5-0095", 02:29:06 INFO - "pgo_build": "False", 02:29:06 INFO - "basedir": "/builds/slave/test", 02:29:06 INFO - "project": "", 02:29:06 INFO - "platform": "yosemite", 02:29:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:29:06 INFO - "slavebuilddir": "test", 02:29:06 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:29:06 INFO - "branch": "fx-team", 02:29:06 INFO - "repo_path": "integration/fx-team", 02:29:06 INFO - "stage_platform": "macosx64", 02:29:06 INFO - "builduid": "f16c1336cd1a4742bb6ecc41afbc2763", 02:29:06 INFO - "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca" 02:29:06 INFO - }, 02:29:06 INFO - "sourcestamp": { 02:29:06 INFO - "repository": "", 02:29:06 INFO - "hasPatch": false, 02:29:06 INFO - "project": "", 02:29:06 INFO - "branch": "fx-team-macosx64-talos", 02:29:06 INFO - "changes": [ 02:29:06 INFO - { 02:29:06 INFO - "category": null, 02:29:06 INFO - "files": [ 02:29:06 INFO - { 02:29:06 INFO - "url": null, 02:29:06 INFO - "name": "https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 02:29:06 INFO - } 02:29:06 INFO - ], 02:29:06 INFO - "repository": "", 02:29:06 INFO - "rev": "ff8ebe5251ec227be26994089871cb40c1da3011", 02:29:06 INFO - "who": "jryans@gmail.com", 02:29:06 INFO - "when": 1446718642, 02:29:06 INFO - "number": 6624242, 02:29:06 INFO - "comments": "Bug 1182722 - Add quotes for l10n-check on Windows. rs=glandium on a CLOSED TREE\n", 02:29:06 INFO - "project": "", 02:29:06 INFO - "at": "Thu 05 Nov 2015 02:17:22", 02:29:06 INFO - "branch": "fx-team-macosx64-talos", 02:29:06 INFO - "revlink": "", 02:29:06 INFO - "properties": [ 02:29:06 INFO - [ 02:29:06 INFO - "buildid", 02:29:06 INFO - "20151105001636", 02:29:06 INFO - "Change" 02:29:06 INFO - ], 02:29:06 INFO - [ 02:29:06 INFO - "builduid", 02:29:06 INFO - "8354ded0d0e54afe85f80e2b720e3b09", 02:29:06 INFO - "Change" 02:29:06 INFO - ], 02:29:06 INFO - [ 02:29:06 INFO - "pgo_build", 02:29:06 INFO - "False", 02:29:06 INFO - "Change" 02:29:06 INFO - ] 02:29:06 INFO - ], 02:29:06 INFO - "revision": "ff8ebe5251ec227be26994089871cb40c1da3011" 02:29:06 INFO - }, 02:29:06 INFO - { 02:29:06 INFO - "category": null, 02:29:06 INFO - "files": [ 02:29:06 INFO - { 02:29:06 INFO - "url": null, 02:29:06 INFO - "name": "https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 02:29:06 INFO - } 02:29:06 INFO - ], 02:29:06 INFO - "repository": "", 02:29:06 INFO - "rev": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca", 02:29:06 INFO - "who": "cbook@mozilla.com", 02:29:06 INFO - "when": 1446717528, 02:29:06 INFO - "number": 6624111, 02:29:06 INFO - "comments": "Bug 1215147 - Enable VR API's on FF for Android by default. r=snorp, r=vlad, r=bz", 02:29:06 INFO - "project": "", 02:29:06 INFO - "at": "Thu 05 Nov 2015 01:58:48", 02:29:06 INFO - "branch": "fx-team-macosx64-talos", 02:29:06 INFO - "revlink": "", 02:29:06 INFO - "properties": [ 02:29:06 INFO - [ 02:29:06 INFO - "buildid", 02:29:06 INFO - "20151105005737", 02:29:06 INFO - "Change" 02:29:06 INFO - ], 02:29:06 INFO - [ 02:29:06 INFO - "builduid", 02:29:06 INFO - "f16c1336cd1a4742bb6ecc41afbc2763", 02:29:06 INFO - "Change" 02:29:06 INFO - ], 02:29:06 INFO - [ 02:29:06 INFO - "pgo_build", 02:29:06 INFO - "False", 02:29:06 INFO - "Change" 02:29:06 INFO - ] 02:29:06 INFO - ], 02:29:06 INFO - "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca" 02:29:06 INFO - } 02:29:06 INFO - ], 02:29:06 INFO - "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca" 02:29:06 INFO - } 02:29:06 INFO - } 02:29:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 02:29:06 INFO - Running post-action listener: _resource_record_post_action 02:29:06 INFO - ##### 02:29:06 INFO - ##### Running download-and-extract step. 02:29:06 INFO - ##### 02:29:06 INFO - Running pre-action listener: _resource_record_pre_action 02:29:06 INFO - Running main action method: download_and_extract 02:29:06 INFO - mkdir: /builds/slave/test/build/tests 02:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:06 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:29:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json 02:29:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json 02:29:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:29:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:29:07 INFO - Downloaded 1149 bytes. 02:29:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:29:07 INFO - Using the following test package requirements: 02:29:07 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:29:07 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:29:07 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 02:29:07 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:29:07 INFO - u'jsshell-mac.zip'], 02:29:07 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:29:07 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 02:29:07 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:29:07 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:29:07 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 02:29:07 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:29:07 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 02:29:07 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:29:07 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 02:29:07 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:29:07 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:29:07 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 02:29:07 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:07 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:29:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:29:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:29:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:29:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:29:08 INFO - Downloaded 17457225 bytes. 02:29:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:29:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:29:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:29:13 INFO - Return code: 0 02:29:13 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:13 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:29:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:29:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:29:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:29:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:29:14 INFO - Downloaded 17457225 bytes. 02:29:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:29:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:29:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:29:20 INFO - Return code: 0 02:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:20 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:29:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:29:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:29:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:29:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:29:21 INFO - Downloaded 11131307 bytes. 02:29:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:29:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:29:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:29:22 INFO - Return code: 0 02:29:22 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')]} 02:29:22 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:29:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:29:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:29:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 02:29:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 02:29:26 INFO - Downloaded 108647076 bytes. 02:29:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:29:26 INFO - mkdir: /builds/slave/test/properties 02:29:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:29:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:29:26 INFO - Contents: 02:29:26 INFO - build_url:https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:29:26 INFO - Running post-action listener: _resource_record_post_action 02:29:26 INFO - Running post-action listener: set_extra_try_arguments 02:29:26 INFO - ##### 02:29:26 INFO - ##### Running populate-webroot step. 02:29:26 INFO - ##### 02:29:26 INFO - Running pre-action listener: _resource_record_pre_action 02:29:26 INFO - Running main action method: populate_webroot 02:29:26 INFO - Guessing talos json url... 02:29: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')]} 02:29:26 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 02:29:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 02:29:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 02:29:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 02:29:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 02:29:27 INFO - Downloaded 103 bytes. 02:29:27 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 02:29:27 INFO - Contents: 02:29:27 INFO - 20151105005737 02:29:27 INFO - https://hg.mozilla.org/integration/fx-team/rev/c951580b6f9b81f7dcab62b40d03ad96d666e1ca 02:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:27 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/c951580b6f/testing/talos/talos.json 02:29:27 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/c951580b6f/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/c951580b6f/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:29:27 INFO - Downloaded 4264 bytes. 02:29:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:29:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:29:27 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:29:27 INFO - '../fennec_ids.txt'], 02:29:27 INFO - 'tests': ['tcheck2']}, 02:29:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:29:27 INFO - '--tppagecycles', 02:29:27 INFO - '7'], 02:29:27 INFO - 'tests': ['tsvgm']}}, 02:29:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:29:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:29:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:29:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:29:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:27 INFO - 'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:27 INFO - 'tests': ['damp', 'tps']}, 02:29:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:27 INFO - 'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['damp', 'tps']}, 02:29:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:29:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:29:27 INFO - 'other': {'tests': ['a11yr', 02:29:27 INFO - 'ts_paint', 02:29:27 INFO - 'tpaint', 02:29:27 INFO - 'sessionrestore', 02:29:27 INFO - 'sessionrestore_no_auto_restore']}, 02:29:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['a11yr', 02:29:27 INFO - 'ts_paint', 02:29:27 INFO - 'tpaint', 02:29:27 INFO - 'sessionrestore', 02:29:27 INFO - 'sessionrestore_no_auto_restore']}, 02:29:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['a11yr', 02:29:27 INFO - 'ts_paint', 02:29:27 INFO - 'tpaint', 02:29:27 INFO - 'sessionrestore', 02:29:27 INFO - 'sessionrestore_no_auto_restore']}, 02:29:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['a11yr', 02:29:27 INFO - 'ts_paint', 02:29:27 INFO - 'tpaint', 02:29:27 INFO - 'sessionrestore', 02:29:27 INFO - 'sessionrestore_no_auto_restore']}, 02:29:27 INFO - 'other_l64': {'tests': ['a11yr', 02:29:27 INFO - 'ts_paint', 02:29:27 INFO - 'tpaint', 02:29:27 INFO - 'sessionrestore', 02:29:27 INFO - 'sessionrestore_no_auto_restore']}, 02:29:27 INFO - 'other_nol64': {'tests': ['a11yr', 02:29:27 INFO - 'ts_paint', 02:29:27 INFO - 'tpaint', 02:29:27 INFO - 'sessionrestore', 02:29:27 INFO - 'sessionrestore_no_auto_restore']}, 02:29:27 INFO - 'svgr': {'tests': ['tsvgx', 02:29:27 INFO - 'tsvgr_opacity', 02:29:27 INFO - 'tart', 02:29:27 INFO - 'tscrollx', 02:29:27 INFO - 'cart']}, 02:29:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['tsvgx', 02:29:27 INFO - 'tsvgr_opacity', 02:29:27 INFO - 'tart', 02:29:27 INFO - 'tscrollx', 02:29:27 INFO - 'cart']}, 02:29:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:27 INFO - 'tests': ['tp5o']}, 02:29:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:27 INFO - 'talos_options': ['--e10s'], 02:29:27 INFO - 'tests': ['tp5o']}, 02:29:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:27 INFO - 'talos_options': ['--xperf_path', 02:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:27 INFO - 'tests': ['tp5n']}, 02:29:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:27 INFO - 'talos_options': ['--e10s', 02:29:27 INFO - '--xperf_path', 02:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:29:27 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:29:27 INFO - 'tests': ['tp5n']}}, 02:29:27 INFO - 'talos.zip': {'path': '', 02:29:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:29:27 INFO - Running post-action listener: _resource_record_post_action 02:29:27 INFO - ##### 02:29:27 INFO - ##### Running create-virtualenv step. 02:29:27 INFO - ##### 02:29:27 INFO - Running pre-action listener: _resource_record_pre_action 02:29:27 INFO - Running main action method: create_virtualenv 02:29:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:29:27 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 02:29:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:29:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:29:27 INFO - Using real prefix '/tools/python27' 02:29:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:29:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:29:32 INFO - Installing pip.................done. 02:29:32 INFO - Return code: 0 02:29:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d32a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb9a64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2729f0>, '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 0x10cfd1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23c990>, '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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:29:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eHvsjjl4jI/Render', 02:29:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:32 INFO - 'HOME': '/Users/cltbld', 02:29:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:32 INFO - 'LOGNAME': 'cltbld', 02:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:32 INFO - 'MOZ_NO_REMOTE': '1', 02:29:32 INFO - 'NO_EM_RESTART': '1', 02:29:32 INFO - 'PAGER': '/bin/cat', 02:29:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:32 INFO - 'PWD': '/builds/slave/test', 02:29:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:32 INFO - 'SHELL': '/bin/bash', 02:29:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XXzPqAEfxg/Listeners', 02:29:32 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:29:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:32 INFO - 'USER': 'cltbld', 02:29:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:32 INFO - 'XPC_FLAGS': '0x0', 02:29:32 INFO - 'XPC_SERVICE_NAME': '0', 02:29:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:32 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 02:29:32 INFO - Cleaning up... 02:29:32 INFO - Return code: 0 02:29:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d32a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb9a64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2729f0>, '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 0x10cfd1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23c990>, '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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:29:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eHvsjjl4jI/Render', 02:29:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:32 INFO - 'HOME': '/Users/cltbld', 02:29:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:32 INFO - 'LOGNAME': 'cltbld', 02:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:32 INFO - 'MOZ_NO_REMOTE': '1', 02:29:32 INFO - 'NO_EM_RESTART': '1', 02:29:32 INFO - 'PAGER': '/bin/cat', 02:29:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:32 INFO - 'PWD': '/builds/slave/test', 02:29:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:32 INFO - 'SHELL': '/bin/bash', 02:29:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XXzPqAEfxg/Listeners', 02:29:32 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:29:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:32 INFO - 'USER': 'cltbld', 02:29:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:32 INFO - 'XPC_FLAGS': '0x0', 02:29:32 INFO - 'XPC_SERVICE_NAME': '0', 02:29:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:33 INFO - Downloading/unpacking psutil>=0.7.1 02:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:29:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:36 INFO - Installing collected packages: psutil 02:29:36 INFO - Running setup.py install for psutil 02:29:36 INFO - building 'psutil._psutil_osx' extension 02:29:36 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 02:29:36 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 02:29:36 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 02:29:36 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 02:29:36 INFO - building 'psutil._psutil_posix' extension 02:29:36 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 02:29:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:29:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:29:36 INFO - ^ 02:29:37 INFO - 1 warning generated. 02:29:37 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 02:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:37 INFO - Successfully installed psutil 02:29:37 INFO - Cleaning up... 02:29:37 INFO - Return code: 0 02:29:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:29:37 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')]} 02:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:37 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')]} 02:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:37 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 0x10d2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d32a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb9a64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2729f0>, '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 0x10cfd1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23c990>, '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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:29:37 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 02:29:37 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 02:29:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eHvsjjl4jI/Render', 02:29:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:37 INFO - 'HOME': '/Users/cltbld', 02:29:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:37 INFO - 'LOGNAME': 'cltbld', 02:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:37 INFO - 'MOZ_NO_REMOTE': '1', 02:29:37 INFO - 'NO_EM_RESTART': '1', 02:29:37 INFO - 'PAGER': '/bin/cat', 02:29:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:37 INFO - 'PWD': '/builds/slave/test', 02:29:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:37 INFO - 'SHELL': '/bin/bash', 02:29:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XXzPqAEfxg/Listeners', 02:29:37 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:29:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:37 INFO - 'USER': 'cltbld', 02:29:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:37 INFO - 'XPC_FLAGS': '0x0', 02:29:37 INFO - 'XPC_SERVICE_NAME': '0', 02:29:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:29:37 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 02:29:37 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 02:29:37 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 02:29:37 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 02:29:37 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 02:29:37 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 02:29:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:29:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:29:40 INFO - Installing collected packages: mozsystemmonitor 02:29:40 INFO - Running setup.py install for mozsystemmonitor 02:29:40 INFO - Successfully installed mozsystemmonitor 02:29:40 INFO - Cleaning up... 02:29:40 INFO - Return code: 0 02:29:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:40 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 0x10d2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d32a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb9a64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2729f0>, '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 0x10cfd1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23c990>, '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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:29:40 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 02:29:40 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 02:29:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eHvsjjl4jI/Render', 02:29:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:40 INFO - 'HOME': '/Users/cltbld', 02:29:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:40 INFO - 'LOGNAME': 'cltbld', 02:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:40 INFO - 'MOZ_NO_REMOTE': '1', 02:29:40 INFO - 'NO_EM_RESTART': '1', 02:29:40 INFO - 'PAGER': '/bin/cat', 02:29:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:40 INFO - 'PWD': '/builds/slave/test', 02:29:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:40 INFO - 'SHELL': '/bin/bash', 02:29:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XXzPqAEfxg/Listeners', 02:29:40 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:29:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:40 INFO - 'USER': 'cltbld', 02:29:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:40 INFO - 'XPC_FLAGS': '0x0', 02:29:40 INFO - 'XPC_SERVICE_NAME': '0', 02:29:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:41 INFO - Downloading/unpacking blobuploader==1.2.4 02:29:41 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 02:29:41 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 02:29:41 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 02:29:41 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 02:29:41 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 02:29:41 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 02:29:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:29:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:29:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:29:43 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 02:29:43 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 02:29:43 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 02:29:43 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 02:29:43 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 02:29:43 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 02:29:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:29:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:29:44 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 02:29:44 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 02:29:44 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 02:29:44 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 02:29:44 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 02:29:44 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 02:29:45 INFO - Downloading docopt-0.6.1.tar.gz 02:29:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:29:45 INFO - Installing collected packages: blobuploader, requests, docopt 02:29:45 INFO - Running setup.py install for blobuploader 02:29:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:29:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:29:45 INFO - Running setup.py install for requests 02:29:46 INFO - Running setup.py install for docopt 02:29:46 INFO - Successfully installed blobuploader requests docopt 02:29:46 INFO - Cleaning up... 02:29:46 INFO - Return code: 0 02:29:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29: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')]} 02:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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')]} 02:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:46 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 0x10d2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d32a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb9a64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2729f0>, '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 0x10cfd1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23c990>, '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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:29:46 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 02:29:46 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 02:29:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eHvsjjl4jI/Render', 02:29:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:46 INFO - 'HOME': '/Users/cltbld', 02:29:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:46 INFO - 'LOGNAME': 'cltbld', 02:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:46 INFO - 'MOZ_NO_REMOTE': '1', 02:29:46 INFO - 'NO_EM_RESTART': '1', 02:29:46 INFO - 'PAGER': '/bin/cat', 02:29:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:46 INFO - 'PWD': '/builds/slave/test', 02:29:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:46 INFO - 'SHELL': '/bin/bash', 02:29:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XXzPqAEfxg/Listeners', 02:29:46 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:29:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:46 INFO - 'USER': 'cltbld', 02:29:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:46 INFO - 'XPC_FLAGS': '0x0', 02:29:46 INFO - 'XPC_SERVICE_NAME': '0', 02:29:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:46 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-edJ0d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:46 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-9lRFA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:47 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-hH59jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:47 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-EwbGXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:47 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-ZP3ZqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:47 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-oaYGzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:47 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-YWbvSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:47 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-uca3YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:47 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-H4i4QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:48 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-H95JvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:48 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-Ck0WDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:48 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-Qv0eqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:48 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-dt3Mx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:48 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-_pol88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:48 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-NpFiKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:48 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-49SYK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:49 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-5NQpGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:29:49 INFO - Running setup.py install for manifestparser 02:29:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:29:49 INFO - Running setup.py install for mozcrash 02:29:49 INFO - Running setup.py install for mozdebug 02:29:49 INFO - Running setup.py install for mozdevice 02:29:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:29:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Running setup.py install for mozfile 02:29:50 INFO - Running setup.py install for mozhttpd 02:29:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Running setup.py install for mozinfo 02:29:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Running setup.py install for mozInstall 02:29:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Running setup.py install for mozleak 02:29:50 INFO - Running setup.py install for mozlog 02:29:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for moznetwork 02:29:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for mozprocess 02:29:51 INFO - Running setup.py install for mozprofile 02:29:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for mozrunner 02:29:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:29:52 INFO - Running setup.py install for mozscreenshot 02:29:52 INFO - Running setup.py install for moztest 02:29:52 INFO - Running setup.py install for mozversion 02:29:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:29:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:29:52 INFO - Cleaning up... 02:29:52 INFO - Return code: 0 02:29:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29: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')]} 02:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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')]} 02:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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', '-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 0x10d2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d32a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb9a64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2729f0>, '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 0x10cfd1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23c990>, '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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:29:52 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 02:29:52 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 02:29:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eHvsjjl4jI/Render', 02:29:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:52 INFO - 'HOME': '/Users/cltbld', 02:29:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:52 INFO - 'LOGNAME': 'cltbld', 02:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:52 INFO - 'MOZ_NO_REMOTE': '1', 02:29:52 INFO - 'NO_EM_RESTART': '1', 02:29:52 INFO - 'PAGER': '/bin/cat', 02:29:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:52 INFO - 'PWD': '/builds/slave/test', 02:29:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:52 INFO - 'SHELL': '/bin/bash', 02:29:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XXzPqAEfxg/Listeners', 02:29:52 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:29:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:52 INFO - 'USER': 'cltbld', 02:29:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:52 INFO - 'XPC_FLAGS': '0x0', 02:29:52 INFO - 'XPC_SERVICE_NAME': '0', 02:29:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:52 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-s2BuXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:53 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-wwzidw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:53 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-nZ_vxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:53 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-TT7BsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:53 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-dSPtvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:53 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-ihca2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:53 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-BQj60Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:53 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-d4hQLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:54 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-kBJVoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:54 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-jceJm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:54 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-pWMk2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:54 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-RdRX0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:54 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-1kH8l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:54 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-CTZ11P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:54 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-vJOrLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-yFBqdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:55 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-YSKx1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:55 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)) 02:29:55 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)) 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:55 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)) 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:55 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 02:29:55 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 02:29:55 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 02:29:55 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 02:29:55 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 02:29:55 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 02:29:58 INFO - Downloading blessings-1.5.1.tar.gz 02:29:58 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 02:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:29:58 INFO - Installing collected packages: blessings 02:29:58 INFO - Running setup.py install for blessings 02:29:58 INFO - Successfully installed blessings 02:29:58 INFO - Cleaning up... 02:29:58 INFO - Return code: 0 02:29:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:58 INFO - Reading from file tmpfile_stdout 02:29:58 INFO - Current package versions: 02:29:58 INFO - blessings == 1.5.1 02:29:58 INFO - blobuploader == 1.2.4 02:29:58 INFO - docopt == 0.6.1 02:29:58 INFO - manifestparser == 1.1 02:29:58 INFO - mozInstall == 1.12 02:29:58 INFO - mozcrash == 0.16 02:29:58 INFO - mozdebug == 0.1 02:29:58 INFO - mozdevice == 0.47 02:29:58 INFO - mozfile == 1.2 02:29:58 INFO - mozhttpd == 0.7 02:29:58 INFO - mozinfo == 0.9 02:29:58 INFO - mozleak == 0.1 02:29:58 INFO - mozlog == 3.0 02:29:58 INFO - moznetwork == 0.27 02:29:58 INFO - mozprocess == 0.22 02:29:58 INFO - mozprofile == 0.27 02:29:58 INFO - mozrunner == 6.11 02:29:58 INFO - mozscreenshot == 0.1 02:29:58 INFO - mozsystemmonitor == 0.0 02:29:58 INFO - moztest == 0.7 02:29:58 INFO - mozversion == 1.4 02:29:58 INFO - psutil == 3.1.1 02:29:58 INFO - requests == 1.2.3 02:29:58 INFO - wsgiref == 0.1.2 02:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29: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')]} 02:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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')]} 02:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:58 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 0x10d2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d32a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb9a64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2729f0>, '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 0x10cfd1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23c990>, '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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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 02:29:58 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 02:29:58 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 02:29:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eHvsjjl4jI/Render', 02:29:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:58 INFO - 'HOME': '/Users/cltbld', 02:29:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:58 INFO - 'LOGNAME': 'cltbld', 02:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:58 INFO - 'MOZ_NO_REMOTE': '1', 02:29:58 INFO - 'NO_EM_RESTART': '1', 02:29:58 INFO - 'PAGER': '/bin/cat', 02:29:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:58 INFO - 'PWD': '/builds/slave/test', 02:29:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:58 INFO - 'SHELL': '/bin/bash', 02:29:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XXzPqAEfxg/Listeners', 02:29:58 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:29:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:58 INFO - 'USER': 'cltbld', 02:29:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:58 INFO - 'XPC_FLAGS': '0x0', 02:29:58 INFO - 'XPC_SERVICE_NAME': '0', 02:29:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 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)) 02:29:59 INFO - Cleaning up... 02:29:59 INFO - Return code: 0 02:29:59 INFO - Running post-action listener: _resource_record_post_action 02:29:59 INFO - Running post-action listener: _start_resource_monitoring 02:29:59 INFO - Starting resource monitoring. 02:29:59 INFO - ##### 02:29:59 INFO - ##### Running install step. 02:29:59 INFO - ##### 02:29:59 INFO - Running pre-action listener: _resource_record_pre_action 02:29:59 INFO - Running main action method: install 02:29:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:59 INFO - Reading from file tmpfile_stdout 02:29:59 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:59 INFO - Reading from file tmpfile_stdout 02:29:59 INFO - Output received: 02:29:59 INFO - Usage: mozinstall [options] installer 02:29:59 INFO - Options: 02:29:59 INFO - -h, --help show this help message and exit 02:29:59 INFO - -d DEST, --destination=DEST 02:29:59 INFO - Directory to install application into. [default: 02:29:59 INFO - "/builds/slave/test"] 02:29:59 INFO - --app=APP Application being installed. [default: firefox] 02:29:59 INFO - mkdir: /builds/slave/test/build/application 02:29:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:30:42 INFO - Reading from file tmpfile_stdout 02:30:42 INFO - Output received: 02:30:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:30:42 INFO - Running post-action listener: _resource_record_post_action 02:30:42 INFO - ##### 02:30:42 INFO - ##### Running run-tests step. 02:30:42 INFO - ##### 02:30:42 INFO - Running pre-action listener: _resource_record_pre_action 02:30:42 INFO - Running main action method: run_tests 02:30:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:30:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:30:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:30:42 INFO - 2015-11-05 02:30:42.673 screenresolution[2918:34872] starting screenresolution argv=screenresolution get 02:30:42 INFO - 2015-11-05 02:30:42.677 screenresolution[2918:34872] Display 0: 1600x1200x32@60 02:30:42 INFO - 2015-11-05 02:30:42.684 screenresolution[2919:34874] starting screenresolution argv=screenresolution list 02:30:42 INFO - Available Modes on Display 0 02:30:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:30:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:30:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:30:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:30:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:30:42 INFO - Intel HD Graphics 3000: 02:30:42 INFO - Chipset Model: Intel HD Graphics 3000 02:30:42 INFO - Type: GPU 02:30:42 INFO - Bus: Built-In 02:30:42 INFO - VRAM (Total): 512 MB 02:30:42 INFO - VRAM (Dynamic, Max): 10 02:30:42 INFO - Vendor: Intel (0x8086) 02:30:42 INFO - Device ID: 0x0116 02:30:42 INFO - Revision ID: 0x0009 02:30:42 INFO - Displays: 02:30:42 INFO - Display: 02:30:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:30:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:30:42 INFO - Display Serial Number: 1600x1200 60 02:30:42 INFO - Main Display: Yes 02:30:42 INFO - Mirror: Off 02:30:42 INFO - Online: Yes 02:30:42 INFO - Rotation: Supported 02:30:42 INFO - Return code: 0 02:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:30:42 INFO - Python 2.7.3 02:30:42 INFO - Return code: 0 02:30:42 INFO - grabbing minidump binary from tooltool 02:30: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')]} 02:30:42 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 0x10d2729f0>, '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 0x10cfd1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23c990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:30:42 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 02:30:42 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 02:30:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:43 INFO - Return code: 0 02:30:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:30:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:30:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:30:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:30:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0095', '--webServer', 'localhost'] in /builds/slave/test/build 02:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0095 --webServer localhost 02:30:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eHvsjjl4jI/Render', 02:30:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:43 INFO - 'HOME': '/Users/cltbld', 02:30:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:43 INFO - 'LOGNAME': 'cltbld', 02:30:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:30:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:43 INFO - 'MOZ_NO_REMOTE': '1', 02:30:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:30:43 INFO - 'NO_EM_RESTART': '1', 02:30:43 INFO - 'PAGER': '/bin/cat', 02:30:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:43 INFO - 'PWD': '/builds/slave/test', 02:30:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:30:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:43 INFO - 'SHELL': '/bin/bash', 02:30:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XXzPqAEfxg/Listeners', 02:30:43 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 02:30:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:43 INFO - 'USER': 'cltbld', 02:30:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:43 INFO - 'XPC_FLAGS': '0x0', 02:30:43 INFO - 'XPC_SERVICE_NAME': '0', 02:30:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:30:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0095', '--webServer', 'localhost'] with output_timeout 3600 02:30:43 INFO - mozversion INFO | application_buildid: 20151105005737 02:30:43 INFO - mozversion INFO | application_changeset: c951580b6f9b81f7dcab62b40d03ad96d666e1ca 02:30:43 INFO - mozversion INFO | application_display_name: Nightly 02:30:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:30:43 INFO - mozversion INFO | application_name: Firefox 02:30:43 INFO - mozversion INFO | application_remotingname: firefox 02:30:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:30:43 INFO - mozversion INFO | application_vendor: Mozilla 02:30:43 INFO - mozversion INFO | application_version: 45.0a1 02:30:43 INFO - mozversion INFO | platform_buildid: 20151105005737 02:30:43 INFO - mozversion INFO | platform_changeset: c951580b6f9b81f7dcab62b40d03ad96d666e1ca 02:30:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:30:43 INFO - mozversion INFO | platform_version: 45.0a1 02:30:43 INFO - 2015-11-05 02:30:43,367 DEBUG : using testdate: 1446719443 02:30:43 INFO - 2015-11-05 02:30:43,367 DEBUG : actual date: 1446719443 02:30:43 INFO - 2015-11-05 02:30:43,377 INFO : starting webserver on 'localhost:53677' 02:30:43 INFO - 2015-11-05 02:30:43,378 INFO : Starting test suite t-yosemite-r5-0095 02:30:43 INFO - 2015-11-05 02:30:43,378 INFO : Starting test dromaeo_css 02:30:43 INFO - 2015-11-05 02:30:43,378 DEBUG : operating with platform_type : mac_ 02:30:43 INFO - 2015-11-05 02:30:43,379 INFO : Initialising browser for dromaeo_css test... 02:30:43 INFO - 2015-11-05 02:30:43,394 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpVxsQ3p/profile http://localhost:53677/getInfo.html 02:30:45 INFO - 2015-11-05 02:30:45,936 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:30:45 INFO - 2015-11-05 02:30:45,936 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:30:45 INFO - 2015-11-05 02:30:45,936 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:30:45 INFO - 2015-11-05 02:30:45,936 DEBUG : BROWSER_OUTPUT: __metrics 02:30:45 INFO - 2015-11-05 02:30:45,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] 02:30:46 INFO - 2015-11-05 02:30:46,747 INFO : Browser initialized. 02:30:46 INFO - 2015-11-05 02:30:46,748 INFO : Running cycle 1/1 for dromaeo_css test... 02:30:46 INFO - 2015-11-05 02:30:46,748 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpVxsQ3p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:30:58 INFO - 2015-11-05 02:30:58,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 222892032 02:30:58 INFO - 2015-11-05 02:30:58,836 DEBUG : BROWSER_OUTPUT: 02:31:50 INFO - 2015-11-05 02:31:50,699 DEBUG : BROWSER_OUTPUT: 1446719510698 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] 02:34:00 INFO - 2015-11-05 02:34:00,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53677/tests/dromaeo/cssquery-ext.html) 02:34:01 INFO - 2015-11-05 02:34:01,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 315604992 02:34:01 INFO - 2015-11-05 02:34:01,834 DEBUG : BROWSER_OUTPUT: 02:37:04 INFO - 2015-11-05 02:37:04,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/dromaeo/cssquery-ext.html (next: http://localhost:53677/tests/dromaeo/cssquery-jquery.html) 02:37:05 INFO - 2015-11-05 02:37:05,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 351334400 02:37:05 INFO - 2015-11-05 02:37:05,298 DEBUG : BROWSER_OUTPUT: 02:40:07 INFO - 2015-11-05 02:40:07,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53677/tests/dromaeo/cssquery-mootools.html) 02:40:08 INFO - 2015-11-05 02:40:08,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 327553024 02:40:08 INFO - 2015-11-05 02:40:08,233 DEBUG : BROWSER_OUTPUT: 02:43:10 INFO - 2015-11-05 02:43:10,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53677/tests/dromaeo/cssquery-prototype.html) 02:43:10 INFO - 2015-11-05 02:43:10,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 310714368 02:43:10 INFO - 2015-11-05 02:43:10,943 DEBUG : BROWSER_OUTPUT: 02:46:14 INFO - 2015-11-05 02:46:14,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53677/tests/dromaeo/cssquery-yui.html) 02:46:14 INFO - 2015-11-05 02:46:14,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 310079488 02:46:14 INFO - 2015-11-05 02:46:14,754 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/dromaeo/cssquery-yui.html (next: http://localhost:53677/tests/dromaeo/cssquery-dojo.html) 02:49:17 INFO - 2015-11-05 02:49:17,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 360935424 02:49:17 INFO - 2015-11-05 02:49:17,792 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,792 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:49:17 INFO - 2015-11-05 02:49:17,792 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:49:17 INFO - 2015-11-05 02:49:17,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:49:17 INFO - 2015-11-05 02:49:17,793 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:49:17 INFO - 2015-11-05 02:49:17,793 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2586.224132760172;2659.800514961378;2672.4521473098007;2672.8529930853797;2679.807485668878;4295.248331541983;4366.6506679465565;4381.518033016369;4453.755043472612;4468.8659340219765;4339.804708788112;4380.32105023721;4395.516493185755;4511.368408422815;4513;4013.2776100301935;4019.1760689058674;4038.7374820636564;4084.1831633673237;4122.2786012447705;4060.8781736547803;4119.505659320886;4194.140201258735;4195.538490766014;4297.484301883778;3938.4289278054807;4023.0948036691802;4071.653909417703;4117.8970525736795;4158.2515147273325;4026.1142548639255;4032.8185231664647;4043.0903046814233;4079.2657321682086;4080.0207950091763;4077.531083925357;4123.731957422758;4129.112240868198;4147.025449019478;4159.812808423628;4239.47006624172;4402.141582391435;4410.272305069691;4469.374287599739;4480.171168333836;4520.570545798144;4603.746793926332;4628.791704373278;4660.254359302496;4664.5335466453425;4786.21027530457;4786.7845946932475;4836.51634836517;4852.344933434012;4857.514248575149;4281.892952676208;4541.72749635023;4562.771861406916;4599.563041511051;4619.0530941156985;4678.578927896438;4826.276058591239;4829.251466022772;4891.413030436371;4957.256411538298;4674.462436819741;4696.248600224016;4737.336772851803;4745.264484004984;4781.187198176319;4582.702124361906;4794.4486384065585;4824.421069471686;4825.662203645781;4847.2729090636685;4597.057603191338;4610.10103029906;4626.37543931565;4712.9057418851435;4778.784954677048;4726.669133160645;4769.475357710649;4778.331033655291;4811.374521312207;4841.9031619367415;3611.8916432507067;3761.755485893408;3819.2743378757946;3821.2548553032448;3827.158025234444;3331.950020749691;3380.2056516718553;3398.6601339865815;3425.9143521412166;3454.2573346730574;4504.2793153096;4527.977360113178;4538.591526762607;4584.770761461914;4607.493175750665;4541.205289074399;4867.488913664085;4868.294097355934;4881.487443818419;4890.437599676012;4292.12011537634;4400.141972315368;4411.933820992687;4437.245668236407;4454.354118652777;4225.68307376948;4282;4289.013526888771;4306.181825453154;4318.805653745589;4518.231900576976;4678.742669153161;4831.516848315211;4853.684510506806;4857.1742803724155;4673.976630116827;4688.976555117202;4729.17239483096;4755;4798.928016079832;4723.197056500335;4758.643101767312;4804.495527969652;4834.1298566257;4853.805847766191;4499.235130027838;4682.812687492462;4690.460597031385;4705.64707646921;4741.50214227515;4600.447946246338;4668.953310466852;4701.153792317279;4709.835155769531;4780.617550596014;4614.1694494991225;4657.324687920301;4684.789184486638;4684.859454216379;4705.623550116051;4594.264917613166;4597.287420449836;4634.513376095461;4637.976810116063;4694.882627934329;4398.428204333416;4403.669724770719;4504.256797628354;4513.909721805479;4517.638588912945;4600.4479462464715;4627.213373726408;4665.160271151225;4676.088162808356;4711.458182309078;4561.703489273186;4575.9771201143785;4581.725096494221;4586.701864378805;4589.357489951342 02:49:17 INFO - 2015-11-05 02:49:17,795 DEBUG : BROWSER_OUTPUT: |1;ext.html;459.1689042832473;462.5952291744723;462.90279041401305;464.91166678331115;486.3215813939557;25744;25905.740942590593;26039;26066.609000865003;31746.84126579364;34475.138121546974;34862.65137348626;35049.29901401971;35149;35299.82350088252;7555.244475552442;7647.120581133157;7647.158812530617;7648.847023059536;7662.11885633151;6860.245373008965;6997.685104170325;7345.669444874993;7465.589392583406;8685.609147588342;8690.782730431727;8810.603522841488;8811.515366654832;8816.250618697419;8819.647214111428;8708.21626053655;8738.388312818106;8774.429662071945;8836.337274704358;8844;6772.525923185379;6800.659967001679;6906.792796216121;6937.583744975318;6988.231294557595;32210.355792884246;32682.673173268202;32733.6726632733;32809.40668306439;32823.343533129206;2319.420144963759;2642.577187649986;2679.7588217060556;2730.8361498310164;2890.7398334150025;22789.31632051041;22837.20069797566;23763.16828910997;23896.522069558687;24052.518949621084;2008.3573256557906;2028.0873606876817;2028.9492762680904;2045.9795402046086;2051.98974005129;227776;230323.8483807587;231334;233391;235267;50997.7450112747;51004;51108.23337649938;51385.229221561705;51566.226506602434;49767;51077.23384149241;51121;55983.44016559864;56440;13648.317584120754;13709.108907920952;13732.588022359345;13825.585232443043;13952.302384880715;10412.791744165073;10505;10625.096866766411;10625.946870265754;10632.840507392395;16137.919310403373;16680.49958501247;16824.242909069122;16873.07198104116;16892.15539223034;7201.819954501179;7501.137369202503;7533.02445534011;7552.093748750185;7625.084989801259;757.5189754505928;819.1030821250721;872.2498651159997;877.6002276369181;902.6840605788053;23175.652365214537;23257.18599848997;23342.416439589146;23371.649425258634;23510.64734028991;887.3433659092225;901.9052999434965;919.558611866308;975.4683697384942;1032.1742605915238;12007.819882701766;12015.219010764273;12057.975072118792;12059.21615095016;12067.456964436622;245669;249863;251425;253388;255561;44094.559054409685;44674.77662611666;44713.55286447159;44776;44884.77557612191;1142.9142814288796;1147.0880649883363;1166.702490864824;1166.8133098704166;1171.912106592026;20840.895795520926;23145.18991835278;23303.300900972998;23325.300240992798;23394.415139621644;36142.4578631326;36716.26567468689;36753.486976952605;36992.445113322785;37225.627743722216;171372;171930;172051;173263;173280;22857.42856428536;23079;25609.359766006;26180.345491362867;26822.865885670446;30813.38373232478;31672.366552668358;31693.524597131523;32114.518282226254;32396;30339;32523.349533008735;33140.337193256484;33164.33671326608;33204.66795332016;25869.741302587485;28511.857440712665;29591.704082958895;30575;33154.834225828716;30056;32312.19219519437;33286.33427331488;33302.16744581308;33502;24563.263102106965;26450.603240951787;26710.59934101029;27189.72810271872;28670.42659146847;19912.60174796525;20088.19647214095;20158.193672252946;20235.79764202398;20254.08856601427 02:49:17 INFO - 2015-11-05 02:49:17,796 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277.04971946224447;279.3769893138303;280.5763297420894;283.440205593952;284.0951569251933;14271.286435678227;14355.282235888217;14750.926245368772;14778.408863645454;14829.77755333671;13962.301884905739;14267.143971361726;14652;15125.394984200619;15214.467493637725;4331.155424692194;4359.825606975717;4375.278079116942;4406.97796511017;4462.620677242438;4323.805428755713;4381.627561657263;4390.648748100144;4425.159219748238;4433.290673492242;3185.3629274145146;3305.2397948471867;3309.271960168771;4326.632236259906;4347.500037495681;4707.976460117695;4798.136335459616;4819.903601927959;4838.903221935541;4842.370491836074;3229.612446506411;4176.979115104405;4178.7283826551175;4205.810738516774;4218.7468751874985;9353.158215760546;9545.379550329206;9719.514024298756;10608.946955265252;10628.521716522775;1209.8064309710492;1421.182819878574;1503.6992601479749;1563.7576175692786;1595.7606359046235;7827.373810095179;7831.099423566249;7840.49036812611;7874.645640946172;7922.881156782653;1222.3460448660014;1241.6399244219165;1278.8017857232144;1296.0992110483219;1297.2929753284482;48224.27663585049;48539;49411.50588494105;58807;62562.68718656423;13764.31178441074;14777.778333325008;14832.406703731946;14867.256637168099;14875.404983800527;20706.17175313001;20895;20948.790512094685;20999.895000525205;21002;8588.699395521127;8609.741707748777;8636.265917397091;8649.870251946226;8751.768299083693;7417.554946703107;7421.8144546386775;7465.888011679829;7488.176300606929;7512.812179695551;6759.493038022069;6871.725130994804;6879;6896.310368963063;6939.167299924042;2699.9730002700117;2728.495228382716;2743.931401714973;2752.573351130578;2756.9172924812287;333.12388418459295;340.5402706346413;359.20973857513576;371.52444870565716;376.2775471095503;9087.468000119501;9660.420374777535;9883.654072107585;9984.101430871257;10023.599056037823;380.6973456102405;386.133131120636;389.92575454622335;390.4650628638783;390.6679322575788;4750.501197374295;4828.275758636162;5283.867903302371;5464.672119672832;5485.61600687956;474997;482557;493754;499274;499450;58729.70635146797;61238.69380653068;61709;62596;62793.37206627967;404.65604236398826;406.21194881928966;412.08517092055587;412.66780241904956;420.88425682937435;9146.908530914605;9191;9248.352615316864;9358.766030849283;9449.574769135268;29594;29726.25684357908;29731;29734.851325744097;30593.388132236785;40412.59587404088;40703.79648101741;40995;41530;41773.58226417697;11902.166848320534;12173.45219465144;12183.695407614881;12517.874821252035;12564;15221.695566088838;15371.692566148839;16266.755998660266;16289.67420651604;16297.837021629632;9693.9030609693;11478.311301321948;12659.430325635185;12748.816823840616;12810.679733006376;10944.507497162487;11176.944115279372;12260.75478490443;12562.371881406076;12919.418626162033;12726.17279876805;12957.676058098246;13394;13528.188308701509;13537.458501659823;12485.250884946932;12548.749025019632;12627;12641.178323408949;12971.09202355826;12465.1274410794;12631.93684031574;12728.854403103765;13033.869661303645;13081.934590326988 02:49:17 INFO - 2015-11-05 02:49:17,800 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1080.9891901080987;1422.3883729996103;1453.4694836384722;1484.7772834074888;1500.2573726005626;5553.416891226424;5749.885002299951;5802.796902108433;5858.326292476367;5869.559783016281;5819.359870414251;5931.288245410546;5959.374265702104;5997.820065398034;6000;1769.867259955502;1798.9640207195848;1806.3948577226645;1806.8735188536807;1807.8553715702712;1763.2506184871443;1770.7786526684165;1793.0944872839198;1798.7571677823523;1830.3685228596114;1766.991165044173;1783.4382169616529;1792.524980880068;1792.5966657502088;1799.406195955338;1709.3504468302028;1714.8456638902496;1751.938682146125;1759.961622642647;1770.97343539847;1758.0506526475688;1787.892726436418;1789.3647755047032;1792.0681245752266;1803.7114061750058;5380.946190538084;5930.822075337746;5935.10973353996;5947;5966.343702192756;3310.5034244863223;3408.8466019028956;3582.3193593217206;3691.335559599271;3702.1855191858017;2301.8503797253293;2350.13045173287;2377.322463098026;2377.500724847784;2397.6163813789885;785.9764207073797;802.9237222463856;805.6656487557657;819.2176471469733;819.3568049081503;7763.8447231055625;7804.88292675616;7809.219078092202;7836.529808211526;7907.683692652287;3343.732501399882;3352.9329413412083;3358.8320583970703;3411.368896754059;3412.84642191102;6984.930150698529;6994.860102797916;7011.29887011305;7033.964830175816;7071;3641.652588542256;3710.3135919854913;3712.832922518493;3718.3121122592406;3759.8496060157286;3381.898543043713;3382.4249877520388;3390.6100798408497;3400.863965441404;3410.7612467127065;2786.317352248712;2822.111035023961;2839.417919326533;2855.072101566999;2871.25347409675;904.073324842029;906.582971832951;909.1908201700492;910.7677542226689;930.223263574909;889.5329951775241;907.7458311672742;917.5228880981851;920.9723708288763;928.3084102343797;5672.517835983987;5691.117876729114;5714.657120572779;5719.4852463277675;5721.942780572141;369.305705274083;387.1308911493658;391.1102242398566;391.1433959628405;391.213660542312;4528.682992190581;4631.305304204397;4646.674732768742;4656.278276867091;4676.95323046772;6592.274849766522;6723.5293529452465;6815.148106486689;6977.93022069783;7009.158900931819;6844.452443804484;6886.345797149263;6912.239653638096;6929.237783843773;6953.269906659728;5534.146061069507;5536.141898005815;5582.080783841302;5586.106223004381;5654.604177707521;5483.670979741229;5491.368492623399;5502.779888804403;5505.03661859181;5517.917231241454;6142.477889379274;6176.752929882754;6204.007358822567;6246.1255424239735;6251.312355640966;6276.309605943434;6385.521085918482;6390.7763228286785;6397.072424498515;6440.742370305135;5264.815731449381;5327.813526526553;5331.226972088948;5335.33308336458;5343.893122137613;5701.173329867063;5756.827295181151;5759.683217423082;5771.278590176228;5796.565257605781;5304.257403963526;5346.358436987586;5459.863503412287;5460.7542660579575;5492.615516913777;5207.557357624492;5224.947750522446;5322.175062865107;5374.838754837361;5389.003034438641;5323.0684630190335;5361.705106219039;5391.973040134774;5400.918986215289;5423.430539793265;4927.901441971068;4936.531029552187;4957.157283261926;4982.10322142018;4998.075356059141;4933.5066493351815;4946.752662366795;4966.081274964144;4968.22992436173;4994.600431965361 02:49:17 INFO - 2015-11-05 02:49:17,802 DEBUG : BROWSER_OUTPUT: |4;prototype.html;258.98187126901115;264.49745483581205;265.21905405204063;268.14194577352475;272.5693404421015;5023.57299629531;5081.263216833557;5094.770735316911;5123.897522049561;5127.589792816575;4958.35541379621;5036.722980236085;5039.72281524516;5068.189089745632;5079.212722028092;3752.2495500899795;3804.9429258561145;3807.562130355003;3903.7657740535587;3915.2169566086754;3823.1397935464574;3899.473571067912;3931.8230679619487;3932.1152740633415;3936.311145549532;3825.3305671507514;3877.185790983897;3886.2227554489214;3893.007283142809;3901.7854018028997;3837.2325534892993;3855.036240939765;3861.362875125615;3870.148567315186;3933.5279766427925;3282.720968717662;3329.101142691484;3368.326334733063;3381.9323613527836;3402.795832250073;4831.806727730886;4959.603231741452;4970.776315065831;4975.7263350515705;5005.124103281911;4400.7579583122915;4429.645628349756;4432.822687092513;4443.955670417449;4452.732836029849;5091.821786237501;5279.577633789288;5295;5315.707636080014;5323.121684921984;3578.7315951303494;3586.820658967067;3613.2050948791225;3658;3665.9266814663824;5470.64440811346;5509.807156749534;5522.088855338864;5534.833954981357;5547.417521160301;3678.1907980244305;3715.554133503997;3721.683656889141;3726.1802403471193;3730.9067273318383;3743.513343265358;3747.2880152770886;3769.6230376962635;3785.6782173515007;3809.695224382043;4229.365595160751;4404.7357158570585;4418.425604671436;4420.160169567772;4447.866564003085;5318.335208098988;5325.573954083664;5330.866728331823;5361.785528578891;5369.328833895763;1355.2478374502246;1370.0683535195963;1377.1048818268005;1378.476179051974;1391.4086513231837;889.4752096263236;897.52879738138;902.8104098139464;915.5742579700471;915.6749353979375;5119.6160287978555;5156.716380599028;5159.871003224875;5203.323567936144;5205;5555.055640541118;5575.163725441135;5585.497305242548;5609.915851262234;5613.298337707786;5111.131107711698;5148.613853960893;5148.665336753099;5158.716270605078;5201.037808005455;2984.850757462118;3086.4752991991413;3090.675479074665;3106.3476669899574;3106.5340198969884;5571.331440227118;5579.302587176603;5583.4137415571595;5588.524975377139;5653.152027195872;5648.491635752802;5657.12314591239;5702.372738998707;5707.74315155819;5725.570582206351;5576.665400076008;5588.972055139699;5599.804006859659;5614.073677843192;5658.236138121301;5356.57147428197;5500.1749737539685;5591.776328946797;5603.635763675348;5636.126400407943;5265.341832270966;5331.253624492497;5380.381256155592;5431.456854314537;5511.834644960658;5550.222968784293;5555.749991250323;5577.191307260506;5595.384507704231;5629.268195134607;3586.04969683029;3623.6195199504727;3655.1227705351057;3659.3413185625777;3664.450332450047;5376.274202982704;5511.366192887709;5533.391326953952;5557.36090349615;5572.9968605651375;5351.277577526984;5425.457454254543;5455.236266922713;5470.261514695624;5541.030319693957;5394.460553944574;5414.485623865727;5420.972895135499;5429.212764149097;5482.698451585042;5306.97346513265;5311.2829767982375;5317.202419637086;5349.144136938071;5377.381601115765;5298.894022119459;5406.2971813665545;5421.349438067457;5431.185322201702;5479.561635069105;5282.234076059027;5311.442298558596;5336.67979921206;5338.439463856239;5339.973300133474 02:49:17 INFO - 2015-11-05 02:49:17,803 DEBUG : BROWSER_OUTPUT: |5;yui.html;611.1108337369128;626.7743612299574;630.360184412821;637.5505268785506;639.1595052505951;11349.319040857554;11451.427428628576;11452.885471145286;11479;11504.309741415522;11700.707482312946;12002.099842511825;12035.518579256819;12220.38898055098;12254.326012069332;590.2356448399312;597.14011822975;732.1507051819904;753.7211231844225;758.9734359297425;591.7899145803242;739.3973911262304;739.9260073992612;741.5624781378986;743.7396911081132;720.8918662200659;766.2261116272549;769.6421164158666;770.8805135204052;777.3509119884875;600.975960961561;616.2851092732409;766.31797700047;766.643510767493;772.1776308231715;567.7785663591203;569.3537834557766;570.7203470299564;572.2560671127518;576.9509591684712;11302.773944521146;11653.475593598223;11823.94088029563;11852.288862668182;11881.34652594107;9805.509724513817;9820;9835.655752048715;10162.39025658463;10180.490975451197;7625.313721765067;7671.462997590171;7709.38324934004;7952.363810895173;8016.719414820512;2727.8090533662653;2739.205630367191;2745.437185377013;2781.1656503049207;2788.9302767430772;42887.14225715468;43271.35092973608;43568.12863742739;43571.346429803576;43963.78018109953;7811.45319827618;7886.290233878978;7926.920730792734;7980.162082981319;8065;16753;17110.657786844193;17149.228284727218;17150.142492875308;17235.31058757661;5811.4479124483105;5969.850753731104;6150.985087460608;6252.280987686383;6253.249610046823;3199.2481766784786;3245.383377158332;3318.950215746766;3365.730741540671;3373.8819141329936;2398.82008849337;2431.4407686232266;2438.2807071913826;2442.4138206830235;2444.071252923913;356.6487010294857;359.77514053716425;360.51510718084137;361.67991327674673;362.5468164794008;388.33982230208755;453.3720796696599;500.29708259894903;503.65247978894445;538.5987439357704;6148.354422785633;6387.5209359297305;6496.155499784998;6665.066890635315;6728.752161282756;363.68695099169264;376.6365457333686;466.89494863655403;490.1324655359993;518.7354449230919;3028.318628308613;3081.306705991134;3126.796758210709;3147.3075923296838;3150.480170771843;50609.49390506048;50654.49345506571;51063.489365105874;51313.74343128261;51477.48522514727;42522.149557008684;43433;43747.34378984254;43824.342634860506;43839.78080109579;37699.62300376961;37872.43191352077;38607.22785544329;40098.19803603912;40221.1955760889;6309.079571212175;6330.240371155491;6339.492840572835;6505.804825855232;6637.435817955527;28658.85670571634;29523.85238073882;29576.852115739282;29757.25606859759;29837.70162298436;37176.81411593033;37319.813400933905;38762.6123738759;39894;40905.59094409018;6383.840403989938;6482.481401487964;6521.380468855451;6548.279689234276;6598.076269322395;9029.593668284811;9213.723588292361;9258.629654814002;9306.627734890528;9359.532023398666;8779.341549383695;8855.512946787989;8882.511461869659;8885.111488851064;8923.73228803137;8765.07966663491;8790.077041910507;8801;8922.330825188006;8925.910740892768;8424.747257582283;8433.95783021081;8555.016173140168;8586.78533036679;8631.964164300323;7412.6664300107705;7802.609869506616;8020.238077382639;8071.152528984372;8077.474964127313;7413.184549699637;7484.401247900264;7758.4181186410115;7810.867424223342;7976.680932762624 02:49:17 INFO - 2015-11-05 02:49:17,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:49:17 INFO - 2015-11-05 02:49:17,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:49:17 INFO - 2015-11-05 02:49:17,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,942 02:49:17 INFO - 2015-11-05 02:49:17,804 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:49:17 INFO - 2015-11-05 02:49:17,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1446720557788__endTimestamp 02:49:17 INFO - 2015-11-05 02:49:17,804 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:49:17 INFO - 2015-11-05 02:49:17,806 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:49:17 INFO - 2015-11-05 02:49:17,806 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,806 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4422.43 Median:4581.73 stddev:459.80 (10.0%) stddev-sans-first:438.06 02:49:17 INFO - 2015-11-05 02:49:17,806 DEBUG : BROWSER_OUTPUT: Values: 2586.2 2659.8 2672.5 2672.9 2679.8 4295.2 4366.7 4381.5 4453.8 4468.9 4339.8 4380.3 4395.5 4511.4 4513.0 4013.3 4019.2 4038.7 4084.2 4122.3 4060.9 4119.5 4194.1 4195.5 4297.5 3938.4 4023.1 4071.7 4117.9 4158.3 4026.1 4032.8 4043.1 4079.3 4080.0 4077.5 4123.7 4129.1 4147.0 4159.8 4239.5 4402.1 4410.3 4469.4 4480.2 4520.6 4603.7 4628.8 4660.3 4664.5 4786.2 4786.8 4836.5 4852.3 4857.5 4281.9 4541.7 4562.8 4599.6 4619.1 4678.6 4826.3 4829.3 4891.4 4957.3 4674.5 4696.2 4737.3 4745.3 4781.2 4582.7 4794.4 4824.4 4825.7 4847.3 4597.1 4610.1 4626.4 4712.9 4778.8 4726.7 4769.5 4778.3 4811.4 4841.9 3611.9 3761.8 3819.3 3821.3 3827.2 3332.0 3380.2 3398.7 3425.9 3454.3 4504.3 4528.0 4538.6 4584.8 4607.5 4541.2 4867.5 4868.3 4881.5 4890.4 4292.1 4400.1 4411.9 4437.2 4454.4 4225.7 4282.0 4289.0 4306.2 4318.8 4518.2 4678.7 4831.5 4853.7 4857.2 4674.0 4689.0 4729.2 4755.0 4798.9 4723.2 4758.6 4804.5 4834.1 4853.8 4499.2 4682.8 4690.5 4705.6 4741.5 4600.4 4669.0 4701.2 4709.8 4780.6 4614.2 4657.3 4684.8 4684.9 4705.6 4594.3 4597.3 4634.5 4638.0 4694.9 4398.4 4403.7 4504.3 4513.9 4517.6 4600.4 4627.2 4665.2 4676.1 4711.5 4561.7 4576.0 4581.7 4586.7 4589.4 02:49:17 INFO - 2015-11-05 02:49:17,807 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,808 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36421.67 Median:30694.19 stddev:57651.00 (187.8%) stddev-sans-first:57749.49 02:49:17 INFO - 2015-11-05 02:49:17,809 DEBUG : BROWSER_OUTPUT: Values: 459.2 462.6 462.9 464.9 486.3 25744.0 25905.7 26039.0 26066.6 31746.8 34475.1 34862.7 35049.3 35149.0 35299.8 7555.2 7647.1 7647.2 7648.8 7662.1 6860.2 6997.7 7345.7 7465.6 8685.6 8690.8 8810.6 8811.5 8816.3 8819.6 8708.2 8738.4 8774.4 8836.3 8844.0 6772.5 6800.7 6906.8 6937.6 6988.2 32210.4 32682.7 32733.7 32809.4 32823.3 2319.4 2642.6 2679.8 2730.8 2890.7 22789.3 22837.2 23763.2 23896.5 24052.5 2008.4 2028.1 2028.9 2046.0 2052.0 227776.0 230323.8 231334.0 233391.0 235267.0 50997.7 51004.0 51108.2 51385.2 51566.2 49767.0 51077.2 51121.0 55983.4 56440.0 13648.3 13709.1 13732.6 13825.6 13952.3 10412.8 10505.0 10625.1 10625.9 10632.8 16137.9 16680.5 16824.2 16873.1 16892.2 7201.8 7501.1 7533.0 7552.1 7625.1 757.5 819.1 872.2 877.6 902.7 23175.7 23257.2 23342.4 23371.6 23510.6 887.3 901.9 919.6 975.5 1032.2 12007.8 12015.2 12058.0 12059.2 12067.5 245669.0 249863.0 251425.0 253388.0 255561.0 44094.6 44674.8 44713.6 44776.0 44884.8 1142.9 1147.1 1166.7 1166.8 1171.9 20840.9 23145.2 23303.3 23325.3 23394.4 36142.5 36716.3 36753.5 36992.4 37225.6 171372.0 171930.0 172051.0 173263.0 173280.0 22857.4 23079.0 25609.4 26180.3 26822.9 30813.4 31672.4 31693.5 32114.5 32396.0 30339.0 32523.3 33140.3 33164.3 33204.7 25869.7 28511.9 29591.7 30575.0 33154.8 30056.0 32312.2 33286.3 33302.2 33502.0 24563.3 26450.6 26710.6 27189.7 28670.4 19912.6 20088.2 20158.2 20235.8 20254.1 02:49:17 INFO - 2015-11-05 02:49:17,810 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,810 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25680.43 Median:378.49 stddev:79914.47 (21114.2%) stddev-sans-first:80115.88 02:49:17 INFO - 2015-11-05 02:49:17,810 DEBUG : BROWSER_OUTPUT: Values: 277.0 279.4 280.6 283.4 284.1 14271.3 14355.3 14750.9 14778.4 14829.8 13962.3 14267.1 14652.0 15125.4 15214.5 4331.2 4359.8 4375.3 4407.0 4462.6 4323.8 4381.6 4390.6 4425.2 4433.3 3185.4 3305.2 3309.3 4326.6 4347.5 4708.0 4798.1 4819.9 4838.9 4842.4 3229.6 4177.0 4178.7 4205.8 4218.7 9353.2 9545.4 9719.5 10608.9 10628.5 1209.8 1421.2 1503.7 1563.8 1595.8 7827.4 7831.1 7840.5 7874.6 7922.9 1222.3 1241.6 1278.8 1296.1 1297.3 48224.3 48539.0 49411.5 58807.0 62562.7 13764.3 14777.8 14832.4 14867.3 14875.4 20706.2 20895.0 20948.8 20999.9 21002.0 8588.7 8609.7 8636.3 8649.9 8751.8 7417.6 7421.8 7465.9 7488.2 7512.8 6759.5 6871.7 6879.0 6896.3 6939.2 2700.0 2728.5 2743.9 2752.6 2756.9 333.1 340.5 359.2 371.5 376.3 9087.5 9660.4 9883.7 9984.1 10023.6 380.7 386.1 389.9 390.5 390.7 4750.5 4828.3 5283.9 5464.7 5485.6 474997.0 482557.0 493754.0 499274.0 499450.0 58729.7 61238.7 61709.0 62596.0 62793.4 404.7 406.2 412.1 412.7 420.9 9146.9 9191.0 9248.4 9358.8 9449.6 29594.0 29726.3 29731.0 29734.9 30593.4 40412.6 40703.8 40995.0 41530.0 41773.6 11902.2 12173.5 12183.7 12517.9 12564.0 15221.7 15371.7 16266.8 16289.7 16297.8 9693.9 11478.3 12659.4 12748.8 12810.7 10944.5 11176.9 12260.8 12562.4 12919.4 12726.2 12957.7 13394.0 13528.2 13537.5 12485.3 12548.7 12627.0 12641.2 12971.1 12465.1 12631.9 12728.9 13033.9 13081.9 02:49:17 INFO - 2015-11-05 02:49:17,810 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,810 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4159.02 Median:5354.03 stddev:2109.92 (39.4%) stddev-sans-first:2103.15 02:49:17 INFO - 2015-11-05 02:49:17,812 DEBUG : BROWSER_OUTPUT: Values: 1081.0 1422.4 1453.5 1484.8 1500.3 5553.4 5749.9 5802.8 5858.3 5869.6 5819.4 5931.3 5959.4 5997.8 6000.0 1769.9 1799.0 1806.4 1806.9 1807.9 1763.3 1770.8 1793.1 1798.8 1830.4 1767.0 1783.4 1792.5 1792.6 1799.4 1709.4 1714.8 1751.9 1760.0 1771.0 1758.1 1787.9 1789.4 1792.1 1803.7 5380.9 5930.8 5935.1 5947.0 5966.3 3310.5 3408.8 3582.3 3691.3 3702.2 2301.9 2350.1 2377.3 2377.5 2397.6 786.0 802.9 805.7 819.2 819.4 7763.8 7804.9 7809.2 7836.5 7907.7 3343.7 3352.9 3358.8 3411.4 3412.8 6984.9 6994.9 7011.3 7034.0 7071.0 3641.7 3710.3 3712.8 3718.3 3759.8 3381.9 3382.4 3390.6 3400.9 3410.8 2786.3 2822.1 2839.4 2855.1 2871.3 904.1 906.6 909.2 910.8 930.2 889.5 907.7 917.5 921.0 928.3 5672.5 5691.1 5714.7 5719.5 5721.9 369.3 387.1 391.1 391.1 391.2 4528.7 4631.3 4646.7 4656.3 4677.0 6592.3 6723.5 6815.1 6977.9 7009.2 6844.5 6886.3 6912.2 6929.2 6953.3 5534.1 5536.1 5582.1 5586.1 5654.6 5483.7 5491.4 5502.8 5505.0 5517.9 6142.5 6176.8 6204.0 6246.1 6251.3 6276.3 6385.5 6390.8 6397.1 6440.7 5264.8 5327.8 5331.2 5335.3 5343.9 5701.2 5756.8 5759.7 5771.3 5796.6 5304.3 5346.4 5459.9 5460.8 5492.6 5207.6 5224.9 5322.2 5374.8 5389.0 5323.1 5361.7 5392.0 5400.9 5423.4 4927.9 4936.5 4957.2 4982.1 4998.1 4933.5 4946.8 4966.1 4968.2 4994.6 02:49:17 INFO - 2015-11-05 02:49:17,812 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,812 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4471.39 Median:5157.72 stddev:1350.93 (26.2%) stddev-sans-first:1317.20 02:49:17 INFO - 2015-11-05 02:49:17,814 DEBUG : BROWSER_OUTPUT: Values: 259.0 264.5 265.2 268.1 272.6 5023.6 5081.3 5094.8 5123.9 5127.6 4958.4 5036.7 5039.7 5068.2 5079.2 3752.2 3804.9 3807.6 3903.8 3915.2 3823.1 3899.5 3931.8 3932.1 3936.3 3825.3 3877.2 3886.2 3893.0 3901.8 3837.2 3855.0 3861.4 3870.1 3933.5 3282.7 3329.1 3368.3 3381.9 3402.8 4831.8 4959.6 4970.8 4975.7 5005.1 4400.8 4429.6 4432.8 4444.0 4452.7 5091.8 5279.6 5295.0 5315.7 5323.1 3578.7 3586.8 3613.2 3658.0 3665.9 5470.6 5509.8 5522.1 5534.8 5547.4 3678.2 3715.6 3721.7 3726.2 3730.9 3743.5 3747.3 3769.6 3785.7 3809.7 4229.4 4404.7 4418.4 4420.2 4447.9 5318.3 5325.6 5330.9 5361.8 5369.3 1355.2 1370.1 1377.1 1378.5 1391.4 889.5 897.5 902.8 915.6 915.7 5119.6 5156.7 5159.9 5203.3 5205.0 5555.1 5575.2 5585.5 5609.9 5613.3 5111.1 5148.6 5148.7 5158.7 5201.0 2984.9 3086.5 3090.7 3106.3 3106.5 5571.3 5579.3 5583.4 5588.5 5653.2 5648.5 5657.1 5702.4 5707.7 5725.6 5576.7 5589.0 5599.8 5614.1 5658.2 5356.6 5500.2 5591.8 5603.6 5636.1 5265.3 5331.3 5380.4 5431.5 5511.8 5550.2 5555.7 5577.2 5595.4 5629.3 3586.0 3623.6 3655.1 3659.3 3664.5 5376.3 5511.4 5533.4 5557.4 5573.0 5351.3 5425.5 5455.2 5470.3 5541.0 5394.5 5414.5 5421.0 5429.2 5482.7 5307.0 5311.3 5317.2 5349.1 5377.4 5298.9 5406.3 5421.3 5431.2 5479.6 5282.2 5311.4 5336.7 5338.4 5340.0 02:49:17 INFO - 2015-11-05 02:49:17,814 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,814 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11571.35 Median:574.60 stddev:14000.48 (2436.5%) stddev-sans-first:14015.56 02:49:17 INFO - 2015-11-05 02:49:17,816 DEBUG : BROWSER_OUTPUT: Values: 611.1 626.8 630.4 637.6 639.2 11349.3 11451.4 11452.9 11479.0 11504.3 11700.7 12002.1 12035.5 12220.4 12254.3 590.2 597.1 732.2 753.7 759.0 591.8 739.4 739.9 741.6 743.7 720.9 766.2 769.6 770.9 777.4 601.0 616.3 766.3 766.6 772.2 567.8 569.4 570.7 572.3 577.0 11302.8 11653.5 11823.9 11852.3 11881.3 9805.5 9820.0 9835.7 10162.4 10180.5 7625.3 7671.5 7709.4 7952.4 8016.7 2727.8 2739.2 2745.4 2781.2 2788.9 42887.1 43271.4 43568.1 43571.3 43963.8 7811.5 7886.3 7926.9 7980.2 8065.0 16753.0 17110.7 17149.2 17150.1 17235.3 5811.4 5969.9 6151.0 6252.3 6253.2 3199.2 3245.4 3319.0 3365.7 3373.9 2398.8 2431.4 2438.3 2442.4 2444.1 356.6 359.8 360.5 361.7 362.5 388.3 453.4 500.3 503.7 538.6 6148.4 6387.5 6496.2 6665.1 6728.8 363.7 376.6 466.9 490.1 518.7 3028.3 3081.3 3126.8 3147.3 3150.5 50609.5 50654.5 51063.5 51313.7 51477.5 42522.1 43433.0 43747.3 43824.3 43839.8 37699.6 37872.4 38607.2 40098.2 40221.2 6309.1 6330.2 6339.5 6505.8 6637.4 28658.9 29523.9 29576.9 29757.3 29837.7 37176.8 37319.8 38762.6 39894.0 40905.6 6383.8 6482.5 6521.4 6548.3 6598.1 9029.6 9213.7 9258.6 9306.6 9359.5 8779.3 8855.5 8882.5 8885.1 8923.7 8765.1 8790.1 8801.0 8922.3 8925.9 8424.7 8434.0 8555.0 8586.8 8632.0 7412.7 7802.6 8020.2 8071.2 8077.5 7413.2 7484.4 7758.4 7810.9 7976.7 02:49:17 INFO - 2015-11-05 02:49:17,816 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:49:17 INFO - 2015-11-05 02:49:17,816 DEBUG : BROWSER_OUTPUT: 02:49:18 INFO - 2015-11-05 02:49:18,706 INFO : Browser exited with error code: 0 02:49:18 INFO - 2015-11-05 02:49:18,739 INFO : Completed test dromaeo_css (00:18:35) 02:49:18 INFO - 2015-11-05 02:49:18,739 INFO : Starting test kraken 02:49:18 INFO - 2015-11-05 02:49:18,739 DEBUG : operating with platform_type : mac_ 02:49:18 INFO - 2015-11-05 02:49:18,739 INFO : Initialising browser for kraken test... 02:49:18 INFO - 2015-11-05 02:49:18,754 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmps17AAa/profile http://localhost:53677/getInfo.html 02:49:21 INFO - 2015-11-05 02:49:21,218 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:49:21 INFO - 2015-11-05 02:49:21,218 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:49:21 INFO - 2015-11-05 02:49:21,219 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:49:21 INFO - 2015-11-05 02:49:21,219 DEBUG : BROWSER_OUTPUT: __metrics 02:49:21 INFO - 2015-11-05 02:49:21,241 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:21 INFO - 2015-11-05 02:49:21,994 INFO : Browser initialized. 02:49:21 INFO - 2015-11-05 02:49:21,994 INFO : Running cycle 1/1 for kraken test... 02:49:21 INFO - 2015-11-05 02:49:21,994 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmps17AAa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:49:34 INFO - 2015-11-05 02:49:34,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 221331456 02:49:34 INFO - 2015-11-05 02:49:34,071 DEBUG : BROWSER_OUTPUT: 02:49:36 INFO - 2015-11-05 02:49:36,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53677/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:37 INFO - 2015-11-05 02:49:37,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 277753856 02:49:37 INFO - 2015-11-05 02:49:37,575 DEBUG : BROWSER_OUTPUT: 02:49:40 INFO - 2015-11-05 02:49:40,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53677/tests/kraken/driver.html?testName=audio-dft) 02:49:41 INFO - 2015-11-05 02:49:41,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 290856960 02:49:41 INFO - 2015-11-05 02:49:41,248 DEBUG : BROWSER_OUTPUT: 02:49:44 INFO - 2015-11-05 02:49:44,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53677/tests/kraken/driver.html?testName=audio-fft) 02:49:45 INFO - 2015-11-05 02:49:45,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 277266432 02:49:45 INFO - 2015-11-05 02:49:45,265 DEBUG : BROWSER_OUTPUT: 02:49:47 INFO - 2015-11-05 02:49:47,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53677/tests/kraken/driver.html?testName=audio-oscillator) 02:49:48 INFO - 2015-11-05 02:49:48,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 279355392 02:49:48 INFO - 2015-11-05 02:49:48,115 DEBUG : BROWSER_OUTPUT: 02:49:50 INFO - 2015-11-05 02:49:50,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53677/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:49:51 INFO - 2015-11-05 02:49:51,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 280555520 02:49:51 INFO - 2015-11-05 02:49:51,220 DEBUG : BROWSER_OUTPUT: 02:49:54 INFO - 2015-11-05 02:49:54,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53677/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:55 INFO - 2015-11-05 02:49:55,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 276856832 02:49:55 INFO - 2015-11-05 02:49:55,359 DEBUG : BROWSER_OUTPUT: 02:49:59 INFO - 2015-11-05 02:49:59,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53677/tests/kraken/driver.html?testName=imaging-desaturate) 02:49:59 INFO - 2015-11-05 02:49:59,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 274366464 02:49:59 INFO - 2015-11-05 02:49:59,637 DEBUG : BROWSER_OUTPUT: 02:50:03 INFO - 2015-11-05 02:50:03,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53677/tests/kraken/driver.html?testName=json-parse-financial) 02:50:03 INFO - 2015-11-05 02:50:03,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 277045248 02:50:03 INFO - 2015-11-05 02:50:03,591 DEBUG : BROWSER_OUTPUT: 02:50:05 INFO - 2015-11-05 02:50:05,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53677/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:05 INFO - 2015-11-05 02:50:05,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 310378496 02:50:05 INFO - 2015-11-05 02:50:05,890 DEBUG : BROWSER_OUTPUT: 02:50:07 INFO - 2015-11-05 02:50:07,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53677/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:08 INFO - 2015-11-05 02:50:08,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 312532992 02:50:08 INFO - 2015-11-05 02:50:08,558 DEBUG : BROWSER_OUTPUT: 02:50:10 INFO - 2015-11-05 02:50:10,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53677/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:11 INFO - 2015-11-05 02:50:11,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 319569920 02:50:11 INFO - 2015-11-05 02:50:11,547 DEBUG : BROWSER_OUTPUT: 02:50:14 INFO - 2015-11-05 02:50:14,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:15 INFO - 2015-11-05 02:50:15,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 321122304 02:50:15 INFO - 2015-11-05 02:50:15,126 DEBUG : BROWSER_OUTPUT: 02:50:18 INFO - 2015-11-05 02:50:18,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:18 INFO - 2015-11-05 02:50:18,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 320512000 02:50:18 INFO - 2015-11-05 02:50:18,695 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53677/tests/kraken/driver.html?testName=ai-astar) 02:50:20 INFO - 2015-11-05 02:50:20,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 380985344 02:50:20 INFO - 2015-11-05 02:50:20,892 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,893 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:50:20 INFO - 2015-11-05 02:50:20,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:50:20 INFO - 2015-11-05 02:50:20,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:50:20 INFO - 2015-11-05 02:50:20,893 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |0;ai-astar;123;132;125;134;134;131;123;131;131;120 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;192;160;190;205;158;180;178;153;196;161 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |2;audio-dft;192;198;196;197;195;198;195;197;199;197 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;97;109;104;82;89;89;95;101;82 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;115;118;163;109;110;110;158;108;109;163 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;141;149;149;142;148;142;142;141;141;135 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;155;154;154;154;154;154;153;154;154;154 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;124;124;130;129;123;124;121;125;129;128 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;69;70;69;70;70;72;78;69;69 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;77;76;82;82;83;81;82;82;82 02:50:20 INFO - 2015-11-05 02:50:20,894 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;101;106;104;106;106;105;106;105;113;107 02:50:20 INFO - 2015-11-05 02:50:20,895 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;149;149;157;168;158;154;155;168;161;152 02:50:20 INFO - 2015-11-05 02:50:20,895 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;180;184;182;183;183;171;181;175;174;183 02:50:20 INFO - 2015-11-05 02:50:20,895 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;82;85;84;85;88;85;85;85;85 02:50:20 INFO - 2015-11-05 02:50:20,895 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:50:20 INFO - 2015-11-05 02:50:20,895 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:50:20 INFO - 2015-11-05 02:50:20,895 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 02:50:20 INFO - 2015-11-05 02:50:20,895 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:50:20 INFO - 2015-11-05 02:50:20,895 DEBUG : BROWSER_OUTPUT: __startTimestamp1446720620892__endTimestamp 02:50:20 INFO - 2015-11-05 02:50:20,896 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,899 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:50:20 INFO - 2015-11-05 02:50:20,899 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:50:20 INFO - 2015-11-05 02:50:20,899 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,900 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:128.40 Median:131.00 stddev:5.13 (3.9%) stddev-sans-first:5.05 02:50:20 INFO - 2015-11-05 02:50:20,900 DEBUG : BROWSER_OUTPUT: Values: 123.0 132.0 125.0 134.0 134.0 131.0 123.0 131.0 131.0 120.0 02:50:20 INFO - 2015-11-05 02:50:20,900 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,900 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:177.30 Median:185.00 stddev:18.35 (9.9%) stddev-sans-first:18.67 02:50:20 INFO - 2015-11-05 02:50:20,901 DEBUG : BROWSER_OUTPUT: Values: 192.0 160.0 190.0 205.0 158.0 180.0 178.0 153.0 196.0 161.0 02:50:20 INFO - 2015-11-05 02:50:20,901 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,901 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.40 Median:197.00 stddev:2.01 (1.0%) stddev-sans-first:1.36 02:50:20 INFO - 2015-11-05 02:50:20,901 DEBUG : BROWSER_OUTPUT: Values: 192.0 198.0 196.0 197.0 195.0 198.0 195.0 197.0 199.0 197.0 02:50:20 INFO - 2015-11-05 02:50:20,901 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,901 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.30 Median:87.00 stddev:9.42 (10.8%) stddev-sans-first:9.50 02:50:20 INFO - 2015-11-05 02:50:20,902 DEBUG : BROWSER_OUTPUT: Values: 85.0 97.0 109.0 104.0 82.0 89.0 89.0 95.0 101.0 82.0 02:50:20 INFO - 2015-11-05 02:50:20,902 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,902 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:126.30 Median:116.50 stddev:24.40 (20.9%) stddev-sans-first:25.54 02:50:20 INFO - 2015-11-05 02:50:20,902 DEBUG : BROWSER_OUTPUT: Values: 115.0 118.0 163.0 109.0 110.0 110.0 158.0 108.0 109.0 163.0 02:50:20 INFO - 2015-11-05 02:50:20,902 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,902 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.00 Median:142.00 stddev:4.42 (3.1%) stddev-sans-first:4.63 02:50:20 INFO - 2015-11-05 02:50:20,903 DEBUG : BROWSER_OUTPUT: Values: 141.0 149.0 149.0 142.0 148.0 142.0 142.0 141.0 141.0 135.0 02:50:20 INFO - 2015-11-05 02:50:20,903 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,903 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.00 Median:154.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 02:50:20 INFO - 2015-11-05 02:50:20,903 DEBUG : BROWSER_OUTPUT: Values: 155.0 154.0 154.0 154.0 154.0 154.0 153.0 154.0 154.0 154.0 02:50:20 INFO - 2015-11-05 02:50:20,903 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,903 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.70 Median:126.50 stddev:3.06 (2.4%) stddev-sans-first:3.18 02:50:20 INFO - 2015-11-05 02:50:20,903 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 130.0 129.0 123.0 124.0 121.0 125.0 129.0 128.0 02:50:20 INFO - 2015-11-05 02:50:20,903 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,904 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:3.46 (4.9%) stddev-sans-first:2.92 02:50:20 INFO - 2015-11-05 02:50:20,904 DEBUG : BROWSER_OUTPUT: Values: 64.0 69.0 70.0 69.0 70.0 70.0 72.0 78.0 69.0 69.0 02:50:20 INFO - 2015-11-05 02:50:20,904 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,904 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:80.40 Median:82.00 stddev:2.63 (3.2%) stddev-sans-first:2.49 02:50:20 INFO - 2015-11-05 02:50:20,904 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 76.0 82.0 82.0 83.0 81.0 82.0 82.0 82.0 02:50:20 INFO - 2015-11-05 02:50:20,904 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,904 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.90 Median:106.00 stddev:3.00 (2.8%) stddev-sans-first:2.60 02:50:20 INFO - 2015-11-05 02:50:20,904 DEBUG : BROWSER_OUTPUT: Values: 101.0 106.0 104.0 106.0 106.0 105.0 106.0 105.0 113.0 107.0 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:157.10 Median:157.50 stddev:6.87 (4.4%) stddev-sans-first:6.63 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 157.0 168.0 158.0 154.0 155.0 168.0 161.0 152.0 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:182.50 stddev:4.58 (2.5%) stddev-sans-first:4.85 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: Values: 180.0 184.0 182.0 183.0 183.0 171.0 181.0 175.0 174.0 183.0 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.10 Median:85.00 stddev:2.88 (3.4%) stddev-sans-first:1.54 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: Values: 77.0 82.0 85.0 84.0 85.0 88.0 85.0 85.0 85.0 85.0 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:50:20 INFO - 2015-11-05 02:50:20,905 DEBUG : BROWSER_OUTPUT: 02:50:21 INFO - 2015-11-05 02:50:21,655 INFO : Browser exited with error code: 0 02:50:21 INFO - 2015-11-05 02:50:21,712 INFO : Completed test kraken (00:01:02) 02:50:21 INFO - 2015-11-05 02:50:21,712 INFO : Starting test v8_7 02:50:21 INFO - 2015-11-05 02:50:21,712 DEBUG : operating with platform_type : mac_ 02:50:21 INFO - 2015-11-05 02:50:21,712 INFO : Initialising browser for v8_7 test... 02:50:21 INFO - 2015-11-05 02:50:21,727 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmp4RJHIJ/profile http://localhost:53677/getInfo.html 02:50:24 INFO - 2015-11-05 02:50:24,199 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:50:24 INFO - 2015-11-05 02:50:24,199 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:50:24 INFO - 2015-11-05 02:50:24,199 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:50:24 INFO - 2015-11-05 02:50:24,199 DEBUG : BROWSER_OUTPUT: __metrics 02:50:24 INFO - 2015-11-05 02:50:24,218 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:50:24 INFO - 2015-11-05 02:50:24,984 INFO : Browser initialized. 02:50:24 INFO - 2015-11-05 02:50:24,984 INFO : Running cycle 1/1 for v8_7 test... 02:50:24 INFO - 2015-11-05 02:50:24,984 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmp4RJHIJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:50:37 INFO - 2015-11-05 02:50:37,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 222339072 02:50:37 INFO - 2015-11-05 02:50:37,102 DEBUG : BROWSER_OUTPUT: 02:50:59 INFO - 2015-11-05 02:50:59,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53677/tests/v8_7/run.html (next: http://localhost:53677/tests/v8_7/run.html) 02:51:00 INFO - 2015-11-05 02:51:00,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 653824000 02:51:00 INFO - 2015-11-05 02:51:00,084 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,085 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:51:00 INFO - 2015-11-05 02:51:00,085 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:51:00 INFO - 2015-11-05 02:51:00,085 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:51:00 INFO - 2015-11-05 02:51:00,085 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:51:00 INFO - 2015-11-05 02:51:00,085 DEBUG : BROWSER_OUTPUT: |0;Richards;208.5070892410342 02:51:00 INFO - 2015-11-05 02:51:00,085 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;244.2002442002442 02:51:00 INFO - 2015-11-05 02:51:00,085 DEBUG : BROWSER_OUTPUT: |2;Encrypt;384.172109104879 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6910.3448275862065 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2487.5621890547263 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: |5;Earley;956.0229445506692 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: |6;Boyer;15952.380952380952 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: |7;RegExp;38301.88679245283 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: |8;Splay;821.1648892534864 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6972.222222222223 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:51:00 INFO - 2015-11-05 02:51:00,086 DEBUG : BROWSER_OUTPUT: __startTimestamp1446720660077__endTimestamp 02:51:00 INFO - 2015-11-05 02:51:00,087 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,087 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:51:00 INFO - 2015-11-05 02:51:00,087 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:51:00 INFO - 2015-11-05 02:51:00,087 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,087 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:208.51 Median:208.51 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,087 DEBUG : BROWSER_OUTPUT: Values: 208.5 02:51:00 INFO - 2015-11-05 02:51:00,087 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:244.20 Median:244.20 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: Values: 244.2 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:384.17 Median:384.17 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: Values: 384.2 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6910.34 Median:6910.34 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: Values: 6910.3 02:51:00 INFO - 2015-11-05 02:51:00,088 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,089 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2487.56 Median:2487.56 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,089 DEBUG : BROWSER_OUTPUT: Values: 2487.6 02:51:00 INFO - 2015-11-05 02:51:00,089 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,089 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:956.02 Median:956.02 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,089 DEBUG : BROWSER_OUTPUT: Values: 956.0 02:51:00 INFO - 2015-11-05 02:51:00,089 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,089 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15952.38 Median:15952.38 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,090 DEBUG : BROWSER_OUTPUT: Values: 15952.4 02:51:00 INFO - 2015-11-05 02:51:00,090 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,090 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:38301.89 Median:38301.89 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,090 DEBUG : BROWSER_OUTPUT: Values: 38301.9 02:51:00 INFO - 2015-11-05 02:51:00,090 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,090 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:821.16 Median:821.16 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,090 DEBUG : BROWSER_OUTPUT: Values: 821.2 02:51:00 INFO - 2015-11-05 02:51:00,090 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,091 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6972.22 Median:6972.22 stddev:0.00 (0.0%) 02:51:00 INFO - 2015-11-05 02:51:00,091 DEBUG : BROWSER_OUTPUT: Values: 6972.2 02:51:00 INFO - 2015-11-05 02:51:00,091 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:51:00 INFO - 2015-11-05 02:51:00,091 DEBUG : BROWSER_OUTPUT: 02:51:00 INFO - 2015-11-05 02:51:00,822 INFO : Browser exited with error code: 0 02:51:00 INFO - 2015-11-05 02:51:00,846 INFO : Completed test v8_7 (00:00:39) 02:51:00 INFO - 2015-11-05 02:51:00,954 INFO : Completed test suite (00:20:17) 02:51:00 INFO - 2015-11-05 02:51:00,954 DEBUG : Working with test: dromaeo_css 02:51:00 INFO - 2015-11-05 02:51:00,954 DEBUG : Generating results file: dromaeo_css 02:51:00 INFO - 2015-11-05 02:51:00,955 DEBUG : Working with test: kraken 02:51:00 INFO - 2015-11-05 02:51:00,955 DEBUG : Generating results file: kraken 02:51:00 INFO - 2015-11-05 02:51:00,956 INFO : javascript benchmark 02:51:00 INFO - 2015-11-05 02:51:00,956 DEBUG : Working with test: v8_7 02:51:00 INFO - 2015-11-05 02:51:00,956 DEBUG : Generating results file: v8_7 02:51:00 INFO - 2015-11-05 02:51:00,956 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:01 INFO - 2015-11-05 02:51:01,016 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 02:51:01 INFO - 2015-11-05 02:51:01,016 DEBUG : process_Request line: dromaeo_css 5687.51 graph.html#tests=[[72,64,55]] 02:51:01 INFO - 2015-11-05 02:51:01,016 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:01 INFO - 2015-11-05 02:51:01,053 DEBUG : process_Request line: kraken 1821.50 graph.html#tests=[[232,64,55]] 02:51:01 INFO - 2015-11-05 02:51:01,054 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:01 INFO - 2015-11-05 02:51:01,083 DEBUG : process_Request line: v8_7 14962.14 graph.html#tests=[[230,64,55]] 02:51:01 INFO - 2015-11-05 02:51:01,084 INFO : javascript benchmark 02:51:01 INFO - 2015-11-05 02:51:01,087 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [277.04971946224447, 279.3769893138303, 280.5763297420894, 283.440205593952, 284.0951569251933, 14271.286435678227, 14355.282235888217, 14750.926245368772, 14778.408863645454, 14829.77755333671, 13962.301884905739, 14267.143971361726, 14652.0, 15125.394984200619, 15214.467493637725, 4331.155424692194, 4359.825606975717, 4375.278079116942, 4406.97796511017, 4462.620677242438, 4323.805428755713, 4381.627561657263, 4390.648748100144, 4425.159219748238, 4433.290673492242, 3185.3629274145146, 3305.2397948471867, 3309.271960168771, 4326.632236259906, 4347.500037495681, 4707.976460117695, 4798.136335459616, 4819.903601927959, 4838.903221935541, 4842.370491836074, 3229.612446506411, 4176.979115104405, 4178.7283826551175, 4205.810738516774, 4218.7468751874985, 9353.158215760546, 9545.379550329206, 9719.514024298756, 10608.946955265252, 10628.521716522775, 1209.8064309710492, 1421.182819878574, 1503.6992601479749, 1563.7576175692786, 1595.7606359046235, 7827.373810095179, 7831.099423566249, 7840.49036812611, 7874.645640946172, 7922.881156782653, 1222.3460448660014, 1241.6399244219165, 1278.8017857232144, 1296.0992110483219, 1297.2929753284482, 48224.27663585049, 48539.0, 49411.50588494105, 58807.0, 62562.68718656423, 13764.31178441074, 14777.778333325008, 14832.406703731946, 14867.256637168099, 14875.404983800527, 20706.17175313001, 20895.0, 20948.790512094685, 20999.895000525205, 21002.0, 8588.699395521127, 8609.741707748777, 8636.265917397091, 8649.870251946226, 8751.768299083693, 7417.554946703107, 7421.8144546386775, 7465.888011679829, 7488.176300606929, 7512.812179695551, 6759.493038022069, 6871.725130994804, 6879.0, 6896.310368963063, 6939.167299924042, 2699.9730002700117, 2728.495228382716, 2743.931401714973, 2752.573351130578, 2756.9172924812287, 333.12388418459295, 340.5402706346413, 359.20973857513576, 371.52444870565716, 376.2775471095503, 9087.468000119501, 9660.420374777535, 9883.654072107585, 9984.101430871257, 10023.599056037823, 380.6973456102405, 386.133131120636, 389.92575454622335, 390.4650628638783, 390.6679322575788, 4750.501197374295, 4828.275758636162, 5283.867903302371, 5464.672119672832, 5485.61600687956, 474997.0, 482557.0, 493754.0, 499274.0, 499450.0, 58729.70635146797, 61238.69380653068, 61709.0, 62596.0, 62793.37206627967, 404.65604236398826, 406.21194881928966, 412.08517092055587, 412.66780241904956, 420.88425682937435, 9146.908530914605, 9191.0, 9248.352615316864, 9358.766030849283, 9449.574769135268, 29594.0, 29726.25684357908, 29731.0, 29734.851325744097, 30593.388132236785, 40412.59587404088, 40703.79648101741, 40995.0, 41530.0, 41773.58226417697, 11902.166848320534, 12173.45219465144, 12183.695407614881, 12517.874821252035, 12564.0, 15221.695566088838, 15371.692566148839, 16266.755998660266, 16289.67420651604, 16297.837021629632, 9693.9030609693, 11478.311301321948, 12659.430325635185, 12748.816823840616, 12810.679733006376, 10944.507497162487, 11176.944115279372, 12260.75478490443, 12562.371881406076, 12919.418626162033, 12726.17279876805, 12957.676058098246, 13394.0, 13528.188308701509, 13537.458501659823, 12485.250884946932, 12548.749025019632, 12627.0, 12641.178323408949, 12971.09202355826, 12465.1274410794, 12631.93684031574, 12728.854403103765, 13033.869661303645, 13081.934590326988], "dojo.html": [2586.224132760172, 2659.800514961378, 2672.4521473098007, 2672.8529930853797, 2679.807485668878, 4295.248331541983, 4366.6506679465565, 4381.518033016369, 4453.755043472612, 4468.8659340219765, 4339.804708788112, 4380.32105023721, 4395.516493185755, 4511.368408422815, 4513.0, 4013.2776100301935, 4019.1760689058674, 4038.7374820636564, 4084.1831633673237, 4122.2786012447705, 4060.8781736547803, 4119.505659320886, 4194.140201258735, 4195.538490766014, 4297.484301883778, 3938.4289278054807, 4023.0948036691802, 4071.653909417703, 4117.8970525736795, 4158.2515147273325, 4026.1142548639255, 4032.8185231664647, 4043.0903046814233, 4079.2657321682086, 4080.0207950091763, 4077.531083925357, 4123.731957422758, 4129.112240868198, 4147.025449019478, 4159.812808423628, 4239.47006624172, 4402.141582391435, 4410.272305069691, 4469.374287599739, 4480.171168333836, 4520.570545798144, 4603.746793926332, 4628.791704373278, 4660.254359302496, 4664.5335466453425, 4786.21027530457, 4786.7845946932475, 4836.51634836517, 4852.344933434012, 4857.514248575149, 4281.892952676208, 4541.72749635023, 4562.771861406916, 4599.563041511051, 4619.0530941156985, 4678.578927896438, 4826.276058591239, 4829.251466022772, 4891.413030436371, 4957.256411538298, 4674.462436819741, 4696.248600224016, 4737.336772851803, 4745.264484004984, 4781.187198176319, 4582.702124361906, 4794.4486384065585, 4824.421069471686, 4825.662203645781, 4847.2729090636685, 4597.057603191338, 4610.10103029906, 4626.37543931565, 4712.9057418851435, 4778.784954677048, 4726.669133160645, 4769.475357710649, 4778.331033655291, 4811.374521312207, 4841.9031619367415, 3611.8916432507067, 3761.755485893408, 3819.2743378757946, 3821.2548553032448, 3827.158025234444, 3331.950020749691, 3380.2056516718553, 3398.6601339865815, 3425.9143521412166, 3454.2573346730574, 4504.2793153096, 4527.977360113178, 4538.591526762607, 4584.770761461914, 4607.493175750665, 4541.205289074399, 4867.488913664085, 4868.294097355934, 4881.487443818419, 4890.437599676012, 4292.12011537634, 4400.141972315368, 4411.933820992687, 4437.245668236407, 4454.354118652777, 4225.68307376948, 4282.0, 4289.013526888771, 4306.181825453154, 4318.805653745589, 4518.231900576976, 4678.742669153161, 4831.516848315211, 4853.684510506806, 4857.1742803724155, 4673.976630116827, 4688.976555117202, 4729.17239483096, 4755.0, 4798.928016079832, 4723.197056500335, 4758.643101767312, 4804.495527969652, 4834.1298566257, 4853.805847766191, 4499.235130027838, 4682.812687492462, 4690.460597031385, 4705.64707646921, 4741.50214227515, 4600.447946246338, 4668.953310466852, 4701.153792317279, 4709.835155769531, 4780.617550596014, 4614.1694494991225, 4657.324687920301, 4684.789184486638, 4684.859454216379, 4705.623550116051, 4594.264917613166, 4597.287420449836, 4634.513376095461, 4637.976810116063, 4694.882627934329, 4398.428204333416, 4403.669724770719, 4504.256797628354, 4513.909721805479, 4517.638588912945, 4600.4479462464715, 4627.213373726408, 4665.160271151225, 4676.088162808356, 4711.458182309078, 4561.703489273186, 4575.9771201143785, 4581.725096494221, 4586.701864378805, 4589.357489951342], "mootools.html": [1080.9891901080987, 1422.3883729996103, 1453.4694836384722, 1484.7772834074888, 1500.2573726005626, 5553.416891226424, 5749.885002299951, 5802.796902108433, 5858.326292476367, 5869.559783016281, 5819.359870414251, 5931.288245410546, 5959.374265702104, 5997.820065398034, 6000.0, 1769.867259955502, 1798.9640207195848, 1806.3948577226645, 1806.8735188536807, 1807.8553715702712, 1763.2506184871443, 1770.7786526684165, 1793.0944872839198, 1798.7571677823523, 1830.3685228596114, 1766.991165044173, 1783.4382169616529, 1792.524980880068, 1792.5966657502088, 1799.406195955338, 1709.3504468302028, 1714.8456638902496, 1751.938682146125, 1759.961622642647, 1770.97343539847, 1758.0506526475688, 1787.892726436418, 1789.3647755047032, 1792.0681245752266, 1803.7114061750058, 5380.946190538084, 5930.822075337746, 5935.10973353996, 5947.0, 5966.343702192756, 3310.5034244863223, 3408.8466019028956, 3582.3193593217206, 3691.335559599271, 3702.1855191858017, 2301.8503797253293, 2350.13045173287, 2377.322463098026, 2377.500724847784, 2397.6163813789885, 785.9764207073797, 802.9237222463856, 805.6656487557657, 819.2176471469733, 819.3568049081503, 7763.8447231055625, 7804.88292675616, 7809.219078092202, 7836.529808211526, 7907.683692652287, 3343.732501399882, 3352.9329413412083, 3358.8320583970703, 3411.368896754059, 3412.84642191102, 6984.930150698529, 6994.860102797916, 7011.29887011305, 7033.964830175816, 7071.0, 3641.652588542256, 3710.3135919854913, 3712.832922518493, 3718.3121122592406, 3759.8496060157286, 3381.898543043713, 3382.4249877520388, 3390.6100798408497, 3400.863965441404, 3410.7612467127065, 2786.317352248712, 2822.111035023961, 2839.417919326533, 2855.072101566999, 2871.25347409675, 904.073324842029, 906.582971832951, 909.1908201700492, 910.7677542226689, 930.223263574909, 889.5329951775241, 907.7458311672742, 917.5228880981851, 920.9723708288763, 928.3084102343797, 5672.517835983987, 5691.117876729114, 5714.657120572779, 5719.4852463277675, 5721.942780572141, 369.305705274083, 387.1308911493658, 391.1102242398566, 391.1433959628405, 391.213660542312, 4528.682992190581, 4631.305304204397, 4646.674732768742, 4656.278276867091, 4676.95323046772, 6592.274849766522, 6723.5293529452465, 6815.148106486689, 6977.93022069783, 7009.158900931819, 6844.452443804484, 6886.345797149263, 6912.239653638096, 6929.237783843773, 6953.269906659728, 5534.146061069507, 5536.141898005815, 5582.080783841302, 5586.106223004381, 5654.604177707521, 5483.670979741229, 5491.368492623399, 5502.779888804403, 5505.03661859181, 5517.917231241454, 6142.477889379274, 6176.752929882754, 6204.007358822567, 6246.1255424239735, 6251.312355640966, 6276.309605943434, 6385.521085918482, 6390.7763228286785, 6397.072424498515, 6440.742370305135, 5264.815731449381, 5327.813526526553, 5331.226972088948, 5335.33308336458, 5343.893122137613, 5701.173329867063, 5756.827295181151, 5759.683217423082, 5771.278590176228, 5796.565257605781, 5304.257403963526, 5346.358436987586, 5459.863503412287, 5460.7542660579575, 5492.615516913777, 5207.557357624492, 5224.947750522446, 5322.175062865107, 5374.838754837361, 5389.003034438641, 5323.0684630190335, 5361.705106219039, 5391.973040134774, 5400.918986215289, 5423.430539793265, 4927.901441971068, 4936.531029552187, 4957.157283261926, 4982.10322142018, 4998.075356059141, 4933.5066493351815, 4946.752662366795, 4966.081274964144, 4968.22992436173, 4994.600431965361], "ext.html": [459.1689042832473, 462.5952291744723, 462.90279041401305, 464.91166678331115, 486.3215813939557, 25744.0, 25905.740942590593, 26039.0, 26066.609000865003, 31746.84126579364, 34475.138121546974, 34862.65137348626, 35049.29901401971, 35149.0, 35299.82350088252, 7555.244475552442, 7647.120581133157, 7647.158812530617, 7648.847023059536, 7662.11885633151, 6860.245373008965, 6997.685104170325, 7345.669444874993, 7465.589392583406, 8685.609147588342, 8690.782730431727, 8810.603522841488, 8811.515366654832, 8816.250618697419, 8819.647214111428, 8708.21626053655, 8738.388312818106, 8774.429662071945, 8836.337274704358, 8844.0, 6772.525923185379, 6800.659967001679, 6906.792796216121, 6937.583744975318, 6988.231294557595, 32210.355792884246, 32682.673173268202, 32733.6726632733, 32809.40668306439, 32823.343533129206, 2319.420144963759, 2642.577187649986, 2679.7588217060556, 2730.8361498310164, 2890.7398334150025, 22789.31632051041, 22837.20069797566, 23763.16828910997, 23896.522069558687, 24052.518949621084, 2008.3573256557906, 2028.0873606876817, 2028.9492762680904, 2045.9795402046086, 2051.98974005129, 227776.0, 230323.8483807587, 231334.0, 233391.0, 235267.0, 50997.7450112747, 51004.0, 51108.23337649938, 51385.229221561705, 51566.226506602434, 49767.0, 51077.23384149241, 51121.0, 55983.44016559864, 56440.0, 13648.317584120754, 13709.108907920952, 13732.588022359345, 13825.585232443043, 13952.302384880715, 10412.791744165073, 10505.0, 10625.096866766411, 10625.946870265754, 10632.840507392395, 16137.919310403373, 16680.49958501247, 16824.242909069122, 16873.07198104116, 16892.15539223034, 7201.819954501179, 7501.137369202503, 7533.02445534011, 7552.093748750185, 7625.084989801259, 757.5189754505928, 819.1030821250721, 872.2498651159997, 877.6002276369181, 902.6840605788053, 23175.652365214537, 23257.18599848997, 23342.416439589146, 23371.649425258634, 23510.64734028991, 887.3433659092225, 901.9052999434965, 919.558611866308, 975.4683697384942, 1032.1742605915238, 12007.819882701766, 12015.219010764273, 12057.975072118792, 12059.21615095016, 12067.456964436622, 245669.0, 249863.0, 251425.0, 253388.0, 255561.0, 44094.559054409685, 44674.77662611666, 44713.55286447159, 44776.0, 44884.77557612191, 1142.9142814288796, 1147.0880649883363, 1166.702490864824, 1166.8133098704166, 1171.912106592026, 20840.895795520926, 23145.18991835278, 23303.300900972998, 23325.300240992798, 23394.415139621644, 36142.4578631326, 36716.26567468689, 36753.486976952605, 36992.445113322785, 37225.627743722216, 171372.0, 171930.0, 172051.0, 173263.0, 173280.0, 22857.42856428536, 23079.0, 25609.359766006, 26180.345491362867, 26822.865885670446, 30813.38373232478, 31672.366552668358, 31693.524597131523, 32114.518282226254, 32396.0, 30339.0, 32523.349533008735, 33140.337193256484, 33164.33671326608, 33204.66795332016, 25869.741302587485, 28511.857440712665, 29591.704082958895, 30575.0, 33154.834225828716, 30056.0, 32312.19219519437, 33286.33427331488, 33302.16744581308, 33502.0, 24563.263102106965, 26450.603240951787, 26710.59934101029, 27189.72810271872, 28670.42659146847, 19912.60174796525, 20088.19647214095, 20158.193672252946, 20235.79764202398, 20254.08856601427], "prototype.html": [258.98187126901115, 264.49745483581205, 265.21905405204063, 268.14194577352475, 272.5693404421015, 5023.57299629531, 5081.263216833557, 5094.770735316911, 5123.897522049561, 5127.589792816575, 4958.35541379621, 5036.722980236085, 5039.72281524516, 5068.189089745632, 5079.212722028092, 3752.2495500899795, 3804.9429258561145, 3807.562130355003, 3903.7657740535587, 3915.2169566086754, 3823.1397935464574, 3899.473571067912, 3931.8230679619487, 3932.1152740633415, 3936.311145549532, 3825.3305671507514, 3877.185790983897, 3886.2227554489214, 3893.007283142809, 3901.7854018028997, 3837.2325534892993, 3855.036240939765, 3861.362875125615, 3870.148567315186, 3933.5279766427925, 3282.720968717662, 3329.101142691484, 3368.326334733063, 3381.9323613527836, 3402.795832250073, 4831.806727730886, 4959.603231741452, 4970.776315065831, 4975.7263350515705, 5005.124103281911, 4400.7579583122915, 4429.645628349756, 4432.822687092513, 4443.955670417449, 4452.732836029849, 5091.821786237501, 5279.577633789288, 5295.0, 5315.707636080014, 5323.121684921984, 3578.7315951303494, 3586.820658967067, 3613.2050948791225, 3658.0, 3665.9266814663824, 5470.64440811346, 5509.807156749534, 5522.088855338864, 5534.833954981357, 5547.417521160301, 3678.1907980244305, 3715.554133503997, 3721.683656889141, 3726.1802403471193, 3730.9067273318383, 3743.513343265358, 3747.2880152770886, 3769.6230376962635, 3785.6782173515007, 3809.695224382043, 4229.365595160751, 4404.7357158570585, 4418.425604671436, 4420.160169567772, 4447.866564003085, 5318.335208098988, 5325.573954083664, 5330.866728331823, 5361.785528578891, 5369.328833895763, 1355.2478374502246, 1370.0683535195963, 1377.1048818268005, 1378.476179051974, 1391.4086513231837, 889.4752096263236, 897.52879738138, 902.8104098139464, 915.5742579700471, 915.6749353979375, 5119.6160287978555, 5156.716380599028, 5159.871003224875, 5203.323567936144, 5205.0, 5555.055640541118, 5575.163725441135, 5585.497305242548, 5609.915851262234, 5613.298337707786, 5111.131107711698, 5148.613853960893, 5148.665336753099, 5158.716270605078, 5201.037808005455, 2984.850757462118, 3086.4752991991413, 3090.675479074665, 3106.3476669899574, 3106.5340198969884, 5571.331440227118, 5579.302587176603, 5583.4137415571595, 5588.524975377139, 5653.152027195872, 5648.491635752802, 5657.12314591239, 5702.372738998707, 5707.74315155819, 5725.570582206351, 5576.665400076008, 5588.972055139699, 5599.804006859659, 5614.073677843192, 5658.236138121301, 5356.57147428197, 5500.1749737539685, 5591.776328946797, 5603.635763675348, 5636.126400407943, 5265.341832270966, 5331.253624492497, 5380.381256155592, 5431.456854314537, 5511.834644960658, 5550.222968784293, 5555.749991250323, 5577.191307260506, 5595.384507704231, 5629.268195134607, 3586.04969683029, 3623.6195199504727, 3655.1227705351057, 3659.3413185625777, 3664.450332450047, 5376.274202982704, 5511.366192887709, 5533.391326953952, 5557.36090349615, 5572.9968605651375, 5351.277577526984, 5425.457454254543, 5455.236266922713, 5470.261514695624, 5541.030319693957, 5394.460553944574, 5414.485623865727, 5420.972895135499, 5429.212764149097, 5482.698451585042, 5306.97346513265, 5311.2829767982375, 5317.202419637086, 5349.144136938071, 5377.381601115765, 5298.894022119459, 5406.2971813665545, 5421.349438067457, 5431.185322201702, 5479.561635069105, 5282.234076059027, 5311.442298558596, 5336.67979921206, 5338.439463856239, 5339.973300133474], "yui.html": [611.1108337369128, 626.7743612299574, 630.360184412821, 637.5505268785506, 639.1595052505951, 11349.319040857554, 11451.427428628576, 11452.885471145286, 11479.0, 11504.309741415522, 11700.707482312946, 12002.099842511825, 12035.518579256819, 12220.38898055098, 12254.326012069332, 590.2356448399312, 597.14011822975, 732.1507051819904, 753.7211231844225, 758.9734359297425, 591.7899145803242, 739.3973911262304, 739.9260073992612, 741.5624781378986, 743.7396911081132, 720.8918662200659, 766.2261116272549, 769.6421164158666, 770.8805135204052, 777.3509119884875, 600.975960961561, 616.2851092732409, 766.31797700047, 766.643510767493, 772.1776308231715, 567.7785663591203, 569.3537834557766, 570.7203470299564, 572.2560671127518, 576.9509591684712, 11302.773944521146, 11653.475593598223, 11823.94088029563, 11852.288862668182, 11881.34652594107, 9805.509724513817, 9820.0, 9835.655752048715, 10162.39025658463, 10180.490975451197, 7625.313721765067, 7671.462997590171, 7709.38324934004, 7952.363810895173, 8016.719414820512, 2727.8090533662653, 2739.205630367191, 2745.437185377013, 2781.1656503049207, 2788.9302767430772, 42887.14225715468, 43271.35092973608, 43568.12863742739, 43571.346429803576, 43963.78018109953, 7811.45319827618, 7886.290233878978, 7926.920730792734, 7980.162082981319, 8065.0, 16753.0, 17110.657786844193, 17149.228284727218, 17150.142492875308, 17235.31058757661, 5811.4479124483105, 5969.850753731104, 6150.985087460608, 6252.280987686383, 6253.249610046823, 3199.2481766784786, 3245.383377158332, 3318.950215746766, 3365.730741540671, 3373.8819141329936, 2398.82008849337, 2431.4407686232266, 2438.2807071913826, 2442.4138206830235, 2444.071252923913, 356.6487010294857, 359.77514053716425, 360.51510718084137, 361.67991327674673, 362.5468164794008, 388.33982230208755, 453.3720796696599, 500.29708259894903, 503.65247978894445, 538.5987439357704, 6148.354422785633, 6387.5209359297305, 6496.155499784998, 6665.066890635315, 6728.752161282756, 363.68695099169264, 376.6365457333686, 466.89494863655403, 490.1324655359993, 518.7354449230919, 3028.318628308613, 3081.306705991134, 3126.796758210709, 3147.3075923296838, 3150.480170771843, 50609.49390506048, 50654.49345506571, 51063.489365105874, 51313.74343128261, 51477.48522514727, 42522.149557008684, 43433.0, 43747.34378984254, 43824.342634860506, 43839.78080109579, 37699.62300376961, 37872.43191352077, 38607.22785544329, 40098.19803603912, 40221.1955760889, 6309.079571212175, 6330.240371155491, 6339.492840572835, 6505.804825855232, 6637.435817955527, 28658.85670571634, 29523.85238073882, 29576.852115739282, 29757.25606859759, 29837.70162298436, 37176.81411593033, 37319.813400933905, 38762.6123738759, 39894.0, 40905.59094409018, 6383.840403989938, 6482.481401487964, 6521.380468855451, 6548.279689234276, 6598.076269322395, 9029.593668284811, 9213.723588292361, 9258.629654814002, 9306.627734890528, 9359.532023398666, 8779.341549383695, 8855.512946787989, 8882.511461869659, 8885.111488851064, 8923.73228803137, 8765.07966663491, 8790.077041910507, 8801.0, 8922.330825188006, 8925.910740892768, 8424.747257582283, 8433.95783021081, 8555.016173140168, 8586.78533036679, 8631.964164300323, 7412.6664300107705, 7802.609869506616, 8020.238077382639, 8071.152528984372, 8077.474964127313, 7413.184549699637, 7484.401247900264, 7758.4181186410115, 7810.867424223342, 7976.680932762624]}, "summary": {"suite": 5687.512312717616, "subtests": {"jquery.html": {"filtered": 7328.905587695124, "value": 7328.905587695124}, "dojo.html": {"filtered": 4394.467969805049, "value": 4394.467969805049}, "mootools.html": {"filtered": 3392.614255131994, "value": 3392.614255131994}, "ext.html": {"filtered": 15202.24872130648, "value": 15202.24872130648}, "prototype.html": {"filtered": 4026.574468544924, "value": 4026.574468544924}, "yui.html": {"filtered": 5060.115624388048, "value": 5060.115624388048}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1446719443, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105005737", "branch": "Fx-Team", "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca"}}, {"talos_counters": {}, "results": {"audio-dft": [192.0, 198.0, 196.0, 197.0, 195.0, 198.0, 195.0, 197.0, 199.0, 197.0], "ai-astar": [123.0, 132.0, 125.0, 134.0, 134.0, 131.0, 123.0, 131.0, 131.0, 120.0], "imaging-gaussian-blur": [141.0, 149.0, 149.0, 142.0, 148.0, 142.0, 142.0, 141.0, 141.0, 135.0], "audio-beat-detection": [192.0, 160.0, 190.0, 205.0, 158.0, 180.0, 178.0, 153.0, 196.0, 161.0], "json-stringify-tinderbox": [77.0, 77.0, 76.0, 82.0, 82.0, 83.0, 81.0, 82.0, 82.0, 82.0], "stanford-crypto-pbkdf2": [180.0, 184.0, 182.0, 183.0, 183.0, 171.0, 181.0, 175.0, 174.0, 183.0], "json-parse-financial": [64.0, 69.0, 70.0, 69.0, 70.0, 70.0, 72.0, 78.0, 69.0, 69.0], "stanford-crypto-sha256-iterative": [77.0, 82.0, 85.0, 84.0, 85.0, 88.0, 85.0, 85.0, 85.0, 85.0], "audio-fft": [85.0, 97.0, 109.0, 104.0, 82.0, 89.0, 89.0, 95.0, 101.0, 82.0], "imaging-darkroom": [155.0, 154.0, 154.0, 154.0, 154.0, 154.0, 153.0, 154.0, 154.0, 154.0], "stanford-crypto-ccm": [149.0, 149.0, 157.0, 168.0, 158.0, 154.0, 155.0, 168.0, 161.0, 152.0], "audio-oscillator": [115.0, 118.0, 163.0, 109.0, 110.0, 110.0, 158.0, 108.0, 109.0, 163.0], "stanford-crypto-aes": [101.0, 106.0, 104.0, 106.0, 106.0, 105.0, 106.0, 105.0, 113.0, 107.0], "imaging-desaturate": [124.0, 124.0, 130.0, 129.0, 123.0, 124.0, 121.0, 125.0, 129.0, 128.0]}, "summary": {"suite": 1821.4999999999998, "subtests": {"audio-fft": {"filtered": 93.3, "value": 93.3}, "stanford-crypto-pbkdf2": {"filtered": 179.6, "value": 179.6}, "audio-beat-detection": {"filtered": 177.3, "value": 177.3}, "stanford-crypto-ccm": {"filtered": 157.1, "value": 157.1}, "imaging-darkroom": {"filtered": 154.0, "value": 154.0}, "json-parse-financial": {"filtered": 70.0, "value": 70.0}, "audio-oscillator": {"filtered": 126.3, "value": 126.3}, "ai-astar": {"filtered": 128.4, "value": 128.4}, "audio-dft": {"filtered": 196.4, "value": 196.4}, "stanford-crypto-sha256-iterative": {"filtered": 84.1, "value": 84.1}, "json-stringify-tinderbox": {"filtered": 80.4, "value": 80.4}, "imaging-gaussian-blur": {"filtered": 143.0, "value": 143.0}, "stanford-crypto-aes": {"filtered": 105.9, "value": 105.9}, "imaging-desaturate": {"filtered": 125.7, "value": 125.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1446719443, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105005737", "branch": "Fx-Team", "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca"}}, {"talos_counters": {}, "results": {"DeltaBlue": [244.2002442002442], "Encrypt": [384.172109104879], "NavierStokes": [6972.222222222223], "Decrypt": [6910.3448275862065], "Splay": [821.1648892534864], "Richards": [208.5070892410342], "RegExp": [38301.88679245283], "Earley": [956.0229445506692], "Boyer": [15952.380952380952], "RayTrace": [2487.5621890547263]}, "summary": {"suite": 14962.144792663654, "subtests": {"DeltaBlue": {"filtered": 270.75321, "value": 270.75321}, "Encrypt": {"filtered": 692.8691430000002, "value": 692.8691430000002}, "NavierStokes": {"filtered": 212.8446215139441, "value": 212.8446215139441}, "Decrypt": {"filtered": 38.51920658682634, "value": 38.51920658682634}, "Splay": {"filtered": 99.23829070929075, "value": 99.23829070929075}, "RegExp": {"filtered": 23.78433743842363, "value": 23.78433743842363}, "Richards": {"filtered": 169.30839199999994, "value": 169.30839199999994}, "Earley": {"filtered": 697.1202979999998, "value": 697.1202979999998}, "Boyer": {"filtered": 41.77827761194028, "value": 41.77827761194028}, "RayTrace": {"filtered": 297.475578, "value": 297.475578}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1446719443, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105005737", "branch": "Fx-Team", "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca"}}] 02:51:01 INFO - RETURN: dromaeo_css: 5687.51 02:51:01 INFO - RETURN: kraken: 1821.50 02:51:01 INFO - RETURN: v8_7: 14962.14 02:51:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "14962.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1821.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5687.51"}}} 02:51:01 INFO - Return code: 0 02:51:01 INFO - # TBPL SUCCESS # 02:51:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:51:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:51:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:51:01 INFO - 2015-11-05 02:51:01.190 screenresolution[2942:36939] starting screenresolution argv=screenresolution get 02:51:01 INFO - 2015-11-05 02:51:01.194 screenresolution[2942:36939] Display 0: 1600x1200x32@60 02:51:01 INFO - 2015-11-05 02:51:01.201 screenresolution[2943:36942] starting screenresolution argv=screenresolution list 02:51:01 INFO - Available Modes on Display 0 02:51:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:51:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:51:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:51:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:51:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:51:01 INFO - Intel HD Graphics 3000: 02:51:01 INFO - Chipset Model: Intel HD Graphics 3000 02:51:01 INFO - Type: GPU 02:51:01 INFO - Bus: Built-In 02:51:01 INFO - VRAM (Total): 512 MB 02:51:01 INFO - VRAM (Dynamic, Max): 10 02:51:01 INFO - Vendor: Intel (0x8086) 02:51:01 INFO - Device ID: 0x0116 02:51:01 INFO - Revision ID: 0x0009 02:51:01 INFO - Displays: 02:51:01 INFO - Display: 02:51:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:51:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:51:01 INFO - Display Serial Number: 1600x1200 60 02:51:01 INFO - Main Display: Yes 02:51:01 INFO - Mirror: Off 02:51:01 INFO - Online: Yes 02:51:01 INFO - Rotation: Supported 02:51:01 INFO - Return code: 0 02:51:01 INFO - Running post-action listener: _resource_record_post_action 02:51:01 INFO - Running post-run listener: _resource_record_post_run 02:51:02 INFO - Total resource usage - Wall time: 1262s; CPU: 30.0%; Read bytes: 20480; Write bytes: 683431936; Read time: 60; Write time: 58668 02:51:02 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 340738560; Write bytes: 335583232; Read time: 37990; Write time: 5918 02:51:02 INFO - run-tests - Wall time: 1219s; CPU: 30.0%; Read bytes: 12288; Write bytes: 337510400; Read time: 12; Write time: 52089 02:51:02 INFO - Running post-run listener: _upload_blobber_files 02:51:02 INFO - Blob upload gear active. 02:51:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:51:02 INFO - Copying logs to upload dir... 02:51:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.834333 ========= master_lag: 1.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-05 02:51:04.020380) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:51:04.024603) ========= 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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010889 build_url: 'https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.29 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:51:04.322883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-05 02:51:04.323233) ========= 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.eHvsjjl4jI/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.XXzPqAEfxg/Listeners TMPDIR=/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/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.005657 ========= master_lag: 3.88 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-05 02:51:08.209167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 02:51:08.209546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 02:51:08.213683) ========= ========= Total master_lag: 5.71 =========