builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0095 starttime: 1448937094.79 results: success (0) buildid: 20151130165432 builduid: d29a931c39ac4b29ae5ee52f33796b82 revision: f6ecc28fba3dda2cb62312b51ca1e305abacd442 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:34.796870) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:34.797685) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:34.798226) ========= 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.LDbbcpRbAv/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.40bAtIXZhN/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.005591 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.114068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.114383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.141014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.141326) ========= 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.LDbbcpRbAv/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.40bAtIXZhN/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.018641 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.190654) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.190954) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.191326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.191624) ========= 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.LDbbcpRbAv/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.40bAtIXZhN/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-30 18:31:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25, :: Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-11-30 18:31:35 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.375955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.376359) ========= 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.LDbbcpRbAv/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.40bAtIXZhN/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.129044 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:35.515556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-30 18:31:35.515875) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6ecc28fba3dda2cb62312b51ca1e305abacd442 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6ecc28fba3dda2cb62312b51ca1e305abacd442 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LDbbcpRbAv/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.40bAtIXZhN/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-30 18:31:35,606 truncating revision to first 12 chars 2015-11-30 18:31:35,607 Setting DEBUG logging. 2015-11-30 18:31:35,607 attempt 1/10 2015-11-30 18:31:35,607 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f6ecc28fba3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-30 18:31:36,824 unpacking tar archive at: mozilla-aurora-f6ecc28fba3d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.501238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-30 18:31:37.030717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:37.031064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:37.040340) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:37.040693) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 18:31:37.041170) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 16 secs) (at 2015-11-30 18:31:37.041531) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LDbbcpRbAv/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.40bAtIXZhN/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 18:31:37 INFO - MultiFileLogger online at 20151130 18:31:37 in /builds/slave/test 18:31:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:31:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:31:37 INFO - {'append_to_log': False, 18:31:37 INFO - 'base_work_dir': '/builds/slave/test', 18:31:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:31:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:31:37 INFO - 'branch': 'Mozilla-Aurora', 18:31:37 INFO - 'buildbot_json_path': 'buildprops.json', 18:31:37 INFO - 'config_files': ('talos/mac_config.py',), 18:31:37 INFO - 'default_actions': ('clobber', 18:31:37 INFO - 'read-buildbot-config', 18:31:37 INFO - 'download-and-extract', 18:31:37 INFO - 'populate-webroot', 18:31:37 INFO - 'create-virtualenv', 18:31:37 INFO - 'install', 18:31:37 INFO - 'run-tests'), 18:31:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:31:37 INFO - 'download_minidump_stackwalk': True, 18:31:37 INFO - 'download_symbols': 'ondemand', 18:31:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:31:37 INFO - 'tooltool.py': '/tools/tooltool.py', 18:31:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:31:37 INFO - '/tools/misc-python/virtualenv.py')}, 18:31:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:31:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:31:37 INFO - 'installer_path': 'installer.exe', 18:31:37 INFO - 'log_level': 'info', 18:31:37 INFO - 'log_name': 'talos', 18:31:37 INFO - 'log_to_console': True, 18:31:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:31:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:31:37 INFO - 'opt_config_files': (), 18:31:37 INFO - 'pip_index': False, 18:31:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:31:37 INFO - 'cmd': ('bash', 18:31:37 INFO - '-c', 18:31:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:31:37 INFO - 'enabled': True, 18:31:37 INFO - 'halt_on_failure': False, 18:31:37 INFO - 'name': 'check_screen_resolution'},), 18:31:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:31:37 INFO - 'cmd': ('bash', 18:31:37 INFO - '-c', 18:31:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:31:37 INFO - 'enabled': True, 18:31:37 INFO - 'halt_on_failure': False, 18:31:37 INFO - 'name': 'check_screen_resolution'},), 18:31:37 INFO - 'run_cmd_checks_enabled': True, 18:31:37 INFO - 'sps_profile': False, 18:31:37 INFO - 'sps_profile_interval': 0, 18:31:37 INFO - 'suite': 'dromaeojs', 18:31:37 INFO - 'system_bits': '64', 18:31:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:31:37 INFO - 'title': 't-yosemite-r5-0095', 18:31:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:31:37 INFO - 'use_talos_json': True, 18:31:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:31:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:31:37 INFO - 'work_dir': 'build'} 18:31:37 INFO - ##### 18:31:37 INFO - ##### Running clobber step. 18:31:37 INFO - ##### 18:31:37 INFO - Running pre-action listener: _resource_record_pre_action 18:31:37 INFO - Running main action method: clobber 18:31:37 INFO - rmtree: /builds/slave/test/build 18:31:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:31:41 INFO - Running post-action listener: _resource_record_post_action 18:31:41 INFO - ##### 18:31:41 INFO - ##### Running read-buildbot-config step. 18:31:41 INFO - ##### 18:31:41 INFO - Running pre-action listener: _resource_record_pre_action 18:31:41 INFO - Running main action method: read_buildbot_config 18:31:41 INFO - Using buildbot properties: 18:31:41 INFO - { 18:31:41 INFO - "properties": { 18:31:41 INFO - "buildnumber": 446, 18:31:41 INFO - "product": "firefox", 18:31:41 INFO - "script_repo_revision": "production", 18:31:41 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 18:31:41 INFO - "repository": "", 18:31:41 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 18:31:41 INFO - "buildid": "20151130165432", 18:31:41 INFO - "slavename": "t-yosemite-r5-0095", 18:31:41 INFO - "pgo_build": "False", 18:31:41 INFO - "basedir": "/builds/slave/test", 18:31:41 INFO - "project": "", 18:31:41 INFO - "platform": "yosemite", 18:31:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:31:41 INFO - "slavebuilddir": "test", 18:31:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:31:41 INFO - "branch": "mozilla-aurora", 18:31:41 INFO - "repo_path": "releases/mozilla-aurora", 18:31:41 INFO - "stage_platform": "macosx64", 18:31:41 INFO - "builduid": "d29a931c39ac4b29ae5ee52f33796b82", 18:31:41 INFO - "revision": "f6ecc28fba3dda2cb62312b51ca1e305abacd442" 18:31:41 INFO - }, 18:31:41 INFO - "sourcestamp": { 18:31:41 INFO - "repository": "", 18:31:41 INFO - "hasPatch": false, 18:31:41 INFO - "project": "", 18:31:41 INFO - "branch": "mozilla-aurora-macosx64-talos", 18:31:41 INFO - "changes": [ 18:31:41 INFO - { 18:31:41 INFO - "category": null, 18:31:41 INFO - "files": [ 18:31:41 INFO - { 18:31:41 INFO - "url": null, 18:31:41 INFO - "name": "https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 18:31:41 INFO - } 18:31:41 INFO - ], 18:31:41 INFO - "repository": "", 18:31:41 INFO - "rev": "f6ecc28fba3dda2cb62312b51ca1e305abacd442", 18:31:41 INFO - "who": "jdaggett@mozilla.com", 18:31:41 INFO - "when": 1448937082, 18:31:41 INFO - "number": 6724418, 18:31:41 INFO - "comments": "Bug 1180560 - enable fontconfig platform fontlist in release builds. r=karlt,cam a=ritu", 18:31:41 INFO - "project": "", 18:31:41 INFO - "at": "Mon 30 Nov 2015 18:31:22", 18:31:41 INFO - "branch": "mozilla-aurora-macosx64-talos", 18:31:41 INFO - "revlink": "", 18:31:41 INFO - "properties": [ 18:31:41 INFO - [ 18:31:41 INFO - "buildid", 18:31:41 INFO - "20151130165432", 18:31:41 INFO - "Change" 18:31:41 INFO - ], 18:31:41 INFO - [ 18:31:41 INFO - "builduid", 18:31:41 INFO - "d29a931c39ac4b29ae5ee52f33796b82", 18:31:41 INFO - "Change" 18:31:41 INFO - ], 18:31:41 INFO - [ 18:31:41 INFO - "pgo_build", 18:31:41 INFO - "False", 18:31:41 INFO - "Change" 18:31:41 INFO - ] 18:31:41 INFO - ], 18:31:41 INFO - "revision": "f6ecc28fba3dda2cb62312b51ca1e305abacd442" 18:31:41 INFO - } 18:31:41 INFO - ], 18:31:41 INFO - "revision": "f6ecc28fba3dda2cb62312b51ca1e305abacd442" 18:31:41 INFO - } 18:31:41 INFO - } 18:31:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 18:31:41 INFO - Running post-action listener: _resource_record_post_action 18:31:41 INFO - ##### 18:31:41 INFO - ##### Running download-and-extract step. 18:31:41 INFO - ##### 18:31:41 INFO - Running pre-action listener: _resource_record_pre_action 18:31:41 INFO - Running main action method: download_and_extract 18:31:41 INFO - mkdir: /builds/slave/test/build/tests 18:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:41 INFO - https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/test_packages.json 18:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/test_packages.json 18:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:31:43 INFO - Downloaded 1149 bytes. 18:31:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:31:43 INFO - Using the following test package requirements: 18:31:43 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 18:31:43 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:31:43 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 18:31:43 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:31:43 INFO - u'jsshell-mac.zip'], 18:31:43 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:31:43 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 18:31:43 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 18:31:43 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:31:43 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 18:31:43 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:31:43 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 18:31:43 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:31:43 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 18:31:43 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 18:31:43 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 18:31:43 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 18:31:43 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:43 INFO - https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:31:46 INFO - Downloaded 17490182 bytes. 18:31:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:31:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:31:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 18:31:52 INFO - Return code: 0 18:31:52 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:31: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')]} 18:31:52 INFO - https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:31:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:31:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:31:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:31:54 INFO - Downloaded 17490182 bytes. 18:31:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:31:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 18:31:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 18:32:01 INFO - Return code: 0 18:32:01 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')]} 18:32:01 INFO - https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:32:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 18:32:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 18:32:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 18:32:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:32:02 INFO - Downloaded 11131307 bytes. 18:32:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 18:32:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 18:32:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:32:02 INFO - Return code: 0 18:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:02 INFO - https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 18:32:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 18:32:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 18:32:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 18:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 18:32:06 INFO - Downloaded 107830551 bytes. 18:32:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 18:32:06 INFO - mkdir: /builds/slave/test/properties 18:32:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:32:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:32:06 INFO - Contents: 18:32:06 INFO - build_url:https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 18:32:06 INFO - Running post-action listener: _resource_record_post_action 18:32:06 INFO - Running post-action listener: set_extra_try_arguments 18:32:06 INFO - ##### 18:32:06 INFO - ##### Running populate-webroot step. 18:32:06 INFO - ##### 18:32:06 INFO - Running pre-action listener: _resource_record_pre_action 18:32:06 INFO - Running main action method: populate_webroot 18:32:06 INFO - Guessing talos json url... 18:32: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')]} 18:32:06 INFO - https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 18:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 18:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 18:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 18:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 18:32:07 INFO - Downloaded 107 bytes. 18:32:07 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 18:32:07 INFO - Contents: 18:32:07 INFO - 20151130165432 18:32:07 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/f6ecc28fba3dda2cb62312b51ca1e305abacd442 18:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:07 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/f6ecc28fba/testing/talos/talos.json 18:32:07 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/f6ecc28fba/testing/talos/talos.json to /builds/slave/test/build/talos.json 18:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/f6ecc28fba/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 18:32:10 INFO - Downloaded 4264 bytes. 18:32:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:32:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:32:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:32:10 INFO - '../fennec_ids.txt'], 18:32:10 INFO - 'tests': ['tcheck2']}, 18:32:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:32:10 INFO - '--tppagecycles', 18:32:10 INFO - '7'], 18:32:10 INFO - 'tests': ['tsvgm']}}, 18:32:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:32:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:32:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:32:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:32:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:32:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:10 INFO - 'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:32:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:10 INFO - 'tests': ['damp', 'tps']}, 18:32:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:10 INFO - 'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['damp', 'tps']}, 18:32:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:32:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:32:10 INFO - 'other': {'tests': ['a11yr', 18:32:10 INFO - 'ts_paint', 18:32:10 INFO - 'tpaint', 18:32:10 INFO - 'sessionrestore', 18:32:10 INFO - 'sessionrestore_no_auto_restore']}, 18:32:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['a11yr', 18:32:10 INFO - 'ts_paint', 18:32:10 INFO - 'tpaint', 18:32:10 INFO - 'sessionrestore', 18:32:10 INFO - 'sessionrestore_no_auto_restore']}, 18:32:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['a11yr', 18:32:10 INFO - 'ts_paint', 18:32:10 INFO - 'tpaint', 18:32:10 INFO - 'sessionrestore', 18:32:10 INFO - 'sessionrestore_no_auto_restore']}, 18:32:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['a11yr', 18:32:10 INFO - 'ts_paint', 18:32:10 INFO - 'tpaint', 18:32:10 INFO - 'sessionrestore', 18:32:10 INFO - 'sessionrestore_no_auto_restore']}, 18:32:10 INFO - 'other_l64': {'tests': ['a11yr', 18:32:10 INFO - 'ts_paint', 18:32:10 INFO - 'tpaint', 18:32:10 INFO - 'sessionrestore', 18:32:10 INFO - 'sessionrestore_no_auto_restore']}, 18:32:10 INFO - 'other_nol64': {'tests': ['a11yr', 18:32:10 INFO - 'ts_paint', 18:32:10 INFO - 'tpaint', 18:32:10 INFO - 'sessionrestore', 18:32:10 INFO - 'sessionrestore_no_auto_restore']}, 18:32:10 INFO - 'svgr': {'tests': ['tsvgx', 18:32:10 INFO - 'tsvgr_opacity', 18:32:10 INFO - 'tart', 18:32:10 INFO - 'tscrollx', 18:32:10 INFO - 'cart']}, 18:32:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['tsvgx', 18:32:10 INFO - 'tsvgr_opacity', 18:32:10 INFO - 'tart', 18:32:10 INFO - 'tscrollx', 18:32:10 INFO - 'cart']}, 18:32:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:10 INFO - 'tests': ['tp5o']}, 18:32:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:10 INFO - 'talos_options': ['--e10s'], 18:32:10 INFO - 'tests': ['tp5o']}, 18:32:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:10 INFO - 'talos_options': ['--xperf_path', 18:32:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:32:10 INFO - 'tests': ['tp5n']}, 18:32:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:10 INFO - 'talos_options': ['--e10s', 18:32:10 INFO - '--xperf_path', 18:32:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 18:32:10 INFO - 'C:/slave/talos-data/talos/xperf.config'], 18:32:10 INFO - 'tests': ['tp5n']}}, 18:32:10 INFO - 'talos.zip': {'path': '', 18:32:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:32:10 INFO - Running post-action listener: _resource_record_post_action 18:32:10 INFO - ##### 18:32:10 INFO - ##### Running create-virtualenv step. 18:32:10 INFO - ##### 18:32:10 INFO - Running pre-action listener: _resource_record_pre_action 18:32:10 INFO - Running main action method: create_virtualenv 18:32:10 INFO - Creating virtualenv /builds/slave/test/build/venv 18:32:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:32:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:32:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:32:10 INFO - Using real prefix '/tools/python27' 18:32:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:32:11 INFO - Installing distribute.............................................................................................................................................................................................done. 18:32:15 INFO - Installing pip.................done. 18:32:15 INFO - Return code: 0 18:32:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:32:15 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')]} 18:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:15 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')]} 18:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:15 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 0x10b9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc94d6e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9749f0>, '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 0x10b6d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b93e990>, '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.LDbbcpRbAv/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.40bAtIXZhN/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 18:32:15 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 18:32:15 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 18:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDbbcpRbAv/Render', 18:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:15 INFO - 'HOME': '/Users/cltbld', 18:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:15 INFO - 'LOGNAME': 'cltbld', 18:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:15 INFO - 'MOZ_NO_REMOTE': '1', 18:32:15 INFO - 'NO_EM_RESTART': '1', 18:32:15 INFO - 'PAGER': '/bin/cat', 18:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:15 INFO - 'PWD': '/builds/slave/test', 18:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:15 INFO - 'SHELL': '/bin/bash', 18:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40bAtIXZhN/Listeners', 18:32:15 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 18:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:15 INFO - 'USER': 'cltbld', 18:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:15 INFO - 'XPC_FLAGS': '0x0', 18:32:15 INFO - 'XPC_SERVICE_NAME': '0', 18:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:32:16 INFO - Cleaning up... 18:32:16 INFO - Return code: 0 18:32:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc94d6e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9749f0>, '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 0x10b6d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b93e990>, '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.LDbbcpRbAv/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.40bAtIXZhN/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 18:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDbbcpRbAv/Render', 18:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:16 INFO - 'HOME': '/Users/cltbld', 18:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:16 INFO - 'LOGNAME': 'cltbld', 18:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:16 INFO - 'MOZ_NO_REMOTE': '1', 18:32:16 INFO - 'NO_EM_RESTART': '1', 18:32:16 INFO - 'PAGER': '/bin/cat', 18:32:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:16 INFO - 'PWD': '/builds/slave/test', 18:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:16 INFO - 'SHELL': '/bin/bash', 18:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40bAtIXZhN/Listeners', 18:32:16 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 18:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:16 INFO - 'USER': 'cltbld', 18:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:16 INFO - 'XPC_FLAGS': '0x0', 18:32:16 INFO - 'XPC_SERVICE_NAME': '0', 18:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:16 INFO - Downloading/unpacking psutil>=0.7.1 18:32:16 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 18:32:16 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 18:32:16 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 18:32:16 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 18:32:16 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 18:32:16 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 18:32:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:32:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:32:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:32:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:32:19 INFO - Installing collected packages: psutil 18:32:19 INFO - Running setup.py install for psutil 18:32:20 INFO - building 'psutil._psutil_osx' extension 18:32:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:32:21 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 18:32:22 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 18:32:22 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 18:32:22 INFO - building 'psutil._psutil_posix' extension 18:32:22 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 18:32:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:32:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:32:22 INFO - ^ 18:32:22 INFO - 1 warning generated. 18:32:22 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 18:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:32:22 INFO - Successfully installed psutil 18:32:22 INFO - Cleaning up... 18:32:22 INFO - Return code: 0 18:32:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:32: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')]} 18:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32: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')]} 18:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:22 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 0x10b9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc94d6e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9749f0>, '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 0x10b6d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b93e990>, '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.LDbbcpRbAv/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.40bAtIXZhN/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 18:32:22 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 18:32:22 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 18:32:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDbbcpRbAv/Render', 18:32:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:22 INFO - 'HOME': '/Users/cltbld', 18:32:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:22 INFO - 'LOGNAME': 'cltbld', 18:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:22 INFO - 'MOZ_NO_REMOTE': '1', 18:32:22 INFO - 'NO_EM_RESTART': '1', 18:32:22 INFO - 'PAGER': '/bin/cat', 18:32:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:22 INFO - 'PWD': '/builds/slave/test', 18:32:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:22 INFO - 'SHELL': '/bin/bash', 18:32:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40bAtIXZhN/Listeners', 18:32:22 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 18:32:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:22 INFO - 'USER': 'cltbld', 18:32:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:22 INFO - 'XPC_FLAGS': '0x0', 18:32:22 INFO - 'XPC_SERVICE_NAME': '0', 18:32:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:32:23 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 18:32:23 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 18:32:23 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 18:32:23 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 18:32:23 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 18:32:23 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 18:32:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:32:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:32:26 INFO - Installing collected packages: mozsystemmonitor 18:32:26 INFO - Running setup.py install for mozsystemmonitor 18:32:26 INFO - Successfully installed mozsystemmonitor 18:32:26 INFO - Cleaning up... 18:32:26 INFO - Return code: 0 18:32:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10b9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc94d6e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9749f0>, '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 0x10b6d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b93e990>, '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.LDbbcpRbAv/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.40bAtIXZhN/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 18:32:26 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 18:32:26 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 18:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDbbcpRbAv/Render', 18:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:26 INFO - 'HOME': '/Users/cltbld', 18:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:26 INFO - 'LOGNAME': 'cltbld', 18:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:26 INFO - 'MOZ_NO_REMOTE': '1', 18:32:26 INFO - 'NO_EM_RESTART': '1', 18:32:26 INFO - 'PAGER': '/bin/cat', 18:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:26 INFO - 'PWD': '/builds/slave/test', 18:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:26 INFO - 'SHELL': '/bin/bash', 18:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40bAtIXZhN/Listeners', 18:32:26 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 18:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:26 INFO - 'USER': 'cltbld', 18:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:26 INFO - 'XPC_FLAGS': '0x0', 18:32:26 INFO - 'XPC_SERVICE_NAME': '0', 18:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:26 INFO - Downloading/unpacking blobuploader==1.2.4 18:32:26 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 18:32:26 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 18:32:26 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 18:32:26 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 18:32:26 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 18:32:26 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 18:32:29 INFO - Downloading blobuploader-1.2.4.tar.gz 18:32:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:32:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:32:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:32:30 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 18:32:30 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 18:32:30 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 18:32:30 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 18:32:30 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 18:32:30 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 18:32:30 INFO - Downloading docopt-0.6.1.tar.gz 18:32:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:32:31 INFO - Installing collected packages: blobuploader, requests, docopt 18:32:31 INFO - Running setup.py install for blobuploader 18:32:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:32:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:32:31 INFO - Running setup.py install for requests 18:32:31 INFO - Running setup.py install for docopt 18:32:32 INFO - Successfully installed blobuploader requests docopt 18:32:32 INFO - Cleaning up... 18:32:32 INFO - Return code: 0 18:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:32 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 0x10b9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc94d6e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9749f0>, '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 0x10b6d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b93e990>, '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.LDbbcpRbAv/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.40bAtIXZhN/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 18:32:32 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 18:32:32 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 18:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDbbcpRbAv/Render', 18:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:32 INFO - 'HOME': '/Users/cltbld', 18:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:32 INFO - 'LOGNAME': 'cltbld', 18:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:32 INFO - 'MOZ_NO_REMOTE': '1', 18:32:32 INFO - 'NO_EM_RESTART': '1', 18:32:32 INFO - 'PAGER': '/bin/cat', 18:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:32 INFO - 'PWD': '/builds/slave/test', 18:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:32 INFO - 'SHELL': '/bin/bash', 18:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40bAtIXZhN/Listeners', 18:32:32 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 18:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:32 INFO - 'USER': 'cltbld', 18:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:32 INFO - 'XPC_FLAGS': '0x0', 18:32:32 INFO - 'XPC_SERVICE_NAME': '0', 18:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:32:32 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-nB2oxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:32:32 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-TMTbuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:32:32 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-etKme1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:32:32 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-pF1yfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:32:33 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-K6J493-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:32:33 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-fHA4Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:32:33 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-h5Yokf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:32:33 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-Ed1r8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:32:33 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-FKVNvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:32:33 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-zEfgYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:32:33 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-wYd5Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:32:34 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-jW2xZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:32:34 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-wyXHeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:32:34 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-ACSRwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:34 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-f7Jkf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:32:34 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-ROBEfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:32:34 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-5vGuTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:32:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:32:34 INFO - Running setup.py install for manifestparser 18:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:32:35 INFO - Running setup.py install for mozcrash 18:32:35 INFO - Running setup.py install for mozdebug 18:32:35 INFO - Running setup.py install for mozdevice 18:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:32:35 INFO - Running setup.py install for mozfile 18:32:35 INFO - Running setup.py install for mozhttpd 18:32:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:32:36 INFO - Running setup.py install for mozinfo 18:32:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:32:36 INFO - Running setup.py install for mozInstall 18:32:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:32:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:32:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:32:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:32:36 INFO - Running setup.py install for mozleak 18:32:36 INFO - Running setup.py install for mozlog 18:32:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:32:36 INFO - Running setup.py install for moznetwork 18:32:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:32:37 INFO - Running setup.py install for mozprocess 18:32:37 INFO - Running setup.py install for mozprofile 18:32:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:32:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:32:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:32:37 INFO - Running setup.py install for mozrunner 18:32:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:32:37 INFO - Running setup.py install for mozscreenshot 18:32:38 INFO - Running setup.py install for moztest 18:32:38 INFO - Running setup.py install for mozversion 18:32:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:32:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:32:38 INFO - Cleaning up... 18:32:38 INFO - Return code: 0 18:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:38 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')]} 18:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:38 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')]} 18:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:38 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 0x10b9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc94d6e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9749f0>, '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 0x10b6d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b93e990>, '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.LDbbcpRbAv/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.40bAtIXZhN/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 18:32:38 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 18:32:38 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 18:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDbbcpRbAv/Render', 18:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:38 INFO - 'HOME': '/Users/cltbld', 18:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:38 INFO - 'LOGNAME': 'cltbld', 18:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:38 INFO - 'MOZ_NO_REMOTE': '1', 18:32:38 INFO - 'NO_EM_RESTART': '1', 18:32:38 INFO - 'PAGER': '/bin/cat', 18:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:38 INFO - 'PWD': '/builds/slave/test', 18:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:38 INFO - 'SHELL': '/bin/bash', 18:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40bAtIXZhN/Listeners', 18:32:38 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 18:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:38 INFO - 'USER': 'cltbld', 18:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:38 INFO - 'XPC_FLAGS': '0x0', 18:32:38 INFO - 'XPC_SERVICE_NAME': '0', 18:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:32:38 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-dgdQ1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:32:38 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)) 18:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:32:38 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-k0ByES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:32:39 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)) 18:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:32:39 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-p2ujkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:32:39 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)) 18:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:32:39 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-hDPdVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:32:39 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-64GsZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:32:39 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)) 18:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:32:39 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-nWRdE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:32:39 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)) 18:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:32:39 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-08rnt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:32:39 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-SN44We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:32:39 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)) 18:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:32:39 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-tYoM_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:32:40 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)) 18:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:32:40 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-M7QFgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:32:40 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)) 18:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:32:40 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-c9JGmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:32:40 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)) 18:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:32:40 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-JKBAvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:32:40 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)) 18:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:32:40 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-zKvcpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:32:40 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)) 18:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:32:40 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-gg6Svz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:32:40 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)) 18:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:40 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-MyftJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:40 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)) 18:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:32:40 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-Ey1xQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:32:41 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)) 18:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:32:41 INFO - Running setup.py (path:/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/pip-VaQsfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:32:41 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)) 18:32:41 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)) 18:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:32:41 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)) 18:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:32:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:32: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 18:32: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 18:32: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 18:32: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 18:32: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 18:32: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 18:32:43 INFO - Downloading blessings-1.5.1.tar.gz 18:32:44 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 18:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:32:44 INFO - Installing collected packages: blessings 18:32:44 INFO - Running setup.py install for blessings 18:32:44 INFO - Successfully installed blessings 18:32:44 INFO - Cleaning up... 18:32:44 INFO - Return code: 0 18:32:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:44 INFO - Reading from file tmpfile_stdout 18:32:44 INFO - Current package versions: 18:32:44 INFO - blessings == 1.5.1 18:32:44 INFO - blobuploader == 1.2.4 18:32:44 INFO - docopt == 0.6.1 18:32:44 INFO - manifestparser == 1.1 18:32:44 INFO - mozInstall == 1.12 18:32:44 INFO - mozcrash == 0.16 18:32:44 INFO - mozdebug == 0.1 18:32:44 INFO - mozdevice == 0.46 18:32:44 INFO - mozfile == 1.2 18:32:44 INFO - mozhttpd == 0.7 18:32:44 INFO - mozinfo == 0.8 18:32:44 INFO - mozleak == 0.1 18:32:44 INFO - mozlog == 3.0 18:32:44 INFO - moznetwork == 0.27 18:32:44 INFO - mozprocess == 0.22 18:32:44 INFO - mozprofile == 0.27 18:32:44 INFO - mozrunner == 6.11 18:32:44 INFO - mozscreenshot == 0.1 18:32:44 INFO - mozsystemmonitor == 0.0 18:32:44 INFO - moztest == 0.7 18:32:44 INFO - mozversion == 1.4 18:32:44 INFO - psutil == 3.1.1 18:32:44 INFO - requests == 1.2.3 18:32:44 INFO - wsgiref == 0.1.2 18:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:44 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')]} 18:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:44 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')]} 18:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:44 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 0x10b9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba2c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc94d6e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9749f0>, '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 0x10b6d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b93e990>, '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.LDbbcpRbAv/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.40bAtIXZhN/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 18:32:44 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 18:32:44 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 18:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDbbcpRbAv/Render', 18:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:44 INFO - 'HOME': '/Users/cltbld', 18:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:44 INFO - 'LOGNAME': 'cltbld', 18:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:44 INFO - 'MOZ_NO_REMOTE': '1', 18:32:44 INFO - 'NO_EM_RESTART': '1', 18:32:44 INFO - 'PAGER': '/bin/cat', 18:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:44 INFO - 'PWD': '/builds/slave/test', 18:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:44 INFO - 'SHELL': '/bin/bash', 18:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40bAtIXZhN/Listeners', 18:32:44 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 18:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:44 INFO - 'USER': 'cltbld', 18:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:44 INFO - 'XPC_FLAGS': '0x0', 18:32:44 INFO - 'XPC_SERVICE_NAME': '0', 18:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 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)) 18:32:45 INFO - Cleaning up... 18:32:45 INFO - Return code: 0 18:32:45 INFO - Running post-action listener: _resource_record_post_action 18:32:45 INFO - Running post-action listener: _start_resource_monitoring 18:32:45 INFO - Starting resource monitoring. 18:32:45 INFO - ##### 18:32:45 INFO - ##### Running install step. 18:32:45 INFO - ##### 18:32:45 INFO - Running pre-action listener: _resource_record_pre_action 18:32:45 INFO - Running main action method: install 18:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:45 INFO - Reading from file tmpfile_stdout 18:32:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:32:45 INFO - Reading from file tmpfile_stdout 18:32:45 INFO - Output received: 18:32:45 INFO - Usage: mozinstall [options] installer 18:32:45 INFO - Options: 18:32:45 INFO - -h, --help show this help message and exit 18:32:45 INFO - -d DEST, --destination=DEST 18:32:45 INFO - Directory to install application into. [default: 18:32:45 INFO - "/builds/slave/test"] 18:32:45 INFO - --app=APP Application being installed. [default: firefox] 18:32:45 INFO - mkdir: /builds/slave/test/build/application 18:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:33:28 INFO - Reading from file tmpfile_stdout 18:33:28 INFO - Output received: 18:33:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:33:28 INFO - Running post-action listener: _resource_record_post_action 18:33:28 INFO - ##### 18:33:28 INFO - ##### Running run-tests step. 18:33:28 INFO - ##### 18:33:28 INFO - Running pre-action listener: _resource_record_pre_action 18:33:28 INFO - Running main action method: run_tests 18:33:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:33:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:33:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:33:28 INFO - 2015-11-30 18:33:28.618 screenresolution[1628:7791] starting screenresolution argv=screenresolution get 18:33:28 INFO - 2015-11-30 18:33:28.622 screenresolution[1628:7791] Display 0: 1600x1200x32@60 18:33:28 INFO - 2015-11-30 18:33:28.629 screenresolution[1629:7793] starting screenresolution argv=screenresolution list 18:33:28 INFO - Available Modes on Display 0 18:33:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:33:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:33:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:33:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:33:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:33:28 INFO - Intel HD Graphics 3000: 18:33:28 INFO - Chipset Model: Intel HD Graphics 3000 18:33:28 INFO - Type: GPU 18:33:28 INFO - Bus: Built-In 18:33:28 INFO - VRAM (Total): 512 MB 18:33:28 INFO - VRAM (Dynamic, Max): 10 18:33:28 INFO - Vendor: Intel (0x8086) 18:33:28 INFO - Device ID: 0x0116 18:33:28 INFO - Revision ID: 0x0009 18:33:28 INFO - Displays: 18:33:28 INFO - Display: 18:33:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:33:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:33:28 INFO - Display Serial Number: 1600x1200 60 18:33:28 INFO - Main Display: Yes 18:33:28 INFO - Mirror: Off 18:33:28 INFO - Online: Yes 18:33:28 INFO - Rotation: Supported 18:33:28 INFO - Return code: 0 18:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:33:28 INFO - Python 2.7.3 18:33:28 INFO - Return code: 0 18:33:28 INFO - grabbing minidump binary from tooltool 18:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:28 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 0x10b9749f0>, '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 0x10b6d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b93e990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:33:28 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 18:33:28 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 18:33:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:33:29 INFO - Return code: 0 18:33:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:33:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:33:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:33:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:33:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0095', '--webServer', 'localhost'] in /builds/slave/test/build 18:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0095 --webServer localhost 18:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDbbcpRbAv/Render', 18:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:29 INFO - 'HOME': '/Users/cltbld', 18:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:29 INFO - 'LOGNAME': 'cltbld', 18:33:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:33:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:29 INFO - 'MOZ_NO_REMOTE': '1', 18:33:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:33:29 INFO - 'NO_EM_RESTART': '1', 18:33:29 INFO - 'PAGER': '/bin/cat', 18:33:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:29 INFO - 'PWD': '/builds/slave/test', 18:33:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:29 INFO - 'SHELL': '/bin/bash', 18:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40bAtIXZhN/Listeners', 18:33:29 INFO - 'TMPDIR': '/var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/', 18:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:29 INFO - 'USER': 'cltbld', 18:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:29 INFO - 'XPC_FLAGS': '0x0', 18:33:29 INFO - 'XPC_SERVICE_NAME': '0', 18:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:33:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0095', '--webServer', 'localhost'] with output_timeout 3600 18:33:29 INFO - mozversion INFO | application_buildid: 20151130165432 18:33:29 INFO - mozversion INFO | application_changeset: f6ecc28fba3dda2cb62312b51ca1e305abacd442 18:33:29 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 18:33:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:33:29 INFO - mozversion INFO | application_name: Firefox 18:33:29 INFO - mozversion INFO | application_remotingname: firefox-dev 18:33:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:33:29 INFO - mozversion INFO | application_vendor: Mozilla 18:33:29 INFO - mozversion INFO | application_version: 44.0a2 18:33:29 INFO - mozversion INFO | platform_buildid: 20151130165432 18:33:29 INFO - mozversion INFO | platform_changeset: f6ecc28fba3dda2cb62312b51ca1e305abacd442 18:33:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:33:29 INFO - mozversion INFO | platform_version: 44.0a2 18:33:29 INFO - 2015-11-30 18:33:29,385 DEBUG : using testdate: 1448937209 18:33:29 INFO - 2015-11-30 18:33:29,385 DEBUG : actual date: 1448937209 18:33:29 INFO - 2015-11-30 18:33:29,395 INFO : starting webserver on 'localhost:49265' 18:33:29 INFO - 2015-11-30 18:33:29,396 INFO : Starting test suite t-yosemite-r5-0095 18:33:29 INFO - 2015-11-30 18:33:29,396 INFO : Starting test dromaeo_css 18:33:29 INFO - 2015-11-30 18:33:29,396 DEBUG : operating with platform_type : mac_ 18:33:29 INFO - 2015-11-30 18:33:29,397 INFO : Initialising browser for dromaeo_css test... 18:33:29 INFO - 2015-11-30 18:33:29,433 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpYKLTOC/profile http://localhost:49265/getInfo.html 18:33:32 INFO - 2015-11-30 18:33:32,569 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:33:32 INFO - 2015-11-30 18:33:32,569 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:33:32 INFO - 2015-11-30 18:33:32,569 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:33:32 INFO - 2015-11-30 18:33:32,569 DEBUG : BROWSER_OUTPUT: __metrics 18:33:32 INFO - 2015-11-30 18:33:32,587 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:33:33 INFO - 2015-11-30 18:33:33,388 INFO : Browser initialized. 18:33:33 INFO - 2015-11-30 18:33:33,389 INFO : Running cycle 1/1 for dromaeo_css test... 18:33:33 INFO - 2015-11-30 18:33:33,389 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpYKLTOC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:33:45 INFO - 2015-11-30 18:33:45,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 199573504 18:33:45 INFO - 2015-11-30 18:33:45,526 DEBUG : BROWSER_OUTPUT: 18:34:37 INFO - 2015-11-30 18:34:37,404 DEBUG : BROWSER_OUTPUT: 1448937277400 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] 18:36:47 INFO - 2015-11-30 18:36:47,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 18:36:49 INFO - 2015-11-30 18:36:49,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 319406080 18:36:49 INFO - 2015-11-30 18:36:49,128 DEBUG : BROWSER_OUTPUT: 18:39:51 INFO - 2015-11-30 18:39:51,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 18:39:52 INFO - 2015-11-30 18:39:52,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 335347712 18:39:52 INFO - 2015-11-30 18:39:52,526 DEBUG : BROWSER_OUTPUT: 18:42:55 INFO - 2015-11-30 18:42:55,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 18:42:55 INFO - 2015-11-30 18:42:55,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 305766400 18:42:55 INFO - 2015-11-30 18:42:55,628 DEBUG : BROWSER_OUTPUT: 18:45:57 INFO - 2015-11-30 18:45:57,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 18:45:58 INFO - 2015-11-30 18:45:58,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 301195264 18:45:58 INFO - 2015-11-30 18:45:58,364 DEBUG : BROWSER_OUTPUT: 18:49:01 INFO - 2015-11-30 18:49:01,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 18:49:02 INFO - 2015-11-30 18:49:02,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 301346816 18:49:02 INFO - 2015-11-30 18:49:02,188 DEBUG : BROWSER_OUTPUT: 18:52:04 INFO - 2015-11-30 18:52:04,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 18:52:05 INFO - 2015-11-30 18:52:05,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 350171136 18:52:05 INFO - 2015-11-30 18:52:05,244 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,245 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:52:05 INFO - 2015-11-30 18:52:05,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:52:05 INFO - 2015-11-30 18:52:05,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:52:05 INFO - 2015-11-30 18:52:05,246 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:52:05 INFO - 2015-11-30 18:52:05,248 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2595.9610605840912;2701.405690748035;2728.208819442362;2734.152412752047;2744.6706395232563;4412.867613971578;4479.865604031885;4511.8646440606835;4530.184566777979;4563.087382523496;4482.125985432834;4526.886827829306;4536.8638940831825;4550.158220729159;4580.793864276107;4171.749695018309;4197.580241975808;4214.4099826024385;4234.110836724291;4264.957350426487;4146.087860670663;4165.12532368203;4213.494380674323;4319.265724826787;4380.540043295456;4274.593913578221;4386.166628340605;4405.229084910144;4454.97772511137;4496.460424749019;4077.918441631151;4340.08858139791;4341.435613370241;4381.474223093217;4432.357308190327;3951.170254246612;4164.875053748392;4198.076423186894;4244.405783190356;4249.4475718156755;4435.445569303837;4435.512093669694;4482.820687172509;4489.592172914684;4496.955030449719;4785.497522760095;4810.278458231258;4819.542143496362;4843.636727245471;4846.660733748639;4798.304245884362;4798.496157903405;4812.1578723723205;4820.517948205152;4884.438289596706;4477.306017567283;4489.349044388546;4536.410266665345;4546.113507865967;4555.180067587866;4932.4081110267;4999.350084489066;5010.298558201855;5014.89970200594;5028.170351891897;4529.388532548064;4625.028743963738;4712.552307530779;4723.149833030019;4770.045990801854;4797.112534181188;4817.78319975602;4862.6839255448995;4867.9269810952865;5032.672876263031;4731.4795372509;4763.095011947788;4794.089123066607;4811.879703007453;4843.8304659337455;4499.955000450019;4609.124266389375;4686.671932964659;4698.389209402756;4829.420469543677;3666.395044817629;3678.8528458861883;3710.925781484409;3714.312852122366;3768.510093687858;3351.8994430167136;3369.4945758135987;3423.4693622488553;3438.6561343865915;3448.8620455181513;4610.216263235258;4628.375169352162;4686.27362758773;4691.554302341272;4726.456457507362;4631;4652.697574657636;4742.19382704941;4931;4999.400071991312;4522.163399771053;4534.410526631583;4579.107074120581;4604.1712491751805;4615.469221039556;4247.320428731388;4251.617354438115;4253.595908388698;4256.29771087767;4340.283853164256;4816.15717249487;4824.614030877591;4860.441049279378;4971.477994810492;5043.823466178666;4852.2479015752615;4886.731229782396;4933.580645645016;4973.875653108701;4991.450940396626;4922.458529561817;4927.162382394929;4966.8758281043265;4993.875153121201;5003.124453220599;4571;4679.789409476513;4766.356541866804;4779.976100119477;4806.279058141306;4848.272759086024;4879.219324907997;4906.1659517881335;4931.235658472942;4958.281049247911;4735.668503204743;4761.309610106446;4800;4816.54242846929;4822.324874517501;4534.614557762628;4663.790129444251;4732.408448943882;4733.502982186821;4859.173940430064;4527.162474942146;4724.976375118103;4752.5485078917445;4753.453352864465;4828.95171048285;4856.63575231852;4867.075255701406;4870.878228044327;4915.311856340187;4917.606591472602;4524.04994951064;4568.1548913451115;4596.8161273548685;4607.677462577587;4647.512011238771 18:52:05 INFO - 2015-11-30 18:52:05,251 DEBUG : BROWSER_OUTPUT: |1;ext.html;475.40574282147315;481.98072077116916;488.7311978411874;491.4643039087396;515.7421289355323;27408.177754667366;28413.57379639307;34063.829680851624;34759.4786078209;34874;36553.81723091381;37012.25975480495;37160.814195928986;37512.62487375126;37809.43285850714;7173.067501224859;7568.167501574822;7735.30382265596;7756.340711039568;7816.921830781705;7278.344948954593;9176.770580735469;9210.401323913924;9244.121808428188;9358.766030849216;9160.6793762218;9169.083091690844;9261.490618016007;9315.580798864034;9316.813663726754;7196.820079498002;7467.514611550286;9057.411268267542;9168;9262.814743705156;9051.094890510962;9084.182423581844;9115.541513357897;9145.542722863831;9147.725568232963;34192.658073419196;34594.308113837586;35091.12272193216;35127.82436087803;35203.64796352055;2485.614729716897;2522.9505996729413;2867.283179205199;2899.492588796973;2997.265669910864;23293.76706232933;23835.523289534285;23919.52160956771;24634.260972170865;24651.137210197736;1974.5162435203324;2001.9699704504299;2008.4275981345247;2018.1019446346381;2047.0992763184151;212718.93640531853;213377;213624;213968;214089;48538.5146148534;49318;52923;53393;58389.70805146032;53534.464655353724;53816.73091634595;54995.175072373946;55082.72458637681;55239.72380138074;14043.1574105554;14225.14649121056;14230.573082807325;14315.355808988621;14356;11418.143639226924;11514;11533.884661153448;11542.653720388234;11551.595694150665;16755.329786808634;16978.660426791394;17206.397776077778;17371.652566948844;17384.130793460277;6945.40964018054;7073.858522829514;7103.751368702174;7143.571385716874;7147.178074521393;746.4588173574115;807.7132617920554;880.3617377401333;941.5574679900436;970.2092794372705;23958.401039974142;24461.266162015167;24628.507429851303;24709.258722238363;24793.380165495648;819.2790344496924;896.9057749545544;899.7840518275567;912.0970239462883;918.169057003413;11348.489317980711;11848.88151118495;11884.584039558575;12029.218100823418;12053.879461205452;293938;302441;304619;304752;310765;40229.597704023174;41314.586854131674;45914.540854591025;46425.53574464212;46592.534074659496;1180.2682336951145;1208.7884620191608;1210.2073142091945;1210.2496452199694;1217.31221859649;20782.27262045821;23448.882755586113;23961.52076958486;24999.375015624755;25172.993080276585;43581.564184357754;44914;45320;45640.771796140805;45758.313625296316;169587.15206423888;169959;170568.1471592634;170697;172447;27012.59481107824;27043.053493127645;27046.1886143416;27057.72942270552;27293.72706272912;32915.670843291264;35869;36258.8187059063;36513.087172820895;37206.6279337214;25748.742512575383;28118.859405703657;29807.403851922405;30554.694453055185;30810;27993.580096298978;28188.43623127485;28369.89969228356;28636;28731.42537149287;29013.129606111004;29170.27074323074;29583.408331833674;29646.703532964395;29654;23702.52594948057;25440.74559254458;27027.59458608083;27218.727812722413;27682.723172768016;20546.589068218254;20561;20867.89566052221;20913.163473460892;20918.47703807417 18:52:05 INFO - 2015-11-30 18:52:05,252 DEBUG : BROWSER_OUTPUT: |2;jquery.html;290.98545072746356;293.8560105548282;298.4151063914727;301.9215004098935;302.20821447806736;8637.956810215941;9083.091690830914;14342.139471631697;14814.629634259149;14840.25798710063;9140.680076197334;9704.854427183598;9955.004499550041;9964.352317099383;10245.385276883373;3689.446583012556;3820.4078367853026;3822.57951625321;3832.559255685604;3843.8846834595006;2951.4687356275863;3020.8036477628993;3045.5888455058507;3799.487069245658;3854.69162467002;4026.5772093930154;4118.052847844998;4128.525219599739;4128.566500517448;4144.834206631746;4111.506619205715;4136.193442278757;4149.3983372410985;4152.252594532983;4176.937345939813;3117.9220519486967;3370.9325813483592;3407.829608519589;3414.8634054638032;3427;11030.28303160292;11208.103351731923;11393.772124557463;11463.484143213574;11679.766404671944;1489.4265707702505;1559.8440155984424;1573;1577.1483398964544;1647.5139833749072;8026.237507436784;8123.431359804816;8143.389245806588;8262.339012878956;8422.578871056485;1229.5757963502576;1285.6271681212438;1341.2958196946583;1357.9728405431936;1376.2705765943965;48780.26829597559;49266.26100608494;49751;49916.75041624805;50155.74922125366;5635.436456354331;5644.689542075143;5707.315122185281;5732.914006289909;5752.942470575241;6481.708323125471;6488.124103246096;6504.05691174777;6537.901931471032;6593.505487088488;4786.497417771154;4813.7593120344545;4820.469748327681;4838.346823178826;4907.1167189905445;5163.535281824654;5170.819021334235;5253.921191182136;5287.814926477555;5297.284866542967;2544.9363765906;2588.327034970921;2590.352411897026;2597.4285657155774;2603.2580714496657;881.8148188880278;895.1451363947415;929.3494553812359;940.0176815228103;966.5698764050071;347.9695973991736;364.72281066389206;375.15215612714917;397.93434083376496;406.8453987484737;8431.831363372698;9725.173360264456;9967.40195588267;10123.797524049478;10157.136643385247;379.24530184932337;388.7181793199907;398.2393628170239;398.59343469661366;402.53507199184986;5322.121849894724;5340.412554618989;5370.677759334452;5400.648957817729;5400.729963501888;463078;491916;493206;498944;499722;62376;63559.682201588694;64418.35581644217;64549.677251613444;67106.32893671001;380.1351924372076;388.52793855465745;390.8690588652833;392.6093536930772;393.9874522477263;9073.274138069071;9209.631614735603;9440.33917625787;9531.094546018117;9589.664361747306;29177.270568235963;30015;31136;31140.688593114686;31242.531362029134;41281.1743765129;42014.57985420107;42080.15839683128;42547.149057019305;43181.56818431775;5225.92161117576;5228.919957226071;5238.135707608202;5255.737213139251;5336.066188416934;9699.951500242736;9739.269554783277;9775.462349570842;9823.70528884106;9993.700188994342;8332.583370831555;8475.49147051179;8503.064662886954;8590;8703.390762646553;8275.379346548913;8360.707375241838;8405.831883362422;8477.279431248166;8495.192956669107;7082.150141982995;7353.8161545961775;7449.4412919032375;8780.912190878265;8877.955610221907;4727.1963766160525;4776.23580227162;5166.4316925138955;5208.869778255574;5292.788288468418;8302.962129733784;8436.662533498591;8460.11168827289;8591.355648326275;8630.39587228888 18:52:05 INFO - 2015-11-30 18:52:05,256 DEBUG : BROWSER_OUTPUT: |3;mootools.html;668.5019660353038;1180.7933611617968;1209.2140108929195;1320.9696436779313;1500.992495037524;5680.289963754531;5949.0778929265925;5972.19375384323;6184.659843708594;6248.062790581415;6092.421219984106;6104.786332478364;6137.907931381022;6231.189945307115;6304.432601065903;1755.455808699304;1778.7598674179014;1805.3139806873369;1809.4209852847093;1810.8551315894697;1822.3894995176631;1839.604485035717;1857.9349722759707;1864.7855496617858;1866.4400679796074;1784.3754685859974;1792.0233472757313;1795.5959909020496;1801.3965321617209;1814.97277540837;1725.991370043148;1730.6971280026007;1732.0214079045363;1759.9120043997748;1771.6279581287945;1799.3702204228546;1814.2470874587032;1819.1631849349315;1838.9908050459796;1854.4992851930037;5517.337919449692;6145.354737752561;6168.259808822925;6179.443850053472;6214.720337584819;3436.1753179237053;3754.530683664542;3826.3877779555414;3868.729188956774;3875.9031024224337;2289.645105008726;2325.337278875529;2376.607859703147;2387.510560335127;2398.040783686522;643.3887806583764;648.5362965479704;659.2682122843639;1233.5374234662002;1338.4044100375336;7848.9607551962445;7881.487703299267;7917.208279172037;7945.284924356835;7964.800879977989;3283.294091770281;3298.5217143514055;3378.7465940054103;3397.3205358928312;3410.2326976430104;6700.966495167493;6707.798766037026;6713.295104014008;6754.493412993947;6789.015592739025;3800.9619903801163;3816.427535869642;3850.0567360996733;3859.6912247020173;3865.5747867734526;3562.4834399011997;3583.749137560346;3584.534010578608;3595.694365978869;3600.0999750062483;2659.9601005984537;2675.3846615278594;2726.3184203949013;2738.2332946774936;2742.616033755276;816.2368185746227;835.5696816139572;838.4885220015785;842.6671464771504;853.6542700206427;991.2466525440717;995.7560397702464;1010.1514727628827;1010.9797804043878;1035.2804800663466;5798.797042103506;5812.331581868139;5866.120081987736;5921.644701317935;5944.851378715567;395.71310799670584;396.8273800896619;397.99307751389034;995.6166875752888;1070.7632684249704;4714.104320179155;4766.6901651392545;4786.210275304606;4828.758562071883;4860.975695121501;7157.713691452388;7381.852362952711;7390.113186417664;7397.852042959111;7436.330730234305;7336.853262934711;7367.668454919434;7392.112946446461;7392.593407362647;7420.517666351778;5522.674558106026;5706.543476521868;5818.418158184148;5945.494632956161;5957.553183511254;5779.0464573344925;5884.0585506318785;5907.940920590911;5927.347991720821;5943.881122377615;6199.5040396767245;6583.407493325623;6665.7333706653135;6686.06395104676;6718.193816741827;6611.966940165268;6657.1345725055435;6681.2984636612455;6702.832429189114;6950.4787140965645;5920.437558431942;6018.187544681412;6064.939350606437;6088.756449742138;6093.177421048102;5860.267466566679;6052.243469566304;6110.694465276807;6154.476869466145;6163.106349579376;5623.831285061455;5628.746706398304;5726.770929162787;5771.163181338767;5825.3592104867585;5319.787208511616;5409.269748584048;5502.284702988586;5667.858303542444;5682.119271512922;5540.7783688652;5545.390007099297;5627.240322556402;5634.943650563606;5649;5007.324011258579;5012.298278240976;5058.443571207091;5091.541761241506;5093.18509038552;4748.169070412595;4781.784819683053;4877.90244195107;5046.671966322324;5154.974225129 18:52:05 INFO - 2015-11-30 18:52:05,257 DEBUG : BROWSER_OUTPUT: |4;prototype.html;238.6539517699336;246.83955428971166;255.81325632288429;269.92846895572666;276.7578368927189;5062.772175252113;5084.923726144101;5116.948830511694;5144.536991670749;5160.14857548504;4837.661363704542;4918.336024636673;4958;4978.054169707753;5051.722155281458;3928.6464218220353;3951.960480395188;3960.5841386654274;3998.860039898604;4003.019260281228;3947;3993.8202780874785;3999.8400063997406;4002.0595160137345;4005.6394924456795;3769.0765762388255;3795.69634429245;3822.063594419371;3868.845246190163;3900.3564411872007;3826.330392181357;3838.0788610733503;3867.9613203867884;3878.7866667333287;3894.0654242981623;3272.214668479548;3325.6508066652896;3327.2680010397676;3334.549835772188;3335.1161942085123;4879.194932836078;4879.243717223836;4915.680480768774;4921.335619691332;4952.182889823175;4191.874243772691;4218.8523401680795;4302.634276086536;4352.17308711347;4401.449818772653;5257.342832145981;5290.947090529123;5311.787528498855;5315.574754019669;5351.357837059539;3632.654897784733;3643.7995910224927;3659.1949771050326;3680.6687398134295;3684.392075307571;5524.806631767909;5580.972095139539;5608.579356548275;5617;5617.129344951539;3519.982400087983;3710.7588006779474;3715.3869611514338;3764.228333191689;3784.3377408953324;3420.793231723297;3493.8602455901987;3617.023403681044;3632.146445585285;3748.962510374916;4280.785960701953;4298.591633794785;4307.590778876001;4359.411479450297;4367;5303.602229832701;5336.493033161843;5356.892862142735;5361.169018802092;5383.892322153535;1336.2984433172467;1336.5522549945877;1343.187371640163;1356.7625665508497;1360.3606305036617;875.802944337519;879.5030807593689;899.0380293086334;900.1718419054486;909.9135582119688;5054.570361519239;5057.089723849743;5160.716160611128;5182.870428239325;5185.844424667266;5486.067368547357;5501.504864562208;5553.055980483327;5568.7215639217875;5582.078956972054;4993.0762808879745;5040.420351659533;5067.847964561069;5147.562457191106;5187.06632806091;2971.257185703574;3030.9242268943453;3039.407315573442;3041.1788817019724;3042.802217855832;5573.498385145356;5581.079121944834;5599.300087489064;5645.774169033275;5653.632513886584;5593.860153496195;5626.718664066781;5636.859078522988;5645.604807663506;5647.915281270784;5502.0921547944945;5573.665580065209;5615.410381910004;5641.294838145232;5672.801451949244;5490.313710786152;5492.890142197213;5514.751836167462;5551.417101204477;5562.694051827189;5347.358317001985;5413.566914646897;5443.292371991616;5472.151816468454;5476.0690682584855;5449.073657478159;5561.944380556142;5630.296212973379;5631.239782629293;5639.182318563868;3510.1926556892568;3522.6653467920505;3543.2027793747234;3566.286742651428;3576.016595436172;5502.174673798962;5536.640118392292;5553.972230138824;5570;5577.860553486195;5407.567394608501;5416.918746218888;5438.102713052302;5445.101558242845;5467.917981230205;5213.530782229617;5383.353997520166;5418.45815418455;5449.972750136224;5475.698836564027;5247.921281180862;5266.131088370376;5289.206619007025;5310.761015754378;5321.308229930084;5373.462653734595;5447.264619276505;5470.781168753205;5472;5493.478119578634;5177.119889618699;5282.049231138279;5334.653247538898;5347.144456886879;5351.063563876384 18:52:05 INFO - 2015-11-30 18:52:05,261 DEBUG : BROWSER_OUTPUT: |5;yui.html;556.9164625306204;560.4451592923004;591.2963573347716;593.7446897833935;618.6999305336914;11472.541098356067;11582.884171158286;11707.5902343418;11862.051035917139;11873.584424545143;10819.188560857929;10873;10898;10970.506327215275;10973.067289280401;596.7344531683414;613.1354789746458;622.7477871462065;733.5158795195172;746.1792028768339;744.7505085796265;746.138210367027;746.3879618712658;758.0600055930662;758.6396461680686;765.9080910290745;767.3477544087536;770.2066871122753;771.8263390737068;773.6711897443593;610.4048552661164;627.6422439209653;748.1620584944842;763.7555982085735;774.2644487736673;555.7193617223277;557.5233175634814;557.5400294756802;557.9358373786986;566.2101368590793;11350.659480215607;11359.545618175263;11360.147988900782;11514.30914145154;11547.307161570248;7761.689532418696;7909.327707144899;8065.072516660601;8237.135100814388;8469.110743371919;7591.772246832604;7668.194839541824;7767.37860971121;7771.378289736807;8003.239692229229;2397.7292035221185;2435.866027368494;2439.78041976223;2555.9488810223693;2568.9980907445924;38745.806270968744;39888.40167397491;40017.79991100055;40164.79917600423;40178.799106004575;5859.5019423349495;5890.764369425261;5923.437273459014;6064.211652485149;6153.323134455206;10169.288149829441;10231.539580718885;10285.794284114276;10318.329308594917;10376.636817711344;5127.487251274917;5290.788368465218;5312.993161493957;5376.865578360573;5479.671219726829;3068.3249685069695;3166.4142133704877;3169.793963392372;3176.7776255661884;3223.46812775894;2193.605151072822;2232;2250.00999560193;2254.4476603231983;2259.1076524772625;343.42990635544874;343.77482748799576;344.5434798891479;345.94637831136214;348.4442314508355;429.02611072865045;440.94929083155205;451.96500014966017;477.8160408242782;510.52521155325906;5902.321233058254;6070.453659170696;6151.046587778812;6155.10750941111;6241.625502469867;395.97228194026144;415.42048841865426;427.79252062749543;481.94698583155827;498.09346988481343;2881.394907069497;2928.0776555384987;3013.7136971987625;3022.440848443045;3023.7732170087334;48978.5102148974;49306.50693493091;49380;49891.750541247064;51092.489075109515;43274.56725432768;43468.565314347084;43573;43596.564034359886;44179.77910110429;40665.796671016455;41218.79390603088;41641;41900.580994189666;42188;5936.554758393224;6022.36765139654;6088.36072212429;6114.908276375769;6595.307492713388;31785;32069.679303207602;32123.839380802947;32348.514772277966;32617.510737339435;42574.148517028865;43704.34443483287;44931;45020.54979450163;45627.54372456233;8884.60019299146;9087.182153606207;9390.060993900555;9516.809663806824;9887.357321774061;9330.30022748283;9491.335606507479;9500.47747373901;9622.16121786873;10265.922078181684;8889.866652000095;9021.233195178484;9092.909070909207;9211.170994610517;9313.161815436371;9020.819583608421;9089.863652045357;9140.908590914005;9252.768680782765;9254;8818.559072046244;8850;8875.334349923653;9008.234300084567;9092.90907090947;7789;7799.571023593757;7875.684972601031;7990.320822730133;8160.918390816016;7694.923050769421;7844.254795794619;7850.293473587404;8053.6778528858185;8089.716859909875 18:52:05 INFO - 2015-11-30 18:52:05,261 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:52:05 INFO - 2015-11-30 18:52:05,261 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:52:05 INFO - 2015-11-30 18:52:05,261 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,960 18:52:05 INFO - 2015-11-30 18:52:05,262 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:52:05 INFO - 2015-11-30 18:52:05,262 DEBUG : BROWSER_OUTPUT: __startTimestamp1448938325244__endTimestamp 18:52:05 INFO - 2015-11-30 18:52:05,262 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,262 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:52:05 INFO - 2015-11-30 18:52:05,262 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:52:05 INFO - 2015-11-30 18:52:05,262 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,263 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4521.99 Median:4628.38 stddev:478.60 (10.3%) stddev-sans-first:455.59 18:52:05 INFO - 2015-11-30 18:52:05,263 DEBUG : BROWSER_OUTPUT: Values: 2596.0 2701.4 2728.2 2734.2 2744.7 4412.9 4479.9 4511.9 4530.2 4563.1 4482.1 4526.9 4536.9 4550.2 4580.8 4171.7 4197.6 4214.4 4234.1 4265.0 4146.1 4165.1 4213.5 4319.3 4380.5 4274.6 4386.2 4405.2 4455.0 4496.5 4077.9 4340.1 4341.4 4381.5 4432.4 3951.2 4164.9 4198.1 4244.4 4249.4 4435.4 4435.5 4482.8 4489.6 4497.0 4785.5 4810.3 4819.5 4843.6 4846.7 4798.3 4798.5 4812.2 4820.5 4884.4 4477.3 4489.3 4536.4 4546.1 4555.2 4932.4 4999.4 5010.3 5014.9 5028.2 4529.4 4625.0 4712.6 4723.1 4770.0 4797.1 4817.8 4862.7 4867.9 5032.7 4731.5 4763.1 4794.1 4811.9 4843.8 4500.0 4609.1 4686.7 4698.4 4829.4 3666.4 3678.9 3710.9 3714.3 3768.5 3351.9 3369.5 3423.5 3438.7 3448.9 4610.2 4628.4 4686.3 4691.6 4726.5 4631.0 4652.7 4742.2 4931.0 4999.4 4522.2 4534.4 4579.1 4604.2 4615.5 4247.3 4251.6 4253.6 4256.3 4340.3 4816.2 4824.6 4860.4 4971.5 5043.8 4852.2 4886.7 4933.6 4973.9 4991.5 4922.5 4927.2 4966.9 4993.9 5003.1 4571.0 4679.8 4766.4 4780.0 4806.3 4848.3 4879.2 4906.2 4931.2 4958.3 4735.7 4761.3 4800.0 4816.5 4822.3 4534.6 4663.8 4732.4 4733.5 4859.2 4527.2 4725.0 4752.5 4753.5 4829.0 4856.6 4867.1 4870.9 4915.3 4917.6 4524.0 4568.2 4596.8 4607.7 4647.5 18:52:05 INFO - 2015-11-30 18:52:05,263 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,263 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38049.79 Median:152719.13 stddev:61768.56 (40.4%) stddev-sans-first:61877.41 18:52:05 INFO - 2015-11-30 18:52:05,263 DEBUG : BROWSER_OUTPUT: Values: 475.4 482.0 488.7 491.5 515.7 27408.2 28413.6 34063.8 34759.5 34874.0 36553.8 37012.3 37160.8 37512.6 37809.4 7173.1 7568.2 7735.3 7756.3 7816.9 7278.3 9176.8 9210.4 9244.1 9358.8 9160.7 9169.1 9261.5 9315.6 9316.8 7196.8 7467.5 9057.4 9168.0 9262.8 9051.1 9084.2 9115.5 9145.5 9147.7 34192.7 34594.3 35091.1 35127.8 35203.6 2485.6 2523.0 2867.3 2899.5 2997.3 23293.8 23835.5 23919.5 24634.3 24651.1 1974.5 2002.0 2008.4 2018.1 2047.1 212718.9 213377.0 213624.0 213968.0 214089.0 48538.5 49318.0 52923.0 53393.0 58389.7 53534.5 53816.7 54995.2 55082.7 55239.7 14043.2 14225.1 14230.6 14315.4 14356.0 11418.1 11514.0 11533.9 11542.7 11551.6 16755.3 16978.7 17206.4 17371.7 17384.1 6945.4 7073.9 7103.8 7143.6 7147.2 746.5 807.7 880.4 941.6 970.2 23958.4 24461.3 24628.5 24709.3 24793.4 819.3 896.9 899.8 912.1 918.2 11348.5 11848.9 11884.6 12029.2 12053.9 293938.0 302441.0 304619.0 304752.0 310765.0 40229.6 41314.6 45914.5 46425.5 46592.5 1180.3 1208.8 1210.2 1210.2 1217.3 20782.3 23448.9 23961.5 24999.4 25173.0 43581.6 44914.0 45320.0 45640.8 45758.3 169587.2 169959.0 170568.1 170697.0 172447.0 27012.6 27043.1 27046.2 27057.7 27293.7 32915.7 35869.0 36258.8 36513.1 37206.6 25748.7 28118.9 29807.4 30554.7 30810.0 27993.6 28188.4 28369.9 28636.0 28731.4 29013.1 29170.3 29583.4 29646.7 29654.0 23702.5 25440.7 27027.6 27218.7 27682.7 20546.6 20561.0 20867.9 20913.2 20918.5 18:52:05 INFO - 2015-11-30 18:52:05,263 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,263 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23458.78 Median:270591.13 stddev:80237.38 (29.7%) stddev-sans-first:80443.60 18:52:05 INFO - 2015-11-30 18:52:05,267 DEBUG : BROWSER_OUTPUT: Values: 291.0 293.9 298.4 301.9 302.2 8638.0 9083.1 14342.1 14814.6 14840.3 9140.7 9704.9 9955.0 9964.4 10245.4 3689.4 3820.4 3822.6 3832.6 3843.9 2951.5 3020.8 3045.6 3799.5 3854.7 4026.6 4118.1 4128.5 4128.6 4144.8 4111.5 4136.2 4149.4 4152.3 4176.9 3117.9 3370.9 3407.8 3414.9 3427.0 11030.3 11208.1 11393.8 11463.5 11679.8 1489.4 1559.8 1573.0 1577.1 1647.5 8026.2 8123.4 8143.4 8262.3 8422.6 1229.6 1285.6 1341.3 1358.0 1376.3 48780.3 49266.3 49751.0 49916.8 50155.7 5635.4 5644.7 5707.3 5732.9 5752.9 6481.7 6488.1 6504.1 6537.9 6593.5 4786.5 4813.8 4820.5 4838.3 4907.1 5163.5 5170.8 5253.9 5287.8 5297.3 2544.9 2588.3 2590.4 2597.4 2603.3 881.8 895.1 929.3 940.0 966.6 348.0 364.7 375.2 397.9 406.8 8431.8 9725.2 9967.4 10123.8 10157.1 379.2 388.7 398.2 398.6 402.5 5322.1 5340.4 5370.7 5400.6 5400.7 463078.0 491916.0 493206.0 498944.0 499722.0 62376.0 63559.7 64418.4 64549.7 67106.3 380.1 388.5 390.9 392.6 394.0 9073.3 9209.6 9440.3 9531.1 9589.7 29177.3 30015.0 31136.0 31140.7 31242.5 41281.2 42014.6 42080.2 42547.1 43181.6 5225.9 5228.9 5238.1 5255.7 5336.1 9700.0 9739.3 9775.5 9823.7 9993.7 8332.6 8475.5 8503.1 8590.0 8703.4 8275.4 8360.7 8405.8 8477.3 8495.2 7082.2 7353.8 7449.4 8780.9 8878.0 4727.2 4776.2 5166.4 5208.9 5292.8 8303.0 8436.7 8460.1 8591.4 8630.4 18:52:05 INFO - 2015-11-30 18:52:05,267 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,267 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4314.64 Median:5625.54 stddev:2213.69 (39.4%) stddev-sans-first:2202.92 18:52:05 INFO - 2015-11-30 18:52:05,267 DEBUG : BROWSER_OUTPUT: Values: 668.5 1180.8 1209.2 1321.0 1501.0 5680.3 5949.1 5972.2 6184.7 6248.1 6092.4 6104.8 6137.9 6231.2 6304.4 1755.5 1778.8 1805.3 1809.4 1810.9 1822.4 1839.6 1857.9 1864.8 1866.4 1784.4 1792.0 1795.6 1801.4 1815.0 1726.0 1730.7 1732.0 1759.9 1771.6 1799.4 1814.2 1819.2 1839.0 1854.5 5517.3 6145.4 6168.3 6179.4 6214.7 3436.2 3754.5 3826.4 3868.7 3875.9 2289.6 2325.3 2376.6 2387.5 2398.0 643.4 648.5 659.3 1233.5 1338.4 7849.0 7881.5 7917.2 7945.3 7964.8 3283.3 3298.5 3378.7 3397.3 3410.2 6701.0 6707.8 6713.3 6754.5 6789.0 3801.0 3816.4 3850.1 3859.7 3865.6 3562.5 3583.7 3584.5 3595.7 3600.1 2660.0 2675.4 2726.3 2738.2 2742.6 816.2 835.6 838.5 842.7 853.7 991.2 995.8 1010.2 1011.0 1035.3 5798.8 5812.3 5866.1 5921.6 5944.9 395.7 396.8 398.0 995.6 1070.8 4714.1 4766.7 4786.2 4828.8 4861.0 7157.7 7381.9 7390.1 7397.9 7436.3 7336.9 7367.7 7392.1 7392.6 7420.5 5522.7 5706.5 5818.4 5945.5 5957.6 5779.0 5884.1 5907.9 5927.3 5943.9 6199.5 6583.4 6665.7 6686.1 6718.2 6612.0 6657.1 6681.3 6702.8 6950.5 5920.4 6018.2 6064.9 6088.8 6093.2 5860.3 6052.2 6110.7 6154.5 6163.1 5623.8 5628.7 5726.8 5771.2 5825.4 5319.8 5409.3 5502.3 5667.9 5682.1 5540.8 5545.4 5627.2 5634.9 5649.0 5007.3 5012.3 5058.4 5091.5 5093.2 4748.2 4781.8 4877.9 5046.7 5155.0 18:52:05 INFO - 2015-11-30 18:52:05,268 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,268 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4454.11 Median:5160.43 stddev:1357.35 (26.3%) stddev-sans-first:1323.77 18:52:05 INFO - 2015-11-30 18:52:05,268 DEBUG : BROWSER_OUTPUT: Values: 238.7 246.8 255.8 269.9 276.8 5062.8 5084.9 5116.9 5144.5 5160.1 4837.7 4918.3 4958.0 4978.1 5051.7 3928.6 3952.0 3960.6 3998.9 4003.0 3947.0 3993.8 3999.8 4002.1 4005.6 3769.1 3795.7 3822.1 3868.8 3900.4 3826.3 3838.1 3868.0 3878.8 3894.1 3272.2 3325.7 3327.3 3334.5 3335.1 4879.2 4879.2 4915.7 4921.3 4952.2 4191.9 4218.9 4302.6 4352.2 4401.4 5257.3 5290.9 5311.8 5315.6 5351.4 3632.7 3643.8 3659.2 3680.7 3684.4 5524.8 5581.0 5608.6 5617.0 5617.1 3520.0 3710.8 3715.4 3764.2 3784.3 3420.8 3493.9 3617.0 3632.1 3749.0 4280.8 4298.6 4307.6 4359.4 4367.0 5303.6 5336.5 5356.9 5361.2 5383.9 1336.3 1336.6 1343.2 1356.8 1360.4 875.8 879.5 899.0 900.2 909.9 5054.6 5057.1 5160.7 5182.9 5185.8 5486.1 5501.5 5553.1 5568.7 5582.1 4993.1 5040.4 5067.8 5147.6 5187.1 2971.3 3030.9 3039.4 3041.2 3042.8 5573.5 5581.1 5599.3 5645.8 5653.6 5593.9 5626.7 5636.9 5645.6 5647.9 5502.1 5573.7 5615.4 5641.3 5672.8 5490.3 5492.9 5514.8 5551.4 5562.7 5347.4 5413.6 5443.3 5472.2 5476.1 5449.1 5561.9 5630.3 5631.2 5639.2 3510.2 3522.7 3543.2 3566.3 3576.0 5502.2 5536.6 5554.0 5570.0 5577.9 5407.6 5416.9 5438.1 5445.1 5467.9 5213.5 5383.4 5418.5 5450.0 5475.7 5247.9 5266.1 5289.2 5310.8 5321.3 5373.5 5447.3 5470.8 5472.0 5493.5 5177.1 5282.0 5334.7 5347.1 5351.1 18:52:05 INFO - 2015-11-30 18:52:05,268 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,269 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11474.61 Median:3017.70 stddev:14273.77 (473.0%) stddev-sans-first:14290.27 18:52:05 INFO - 2015-11-30 18:52:05,271 DEBUG : BROWSER_OUTPUT: Values: 556.9 560.4 591.3 593.7 618.7 11472.5 11582.9 11707.6 11862.1 11873.6 10819.2 10873.0 10898.0 10970.5 10973.1 596.7 613.1 622.7 733.5 746.2 744.8 746.1 746.4 758.1 758.6 765.9 767.3 770.2 771.8 773.7 610.4 627.6 748.2 763.8 774.3 555.7 557.5 557.5 557.9 566.2 11350.7 11359.5 11360.1 11514.3 11547.3 7761.7 7909.3 8065.1 8237.1 8469.1 7591.8 7668.2 7767.4 7771.4 8003.2 2397.7 2435.9 2439.8 2555.9 2569.0 38745.8 39888.4 40017.8 40164.8 40178.8 5859.5 5890.8 5923.4 6064.2 6153.3 10169.3 10231.5 10285.8 10318.3 10376.6 5127.5 5290.8 5313.0 5376.9 5479.7 3068.3 3166.4 3169.8 3176.8 3223.5 2193.6 2232.0 2250.0 2254.4 2259.1 343.4 343.8 344.5 345.9 348.4 429.0 440.9 452.0 477.8 510.5 5902.3 6070.5 6151.0 6155.1 6241.6 396.0 415.4 427.8 481.9 498.1 2881.4 2928.1 3013.7 3022.4 3023.8 48978.5 49306.5 49380.0 49891.8 51092.5 43274.6 43468.6 43573.0 43596.6 44179.8 40665.8 41218.8 41641.0 41900.6 42188.0 5936.6 6022.4 6088.4 6114.9 6595.3 31785.0 32069.7 32123.8 32348.5 32617.5 42574.1 43704.3 44931.0 45020.5 45627.5 8884.6 9087.2 9390.1 9516.8 9887.4 9330.3 9491.3 9500.5 9622.2 10265.9 8889.9 9021.2 9092.9 9211.2 9313.2 9020.8 9089.9 9140.9 9252.8 9254.0 8818.6 8850.0 8875.3 9008.2 9092.9 7789.0 7799.6 7875.7 7990.3 8160.9 7694.9 7844.3 7850.3 8053.7 8089.7 18:52:05 INFO - 2015-11-30 18:52:05,271 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:52:05 INFO - 2015-11-30 18:52:05,271 DEBUG : BROWSER_OUTPUT: 18:52:05 INFO - 2015-11-30 18:52:05,954 INFO : Browser exited with error code: 0 18:52:05 INFO - 2015-11-30 18:52:05,987 INFO : Completed test dromaeo_css (00:18:36) 18:52:05 INFO - 2015-11-30 18:52:05,987 INFO : Starting test kraken 18:52:05 INFO - 2015-11-30 18:52:05,987 DEBUG : operating with platform_type : mac_ 18:52:05 INFO - 2015-11-30 18:52:05,987 INFO : Initialising browser for kraken test... 18:52:06 INFO - 2015-11-30 18:52:06,003 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpsep6o6/profile http://localhost:49265/getInfo.html 18:52:08 INFO - 2015-11-30 18:52:08,505 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:52:08 INFO - 2015-11-30 18:52:08,505 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:52:08 INFO - 2015-11-30 18:52:08,505 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:52:08 INFO - 2015-11-30 18:52:08,505 DEBUG : BROWSER_OUTPUT: __metrics 18:52:08 INFO - 2015-11-30 18:52:08,526 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:52:08 INFO - 2015-11-30 18:52:08,840 DEBUG : BROWSER_OUTPUT: console.error: 18:52:08 INFO - 2015-11-30 18:52:08,844 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 18:52:08 INFO - 2015-11-30 18:52:08,844 DEBUG : BROWSER_OUTPUT: Stack: 18:52:08 INFO - 2015-11-30 18:52:08,844 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 18:52:08 INFO - 2015-11-30 18:52:08,844 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 18:52:08 INFO - 2015-11-30 18:52:08,845 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 18:52:08 INFO - 2015-11-30 18:52:08,845 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 18:52:08 INFO - 2015-11-30 18:52:08,845 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 18:52:08 INFO - 2015-11-30 18:52:08,845 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 18:52:08 INFO - 2015-11-30 18:52:08,845 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:52:08 INFO - 2015-11-30 18:52:08,845 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 18:52:08 INFO - 2015-11-30 18:52:08,846 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:52:08 INFO - 2015-11-30 18:52:08,846 DEBUG : BROWSER_OUTPUT: 18:52:09 INFO - 2015-11-30 18:52:09,302 INFO : Browser initialized. 18:52:09 INFO - 2015-11-30 18:52:09,303 INFO : Running cycle 1/1 for kraken test... 18:52:09 INFO - 2015-11-30 18:52:09,303 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpsep6o6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:52:21 INFO - 2015-11-30 18:52:21,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 202911744 18:52:21 INFO - 2015-11-30 18:52:21,334 DEBUG : BROWSER_OUTPUT: 18:52:24 INFO - 2015-11-30 18:52:24,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 18:52:24 INFO - 2015-11-30 18:52:24,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 266674176 18:52:24 INFO - 2015-11-30 18:52:24,905 DEBUG : BROWSER_OUTPUT: 18:52:28 INFO - 2015-11-30 18:52:28,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 18:52:28 INFO - 2015-11-30 18:52:28,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 278978560 18:52:28 INFO - 2015-11-30 18:52:28,593 DEBUG : BROWSER_OUTPUT: 18:52:31 INFO - 2015-11-30 18:52:31,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 18:52:32 INFO - 2015-11-30 18:52:32,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 267284480 18:52:32 INFO - 2015-11-30 18:52:32,476 DEBUG : BROWSER_OUTPUT: 18:52:34 INFO - 2015-11-30 18:52:34,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 18:52:35 INFO - 2015-11-30 18:52:35,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 268509184 18:52:35 INFO - 2015-11-30 18:52:35,437 DEBUG : BROWSER_OUTPUT: 18:52:37 INFO - 2015-11-30 18:52:37,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:52:38 INFO - 2015-11-30 18:52:38,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 267948032 18:52:38 INFO - 2015-11-30 18:52:38,530 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-30 18:52:42,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 18:52:42 INFO - 2015-11-30 18:52:42,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 265277440 18:52:42 INFO - 2015-11-30 18:52:42,697 DEBUG : BROWSER_OUTPUT: 18:52:46 INFO - 2015-11-30 18:52:46,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 18:52:47 INFO - 2015-11-30 18:52:47,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 264785920 18:52:47 INFO - 2015-11-30 18:52:47,043 DEBUG : BROWSER_OUTPUT: 18:52:50 INFO - 2015-11-30 18:52:50,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 18:52:51 INFO - 2015-11-30 18:52:51,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 267259904 18:52:51 INFO - 2015-11-30 18:52:51,023 DEBUG : BROWSER_OUTPUT: 18:52:52 INFO - 2015-11-30 18:52:52,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:52:53 INFO - 2015-11-30 18:52:53,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 300163072 18:52:53 INFO - 2015-11-30 18:52:53,404 DEBUG : BROWSER_OUTPUT: 18:52:55 INFO - 2015-11-30 18:52:55,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:52:56 INFO - 2015-11-30 18:52:56,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 301576192 18:52:56 INFO - 2015-11-30 18:52:56,113 DEBUG : BROWSER_OUTPUT: 18:52:58 INFO - 2015-11-30 18:52:58,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:52:59 INFO - 2015-11-30 18:52:59,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 307699712 18:52:59 INFO - 2015-11-30 18:52:59,064 DEBUG : BROWSER_OUTPUT: 18:53:02 INFO - 2015-11-30 18:53:02,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:53:02 INFO - 2015-11-30 18:53:02,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 310145024 18:53:02 INFO - 2015-11-30 18:53:02,660 DEBUG : BROWSER_OUTPUT: 18:53:05 INFO - 2015-11-30 18:53:05,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:53:06 INFO - 2015-11-30 18:53:06,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 309075968 18:53:06 INFO - 2015-11-30 18:53:06,214 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 18:53:08 INFO - 2015-11-30 18:53:08,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 367562752 18:53:08 INFO - 2015-11-30 18:53:08,392 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,392 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:53:08 INFO - 2015-11-30 18:53:08,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:53:08 INFO - 2015-11-30 18:53:08,393 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:53:08 INFO - 2015-11-30 18:53:08,393 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:53:08 INFO - 2015-11-30 18:53:08,393 DEBUG : BROWSER_OUTPUT: |0;ai-astar;129;136;124;131;134;135;118;134;130;119 18:53:08 INFO - 2015-11-30 18:53:08,393 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;185;167;202;186;155;177;157;201;187;155 18:53:08 INFO - 2015-11-30 18:53:08,393 DEBUG : BROWSER_OUTPUT: |2;audio-dft;196;196;196;196;196;198;198;197;197;205 18:53:08 INFO - 2015-11-30 18:53:08,393 DEBUG : BROWSER_OUTPUT: |3;audio-fft;98;94;92;148;84;88;88;82;142;84 18:53:08 INFO - 2015-11-30 18:53:08,394 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;117;120;167;108;110;110;154;113;112;153 18:53:08 INFO - 2015-11-30 18:53:08,394 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;150;156;143;141;142;142;148;148;141;149 18:53:08 INFO - 2015-11-30 18:53:08,394 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;154;153;154;153;154;170;175;162;158;154 18:53:08 INFO - 2015-11-30 18:53:08,395 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;124;129;130;127;124;123;130;129;129;125 18:53:08 INFO - 2015-11-30 18:53:08,395 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;75;78;77;80;78;77;86;71;72 18:53:08 INFO - 2015-11-30 18:53:08,395 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;81;81;85;82;82;82;82;83;82 18:53:08 INFO - 2015-11-30 18:53:08,395 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;100;101;105;104;103;99;101;102;105 18:53:08 INFO - 2015-11-30 18:53:08,395 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;150;151;163;155;153;154;148;157;161;160 18:53:08 INFO - 2015-11-30 18:53:08,396 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;174;179;177;178;178;178;184;184;176;181 18:53:08 INFO - 2015-11-30 18:53:08,396 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;81;84;83;83;83;84;83;83;84 18:53:08 INFO - 2015-11-30 18:53:08,396 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:53:08 INFO - 2015-11-30 18:53:08,396 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:53:08 INFO - 2015-11-30 18:53:08,396 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 18:53:08 INFO - 2015-11-30 18:53:08,396 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:53:08 INFO - 2015-11-30 18:53:08,396 DEBUG : BROWSER_OUTPUT: __startTimestamp1448938388391__endTimestamp 18:53:08 INFO - 2015-11-30 18:53:08,396 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,397 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:53:08 INFO - 2015-11-30 18:53:08,398 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:53:08 INFO - 2015-11-30 18:53:08,398 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,398 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:129.00 Median:132.50 stddev:6.55 (4.9%) stddev-sans-first:6.95 18:53:08 INFO - 2015-11-30 18:53:08,398 DEBUG : BROWSER_OUTPUT: Values: 129.0 136.0 124.0 131.0 134.0 135.0 118.0 134.0 130.0 119.0 18:53:08 INFO - 2015-11-30 18:53:08,399 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,399 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:177.20 Median:185.50 stddev:17.99 (9.7%) stddev-sans-first:18.86 18:53:08 INFO - 2015-11-30 18:53:08,399 DEBUG : BROWSER_OUTPUT: Values: 185.0 167.0 202.0 186.0 155.0 177.0 157.0 201.0 187.0 155.0 18:53:08 INFO - 2015-11-30 18:53:08,399 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,399 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:197.50 Median:197.00 stddev:2.76 (1.4%) stddev-sans-first:2.87 18:53:08 INFO - 2015-11-30 18:53:08,399 DEBUG : BROWSER_OUTPUT: Values: 196.0 196.0 196.0 196.0 196.0 198.0 198.0 197.0 197.0 205.0 18:53:08 INFO - 2015-11-30 18:53:08,400 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,400 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:100.00 Median:88.00 stddev:24.26 (27.6%) stddev-sans-first:25.72 18:53:08 INFO - 2015-11-30 18:53:08,400 DEBUG : BROWSER_OUTPUT: Values: 98.0 94.0 92.0 148.0 84.0 88.0 88.0 82.0 142.0 84.0 18:53:08 INFO - 2015-11-30 18:53:08,400 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,401 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:126.40 Median:118.50 stddev:22.39 (18.9%) stddev-sans-first:23.48 18:53:08 INFO - 2015-11-30 18:53:08,402 DEBUG : BROWSER_OUTPUT: Values: 117.0 120.0 167.0 108.0 110.0 110.0 154.0 113.0 112.0 153.0 18:53:08 INFO - 2015-11-30 18:53:08,402 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,402 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:146.00 Median:148.00 stddev:4.99 (3.4%) stddev-sans-first:5.08 18:53:08 INFO - 2015-11-30 18:53:08,402 DEBUG : BROWSER_OUTPUT: Values: 150.0 156.0 143.0 141.0 142.0 142.0 148.0 148.0 141.0 149.0 18:53:08 INFO - 2015-11-30 18:53:08,403 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,403 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:158.70 Median:156.00 stddev:7.87 (5.0%) stddev-sans-first:8.17 18:53:08 INFO - 2015-11-30 18:53:08,403 DEBUG : BROWSER_OUTPUT: Values: 154.0 153.0 154.0 153.0 154.0 170.0 175.0 162.0 158.0 154.0 18:53:08 INFO - 2015-11-30 18:53:08,403 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,403 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:127.00 Median:129.00 stddev:2.75 (2.1%) stddev-sans-first:2.69 18:53:08 INFO - 2015-11-30 18:53:08,404 DEBUG : BROWSER_OUTPUT: Values: 124.0 129.0 130.0 127.0 124.0 123.0 130.0 129.0 129.0 125.0 18:53:08 INFO - 2015-11-30 18:53:08,404 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,404 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.80 Median:77.50 stddev:5.88 (7.6%) stddev-sans-first:4.43 18:53:08 INFO - 2015-11-30 18:53:08,404 DEBUG : BROWSER_OUTPUT: Values: 64.0 75.0 78.0 77.0 80.0 78.0 77.0 86.0 71.0 72.0 18:53:08 INFO - 2015-11-30 18:53:08,404 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,404 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:81.70 Median:82.00 stddev:2.00 (2.4%) stddev-sans-first:1.20 18:53:08 INFO - 2015-11-30 18:53:08,405 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 81.0 85.0 82.0 82.0 82.0 82.0 83.0 82.0 18:53:08 INFO - 2015-11-30 18:53:08,405 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,405 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:101.50 Median:104.50 stddev:3.06 (2.9%) stddev-sans-first:2.17 18:53:08 INFO - 2015-11-30 18:53:08,405 DEBUG : BROWSER_OUTPUT: Values: 95.0 100.0 101.0 105.0 104.0 103.0 99.0 101.0 102.0 105.0 18:53:08 INFO - 2015-11-30 18:53:08,405 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,405 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:155.20 Median:156.00 stddev:4.98 (3.2%) stddev-sans-first:4.92 18:53:08 INFO - 2015-11-30 18:53:08,406 DEBUG : BROWSER_OUTPUT: Values: 150.0 151.0 163.0 155.0 153.0 154.0 148.0 157.0 161.0 160.0 18:53:08 INFO - 2015-11-30 18:53:08,406 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,406 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:178.50 stddev:3.25 (1.8%) stddev-sans-first:2.92 18:53:08 INFO - 2015-11-30 18:53:08,407 DEBUG : BROWSER_OUTPUT: Values: 174.0 179.0 177.0 178.0 178.0 178.0 184.0 184.0 176.0 181.0 18:53:08 INFO - 2015-11-30 18:53:08,408 DEBUG : BROWSER_OUTPUT: 18:53:08 INFO - 2015-11-30 18:53:08,408 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.70 Median:83.00 stddev:1.57 (1.9%) stddev-sans-first:0.93 18:53:08 INFO - 2015-11-30 18:53:08,408 DEBUG : BROWSER_OUTPUT: Values: 79.0 81.0 84.0 83.0 83.0 83.0 84.0 83.0 83.0 84.0 18:53:08 INFO - 2015-11-30 18:53:08,408 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:53:08 INFO - 2015-11-30 18:53:08,408 DEBUG : BROWSER_OUTPUT: 18:53:09 INFO - 2015-11-30 18:53:09,155 INFO : Browser exited with error code: 0 18:53:09 INFO - 2015-11-30 18:53:09,212 INFO : Completed test kraken (00:01:03) 18:53:09 INFO - 2015-11-30 18:53:09,212 INFO : Starting test v8_7 18:53:09 INFO - 2015-11-30 18:53:09,212 DEBUG : operating with platform_type : mac_ 18:53:09 INFO - 2015-11-30 18:53:09,213 INFO : Initialising browser for v8_7 test... 18:53:09 INFO - 2015-11-30 18:53:09,228 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpGP2t8q/profile http://localhost:49265/getInfo.html 18:53:11 INFO - 2015-11-30 18:53:11,645 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:53:11 INFO - 2015-11-30 18:53:11,645 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:53:11 INFO - 2015-11-30 18:53:11,645 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:53:11 INFO - 2015-11-30 18:53:11,646 DEBUG : BROWSER_OUTPUT: __metrics 18:53:11 INFO - 2015-11-30 18:53:11,663 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:53:12 INFO - 2015-11-30 18:53:12,425 INFO : Browser initialized. 18:53:12 INFO - 2015-11-30 18:53:12,426 INFO : Running cycle 1/1 for v8_7 test... 18:53:12 INFO - 2015-11-30 18:53:12,426 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/lynp_3t134x1dyjj0dk7yvt000000w/T/tmpGP2t8q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:53:24 INFO - 2015-11-30 18:53:24,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 198610944 18:53:24 INFO - 2015-11-30 18:53:24,476 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/v8_7/run.html (next: http://localhost:49265/tests/v8_7/run.html) 18:53:47 INFO - 2015-11-30 18:53:47,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 519094272 18:53:47 INFO - 2015-11-30 18:53:47,335 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,335 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:53:47 INFO - 2015-11-30 18:53:47,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:53:47 INFO - 2015-11-30 18:53:47,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:53:47 INFO - 2015-11-30 18:53:47,336 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:53:47 INFO - 2015-11-30 18:53:47,336 DEBUG : BROWSER_OUTPUT: |0;Richards;199.96000799840033 18:53:47 INFO - 2015-11-30 18:53:47,336 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;238.49272597185785 18:53:47 INFO - 2015-11-30 18:53:47,336 DEBUG : BROWSER_OUTPUT: |2;Encrypt;382.84839203675347 18:53:47 INFO - 2015-11-30 18:53:47,336 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6972.222222222223 18:53:47 INFO - 2015-11-30 18:53:47,336 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1253.1328320802006 18:53:47 INFO - 2015-11-30 18:53:47,336 DEBUG : BROWSER_OUTPUT: |5;Earley;836.8200836820083 18:53:47 INFO - 2015-11-30 18:53:47,336 DEBUG : BROWSER_OUTPUT: |6;Boyer;14955.223880597016 18:53:47 INFO - 2015-11-30 18:53:47,337 DEBUG : BROWSER_OUTPUT: |7;RegExp;34931.03448275862 18:53:47 INFO - 2015-11-30 18:53:47,337 DEBUG : BROWSER_OUTPUT: |8;Splay;696.8641114982578 18:53:47 INFO - 2015-11-30 18:53:47,337 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6972.222222222223 18:53:47 INFO - 2015-11-30 18:53:47,337 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:53:47 INFO - 2015-11-30 18:53:47,337 DEBUG : BROWSER_OUTPUT: __startTimestamp1448938427330__endTimestamp 18:53:47 INFO - 2015-11-30 18:53:47,337 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:199.96 Median:199.96 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: Values: 200.0 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:238.49 Median:238.49 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: Values: 238.5 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:382.85 Median:382.85 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: Values: 382.8 18:53:47 INFO - 2015-11-30 18:53:47,338 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6972.22 Median:6972.22 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: Values: 6972.2 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1253.13 Median:1253.13 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: Values: 1253.1 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:836.82 Median:836.82 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: Values: 836.8 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14955.22 Median:14955.22 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: Values: 14955.2 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,339 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34931.03 Median:34931.03 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: Values: 34931.0 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:696.86 Median:696.86 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: Values: 696.9 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6972.22 Median:6972.22 stddev:0.00 (0.0%) 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: Values: 6972.2 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:53:47 INFO - 2015-11-30 18:53:47,340 DEBUG : BROWSER_OUTPUT: 18:53:48 INFO - 2015-11-30 18:53:48,072 INFO : Browser exited with error code: 0 18:53:48 INFO - 2015-11-30 18:53:48,096 INFO : Completed test v8_7 (00:00:38) 18:53:48 INFO - 2015-11-30 18:53:48,336 INFO : Completed test suite (00:20:18) 18:53:48 INFO - 2015-11-30 18:53:48,336 DEBUG : Working with test: dromaeo_css 18:53:48 INFO - 2015-11-30 18:53:48,337 DEBUG : Generating results file: dromaeo_css 18:53:48 INFO - 2015-11-30 18:53:48,337 DEBUG : Working with test: kraken 18:53:48 INFO - 2015-11-30 18:53:48,338 DEBUG : Generating results file: kraken 18:53:48 INFO - 2015-11-30 18:53:48,338 INFO : javascript benchmark 18:53:48 INFO - 2015-11-30 18:53:48,338 DEBUG : Working with test: v8_7 18:53:48 INFO - 2015-11-30 18:53:48,338 DEBUG : Generating results file: v8_7 18:53:48 INFO - 2015-11-30 18:53:48,339 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:53:48 INFO - 2015-11-30 18:53:48,401 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 18:53:48 INFO - 2015-11-30 18:53:48,401 DEBUG : process_Request line: dromaeo_css 5495.64 graph.html#tests=[[72,52,55]] 18:53:48 INFO - 2015-11-30 18:53:48,401 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:53:48 INFO - 2015-11-30 18:53:48,432 DEBUG : process_Request line: kraken 1837.60 graph.html#tests=[[232,52,55]] 18:53:48 INFO - 2015-11-30 18:53:48,432 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:53:48 INFO - 2015-11-30 18:53:48,463 DEBUG : process_Request line: v8_7 16867.58 graph.html#tests=[[230,52,55]] 18:53:48 INFO - 2015-11-30 18:53:48,464 INFO : javascript benchmark 18:53:48 INFO - 2015-11-30 18:53:48,466 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [290.98545072746356, 293.8560105548282, 298.4151063914727, 301.9215004098935, 302.20821447806736, 8637.956810215941, 9083.091690830914, 14342.139471631697, 14814.629634259149, 14840.25798710063, 9140.680076197334, 9704.854427183598, 9955.004499550041, 9964.352317099383, 10245.385276883373, 3689.446583012556, 3820.4078367853026, 3822.57951625321, 3832.559255685604, 3843.8846834595006, 2951.4687356275863, 3020.8036477628993, 3045.5888455058507, 3799.487069245658, 3854.69162467002, 4026.5772093930154, 4118.052847844998, 4128.525219599739, 4128.566500517448, 4144.834206631746, 4111.506619205715, 4136.193442278757, 4149.3983372410985, 4152.252594532983, 4176.937345939813, 3117.9220519486967, 3370.9325813483592, 3407.829608519589, 3414.8634054638032, 3427.0, 11030.28303160292, 11208.103351731923, 11393.772124557463, 11463.484143213574, 11679.766404671944, 1489.4265707702505, 1559.8440155984424, 1573.0, 1577.1483398964544, 1647.5139833749072, 8026.237507436784, 8123.431359804816, 8143.389245806588, 8262.339012878956, 8422.578871056485, 1229.5757963502576, 1285.6271681212438, 1341.2958196946583, 1357.9728405431936, 1376.2705765943965, 48780.26829597559, 49266.26100608494, 49751.0, 49916.75041624805, 50155.74922125366, 5635.436456354331, 5644.689542075143, 5707.315122185281, 5732.914006289909, 5752.942470575241, 6481.708323125471, 6488.124103246096, 6504.05691174777, 6537.901931471032, 6593.505487088488, 4786.497417771154, 4813.7593120344545, 4820.469748327681, 4838.346823178826, 4907.1167189905445, 5163.535281824654, 5170.819021334235, 5253.921191182136, 5287.814926477555, 5297.284866542967, 2544.9363765906, 2588.327034970921, 2590.352411897026, 2597.4285657155774, 2603.2580714496657, 881.8148188880278, 895.1451363947415, 929.3494553812359, 940.0176815228103, 966.5698764050071, 347.9695973991736, 364.72281066389206, 375.15215612714917, 397.93434083376496, 406.8453987484737, 8431.831363372698, 9725.173360264456, 9967.40195588267, 10123.797524049478, 10157.136643385247, 379.24530184932337, 388.7181793199907, 398.2393628170239, 398.59343469661366, 402.53507199184986, 5322.121849894724, 5340.412554618989, 5370.677759334452, 5400.648957817729, 5400.729963501888, 463078.0, 491916.0, 493206.0, 498944.0, 499722.0, 62376.0, 63559.682201588694, 64418.35581644217, 64549.677251613444, 67106.32893671001, 380.1351924372076, 388.52793855465745, 390.8690588652833, 392.6093536930772, 393.9874522477263, 9073.274138069071, 9209.631614735603, 9440.33917625787, 9531.094546018117, 9589.664361747306, 29177.270568235963, 30015.0, 31136.0, 31140.688593114686, 31242.531362029134, 41281.1743765129, 42014.57985420107, 42080.15839683128, 42547.149057019305, 43181.56818431775, 5225.92161117576, 5228.919957226071, 5238.135707608202, 5255.737213139251, 5336.066188416934, 9699.951500242736, 9739.269554783277, 9775.462349570842, 9823.70528884106, 9993.700188994342, 8332.583370831555, 8475.49147051179, 8503.064662886954, 8590.0, 8703.390762646553, 8275.379346548913, 8360.707375241838, 8405.831883362422, 8477.279431248166, 8495.192956669107, 7082.150141982995, 7353.8161545961775, 7449.4412919032375, 8780.912190878265, 8877.955610221907, 4727.1963766160525, 4776.23580227162, 5166.4316925138955, 5208.869778255574, 5292.788288468418, 8302.962129733784, 8436.662533498591, 8460.11168827289, 8591.355648326275, 8630.39587228888], "dojo.html": [2595.9610605840912, 2701.405690748035, 2728.208819442362, 2734.152412752047, 2744.6706395232563, 4412.867613971578, 4479.865604031885, 4511.8646440606835, 4530.184566777979, 4563.087382523496, 4482.125985432834, 4526.886827829306, 4536.8638940831825, 4550.158220729159, 4580.793864276107, 4171.749695018309, 4197.580241975808, 4214.4099826024385, 4234.110836724291, 4264.957350426487, 4146.087860670663, 4165.12532368203, 4213.494380674323, 4319.265724826787, 4380.540043295456, 4274.593913578221, 4386.166628340605, 4405.229084910144, 4454.97772511137, 4496.460424749019, 4077.918441631151, 4340.08858139791, 4341.435613370241, 4381.474223093217, 4432.357308190327, 3951.170254246612, 4164.875053748392, 4198.076423186894, 4244.405783190356, 4249.4475718156755, 4435.445569303837, 4435.512093669694, 4482.820687172509, 4489.592172914684, 4496.955030449719, 4785.497522760095, 4810.278458231258, 4819.542143496362, 4843.636727245471, 4846.660733748639, 4798.304245884362, 4798.496157903405, 4812.1578723723205, 4820.517948205152, 4884.438289596706, 4477.306017567283, 4489.349044388546, 4536.410266665345, 4546.113507865967, 4555.180067587866, 4932.4081110267, 4999.350084489066, 5010.298558201855, 5014.89970200594, 5028.170351891897, 4529.388532548064, 4625.028743963738, 4712.552307530779, 4723.149833030019, 4770.045990801854, 4797.112534181188, 4817.78319975602, 4862.6839255448995, 4867.9269810952865, 5032.672876263031, 4731.4795372509, 4763.095011947788, 4794.089123066607, 4811.879703007453, 4843.8304659337455, 4499.955000450019, 4609.124266389375, 4686.671932964659, 4698.389209402756, 4829.420469543677, 3666.395044817629, 3678.8528458861883, 3710.925781484409, 3714.312852122366, 3768.510093687858, 3351.8994430167136, 3369.4945758135987, 3423.4693622488553, 3438.6561343865915, 3448.8620455181513, 4610.216263235258, 4628.375169352162, 4686.27362758773, 4691.554302341272, 4726.456457507362, 4631.0, 4652.697574657636, 4742.19382704941, 4931.0, 4999.400071991312, 4522.163399771053, 4534.410526631583, 4579.107074120581, 4604.1712491751805, 4615.469221039556, 4247.320428731388, 4251.617354438115, 4253.595908388698, 4256.29771087767, 4340.283853164256, 4816.15717249487, 4824.614030877591, 4860.441049279378, 4971.477994810492, 5043.823466178666, 4852.2479015752615, 4886.731229782396, 4933.580645645016, 4973.875653108701, 4991.450940396626, 4922.458529561817, 4927.162382394929, 4966.8758281043265, 4993.875153121201, 5003.124453220599, 4571.0, 4679.789409476513, 4766.356541866804, 4779.976100119477, 4806.279058141306, 4848.272759086024, 4879.219324907997, 4906.1659517881335, 4931.235658472942, 4958.281049247911, 4735.668503204743, 4761.309610106446, 4800.0, 4816.54242846929, 4822.324874517501, 4534.614557762628, 4663.790129444251, 4732.408448943882, 4733.502982186821, 4859.173940430064, 4527.162474942146, 4724.976375118103, 4752.5485078917445, 4753.453352864465, 4828.95171048285, 4856.63575231852, 4867.075255701406, 4870.878228044327, 4915.311856340187, 4917.606591472602, 4524.04994951064, 4568.1548913451115, 4596.8161273548685, 4607.677462577587, 4647.512011238771], "mootools.html": [668.5019660353038, 1180.7933611617968, 1209.2140108929195, 1320.9696436779313, 1500.992495037524, 5680.289963754531, 5949.0778929265925, 5972.19375384323, 6184.659843708594, 6248.062790581415, 6092.421219984106, 6104.786332478364, 6137.907931381022, 6231.189945307115, 6304.432601065903, 1755.455808699304, 1778.7598674179014, 1805.3139806873369, 1809.4209852847093, 1810.8551315894697, 1822.3894995176631, 1839.604485035717, 1857.9349722759707, 1864.7855496617858, 1866.4400679796074, 1784.3754685859974, 1792.0233472757313, 1795.5959909020496, 1801.3965321617209, 1814.97277540837, 1725.991370043148, 1730.6971280026007, 1732.0214079045363, 1759.9120043997748, 1771.6279581287945, 1799.3702204228546, 1814.2470874587032, 1819.1631849349315, 1838.9908050459796, 1854.4992851930037, 5517.337919449692, 6145.354737752561, 6168.259808822925, 6179.443850053472, 6214.720337584819, 3436.1753179237053, 3754.530683664542, 3826.3877779555414, 3868.729188956774, 3875.9031024224337, 2289.645105008726, 2325.337278875529, 2376.607859703147, 2387.510560335127, 2398.040783686522, 643.3887806583764, 648.5362965479704, 659.2682122843639, 1233.5374234662002, 1338.4044100375336, 7848.9607551962445, 7881.487703299267, 7917.208279172037, 7945.284924356835, 7964.800879977989, 3283.294091770281, 3298.5217143514055, 3378.7465940054103, 3397.3205358928312, 3410.2326976430104, 6700.966495167493, 6707.798766037026, 6713.295104014008, 6754.493412993947, 6789.015592739025, 3800.9619903801163, 3816.427535869642, 3850.0567360996733, 3859.6912247020173, 3865.5747867734526, 3562.4834399011997, 3583.749137560346, 3584.534010578608, 3595.694365978869, 3600.0999750062483, 2659.9601005984537, 2675.3846615278594, 2726.3184203949013, 2738.2332946774936, 2742.616033755276, 816.2368185746227, 835.5696816139572, 838.4885220015785, 842.6671464771504, 853.6542700206427, 991.2466525440717, 995.7560397702464, 1010.1514727628827, 1010.9797804043878, 1035.2804800663466, 5798.797042103506, 5812.331581868139, 5866.120081987736, 5921.644701317935, 5944.851378715567, 395.71310799670584, 396.8273800896619, 397.99307751389034, 995.6166875752888, 1070.7632684249704, 4714.104320179155, 4766.6901651392545, 4786.210275304606, 4828.758562071883, 4860.975695121501, 7157.713691452388, 7381.852362952711, 7390.113186417664, 7397.852042959111, 7436.330730234305, 7336.853262934711, 7367.668454919434, 7392.112946446461, 7392.593407362647, 7420.517666351778, 5522.674558106026, 5706.543476521868, 5818.418158184148, 5945.494632956161, 5957.553183511254, 5779.0464573344925, 5884.0585506318785, 5907.940920590911, 5927.347991720821, 5943.881122377615, 6199.5040396767245, 6583.407493325623, 6665.7333706653135, 6686.06395104676, 6718.193816741827, 6611.966940165268, 6657.1345725055435, 6681.2984636612455, 6702.832429189114, 6950.4787140965645, 5920.437558431942, 6018.187544681412, 6064.939350606437, 6088.756449742138, 6093.177421048102, 5860.267466566679, 6052.243469566304, 6110.694465276807, 6154.476869466145, 6163.106349579376, 5623.831285061455, 5628.746706398304, 5726.770929162787, 5771.163181338767, 5825.3592104867585, 5319.787208511616, 5409.269748584048, 5502.284702988586, 5667.858303542444, 5682.119271512922, 5540.7783688652, 5545.390007099297, 5627.240322556402, 5634.943650563606, 5649.0, 5007.324011258579, 5012.298278240976, 5058.443571207091, 5091.541761241506, 5093.18509038552, 4748.169070412595, 4781.784819683053, 4877.90244195107, 5046.671966322324, 5154.974225129], "ext.html": [475.40574282147315, 481.98072077116916, 488.7311978411874, 491.4643039087396, 515.7421289355323, 27408.177754667366, 28413.57379639307, 34063.829680851624, 34759.4786078209, 34874.0, 36553.81723091381, 37012.25975480495, 37160.814195928986, 37512.62487375126, 37809.43285850714, 7173.067501224859, 7568.167501574822, 7735.30382265596, 7756.340711039568, 7816.921830781705, 7278.344948954593, 9176.770580735469, 9210.401323913924, 9244.121808428188, 9358.766030849216, 9160.6793762218, 9169.083091690844, 9261.490618016007, 9315.580798864034, 9316.813663726754, 7196.820079498002, 7467.514611550286, 9057.411268267542, 9168.0, 9262.814743705156, 9051.094890510962, 9084.182423581844, 9115.541513357897, 9145.542722863831, 9147.725568232963, 34192.658073419196, 34594.308113837586, 35091.12272193216, 35127.82436087803, 35203.64796352055, 2485.614729716897, 2522.9505996729413, 2867.283179205199, 2899.492588796973, 2997.265669910864, 23293.76706232933, 23835.523289534285, 23919.52160956771, 24634.260972170865, 24651.137210197736, 1974.5162435203324, 2001.9699704504299, 2008.4275981345247, 2018.1019446346381, 2047.0992763184151, 212718.93640531853, 213377.0, 213624.0, 213968.0, 214089.0, 48538.5146148534, 49318.0, 52923.0, 53393.0, 58389.70805146032, 53534.464655353724, 53816.73091634595, 54995.175072373946, 55082.72458637681, 55239.72380138074, 14043.1574105554, 14225.14649121056, 14230.573082807325, 14315.355808988621, 14356.0, 11418.143639226924, 11514.0, 11533.884661153448, 11542.653720388234, 11551.595694150665, 16755.329786808634, 16978.660426791394, 17206.397776077778, 17371.652566948844, 17384.130793460277, 6945.40964018054, 7073.858522829514, 7103.751368702174, 7143.571385716874, 7147.178074521393, 746.4588173574115, 807.7132617920554, 880.3617377401333, 941.5574679900436, 970.2092794372705, 23958.401039974142, 24461.266162015167, 24628.507429851303, 24709.258722238363, 24793.380165495648, 819.2790344496924, 896.9057749545544, 899.7840518275567, 912.0970239462883, 918.169057003413, 11348.489317980711, 11848.88151118495, 11884.584039558575, 12029.218100823418, 12053.879461205452, 293938.0, 302441.0, 304619.0, 304752.0, 310765.0, 40229.597704023174, 41314.586854131674, 45914.540854591025, 46425.53574464212, 46592.534074659496, 1180.2682336951145, 1208.7884620191608, 1210.2073142091945, 1210.2496452199694, 1217.31221859649, 20782.27262045821, 23448.882755586113, 23961.52076958486, 24999.375015624755, 25172.993080276585, 43581.564184357754, 44914.0, 45320.0, 45640.771796140805, 45758.313625296316, 169587.15206423888, 169959.0, 170568.1471592634, 170697.0, 172447.0, 27012.59481107824, 27043.053493127645, 27046.1886143416, 27057.72942270552, 27293.72706272912, 32915.670843291264, 35869.0, 36258.8187059063, 36513.087172820895, 37206.6279337214, 25748.742512575383, 28118.859405703657, 29807.403851922405, 30554.694453055185, 30810.0, 27993.580096298978, 28188.43623127485, 28369.89969228356, 28636.0, 28731.42537149287, 29013.129606111004, 29170.27074323074, 29583.408331833674, 29646.703532964395, 29654.0, 23702.52594948057, 25440.74559254458, 27027.59458608083, 27218.727812722413, 27682.723172768016, 20546.589068218254, 20561.0, 20867.89566052221, 20913.163473460892, 20918.47703807417], "prototype.html": [238.6539517699336, 246.83955428971166, 255.81325632288429, 269.92846895572666, 276.7578368927189, 5062.772175252113, 5084.923726144101, 5116.948830511694, 5144.536991670749, 5160.14857548504, 4837.661363704542, 4918.336024636673, 4958.0, 4978.054169707753, 5051.722155281458, 3928.6464218220353, 3951.960480395188, 3960.5841386654274, 3998.860039898604, 4003.019260281228, 3947.0, 3993.8202780874785, 3999.8400063997406, 4002.0595160137345, 4005.6394924456795, 3769.0765762388255, 3795.69634429245, 3822.063594419371, 3868.845246190163, 3900.3564411872007, 3826.330392181357, 3838.0788610733503, 3867.9613203867884, 3878.7866667333287, 3894.0654242981623, 3272.214668479548, 3325.6508066652896, 3327.2680010397676, 3334.549835772188, 3335.1161942085123, 4879.194932836078, 4879.243717223836, 4915.680480768774, 4921.335619691332, 4952.182889823175, 4191.874243772691, 4218.8523401680795, 4302.634276086536, 4352.17308711347, 4401.449818772653, 5257.342832145981, 5290.947090529123, 5311.787528498855, 5315.574754019669, 5351.357837059539, 3632.654897784733, 3643.7995910224927, 3659.1949771050326, 3680.6687398134295, 3684.392075307571, 5524.806631767909, 5580.972095139539, 5608.579356548275, 5617.0, 5617.129344951539, 3519.982400087983, 3710.7588006779474, 3715.3869611514338, 3764.228333191689, 3784.3377408953324, 3420.793231723297, 3493.8602455901987, 3617.023403681044, 3632.146445585285, 3748.962510374916, 4280.785960701953, 4298.591633794785, 4307.590778876001, 4359.411479450297, 4367.0, 5303.602229832701, 5336.493033161843, 5356.892862142735, 5361.169018802092, 5383.892322153535, 1336.2984433172467, 1336.5522549945877, 1343.187371640163, 1356.7625665508497, 1360.3606305036617, 875.802944337519, 879.5030807593689, 899.0380293086334, 900.1718419054486, 909.9135582119688, 5054.570361519239, 5057.089723849743, 5160.716160611128, 5182.870428239325, 5185.844424667266, 5486.067368547357, 5501.504864562208, 5553.055980483327, 5568.7215639217875, 5582.078956972054, 4993.0762808879745, 5040.420351659533, 5067.847964561069, 5147.562457191106, 5187.06632806091, 2971.257185703574, 3030.9242268943453, 3039.407315573442, 3041.1788817019724, 3042.802217855832, 5573.498385145356, 5581.079121944834, 5599.300087489064, 5645.774169033275, 5653.632513886584, 5593.860153496195, 5626.718664066781, 5636.859078522988, 5645.604807663506, 5647.915281270784, 5502.0921547944945, 5573.665580065209, 5615.410381910004, 5641.294838145232, 5672.801451949244, 5490.313710786152, 5492.890142197213, 5514.751836167462, 5551.417101204477, 5562.694051827189, 5347.358317001985, 5413.566914646897, 5443.292371991616, 5472.151816468454, 5476.0690682584855, 5449.073657478159, 5561.944380556142, 5630.296212973379, 5631.239782629293, 5639.182318563868, 3510.1926556892568, 3522.6653467920505, 3543.2027793747234, 3566.286742651428, 3576.016595436172, 5502.174673798962, 5536.640118392292, 5553.972230138824, 5570.0, 5577.860553486195, 5407.567394608501, 5416.918746218888, 5438.102713052302, 5445.101558242845, 5467.917981230205, 5213.530782229617, 5383.353997520166, 5418.45815418455, 5449.972750136224, 5475.698836564027, 5247.921281180862, 5266.131088370376, 5289.206619007025, 5310.761015754378, 5321.308229930084, 5373.462653734595, 5447.264619276505, 5470.781168753205, 5472.0, 5493.478119578634, 5177.119889618699, 5282.049231138279, 5334.653247538898, 5347.144456886879, 5351.063563876384], "yui.html": [556.9164625306204, 560.4451592923004, 591.2963573347716, 593.7446897833935, 618.6999305336914, 11472.541098356067, 11582.884171158286, 11707.5902343418, 11862.051035917139, 11873.584424545143, 10819.188560857929, 10873.0, 10898.0, 10970.506327215275, 10973.067289280401, 596.7344531683414, 613.1354789746458, 622.7477871462065, 733.5158795195172, 746.1792028768339, 744.7505085796265, 746.138210367027, 746.3879618712658, 758.0600055930662, 758.6396461680686, 765.9080910290745, 767.3477544087536, 770.2066871122753, 771.8263390737068, 773.6711897443593, 610.4048552661164, 627.6422439209653, 748.1620584944842, 763.7555982085735, 774.2644487736673, 555.7193617223277, 557.5233175634814, 557.5400294756802, 557.9358373786986, 566.2101368590793, 11350.659480215607, 11359.545618175263, 11360.147988900782, 11514.30914145154, 11547.307161570248, 7761.689532418696, 7909.327707144899, 8065.072516660601, 8237.135100814388, 8469.110743371919, 7591.772246832604, 7668.194839541824, 7767.37860971121, 7771.378289736807, 8003.239692229229, 2397.7292035221185, 2435.866027368494, 2439.78041976223, 2555.9488810223693, 2568.9980907445924, 38745.806270968744, 39888.40167397491, 40017.79991100055, 40164.79917600423, 40178.799106004575, 5859.5019423349495, 5890.764369425261, 5923.437273459014, 6064.211652485149, 6153.323134455206, 10169.288149829441, 10231.539580718885, 10285.794284114276, 10318.329308594917, 10376.636817711344, 5127.487251274917, 5290.788368465218, 5312.993161493957, 5376.865578360573, 5479.671219726829, 3068.3249685069695, 3166.4142133704877, 3169.793963392372, 3176.7776255661884, 3223.46812775894, 2193.605151072822, 2232.0, 2250.00999560193, 2254.4476603231983, 2259.1076524772625, 343.42990635544874, 343.77482748799576, 344.5434798891479, 345.94637831136214, 348.4442314508355, 429.02611072865045, 440.94929083155205, 451.96500014966017, 477.8160408242782, 510.52521155325906, 5902.321233058254, 6070.453659170696, 6151.046587778812, 6155.10750941111, 6241.625502469867, 395.97228194026144, 415.42048841865426, 427.79252062749543, 481.94698583155827, 498.09346988481343, 2881.394907069497, 2928.0776555384987, 3013.7136971987625, 3022.440848443045, 3023.7732170087334, 48978.5102148974, 49306.50693493091, 49380.0, 49891.750541247064, 51092.489075109515, 43274.56725432768, 43468.565314347084, 43573.0, 43596.564034359886, 44179.77910110429, 40665.796671016455, 41218.79390603088, 41641.0, 41900.580994189666, 42188.0, 5936.554758393224, 6022.36765139654, 6088.36072212429, 6114.908276375769, 6595.307492713388, 31785.0, 32069.679303207602, 32123.839380802947, 32348.514772277966, 32617.510737339435, 42574.148517028865, 43704.34443483287, 44931.0, 45020.54979450163, 45627.54372456233, 8884.60019299146, 9087.182153606207, 9390.060993900555, 9516.809663806824, 9887.357321774061, 9330.30022748283, 9491.335606507479, 9500.47747373901, 9622.16121786873, 10265.922078181684, 8889.866652000095, 9021.233195178484, 9092.909070909207, 9211.170994610517, 9313.161815436371, 9020.819583608421, 9089.863652045357, 9140.908590914005, 9252.768680782765, 9254.0, 8818.559072046244, 8850.0, 8875.334349923653, 9008.234300084567, 9092.90907090947, 7789.0, 7799.571023593757, 7875.684972601031, 7990.320822730133, 8160.918390816016, 7694.923050769421, 7844.254795794619, 7850.293473587404, 8053.6778528858185, 8089.716859909875]}, "summary": {"suite": 5495.640920493215, "subtests": {"jquery.html": {"filtered": 5589.585768262744, "value": 5589.585768262744}, "dojo.html": {"filtered": 4492.184328511538, "value": 4492.184328511538}, "mootools.html": {"filtered": 3533.448304566504, "value": 3533.448304566504}, "ext.html": {"filtered": 15771.30856298006, "value": 15771.30856298006}, "prototype.html": {"filtered": 4003.672399881396, "value": 4003.672399881396}, "yui.html": {"filtered": 4917.002630172768, "value": 4917.002630172768}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1448937209, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151130165432", "branch": "Mozilla-Aurora", "revision": "f6ecc28fba3dda2cb62312b51ca1e305abacd442"}}, {"talos_counters": {}, "results": {"audio-dft": [196.0, 196.0, 196.0, 196.0, 196.0, 198.0, 198.0, 197.0, 197.0, 205.0], "ai-astar": [129.0, 136.0, 124.0, 131.0, 134.0, 135.0, 118.0, 134.0, 130.0, 119.0], "imaging-gaussian-blur": [150.0, 156.0, 143.0, 141.0, 142.0, 142.0, 148.0, 148.0, 141.0, 149.0], "audio-beat-detection": [185.0, 167.0, 202.0, 186.0, 155.0, 177.0, 157.0, 201.0, 187.0, 155.0], "json-stringify-tinderbox": [77.0, 81.0, 81.0, 85.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0], "stanford-crypto-pbkdf2": [174.0, 179.0, 177.0, 178.0, 178.0, 178.0, 184.0, 184.0, 176.0, 181.0], "json-parse-financial": [64.0, 75.0, 78.0, 77.0, 80.0, 78.0, 77.0, 86.0, 71.0, 72.0], "stanford-crypto-sha256-iterative": [79.0, 81.0, 84.0, 83.0, 83.0, 83.0, 84.0, 83.0, 83.0, 84.0], "audio-fft": [98.0, 94.0, 92.0, 148.0, 84.0, 88.0, 88.0, 82.0, 142.0, 84.0], "imaging-darkroom": [154.0, 153.0, 154.0, 153.0, 154.0, 170.0, 175.0, 162.0, 158.0, 154.0], "stanford-crypto-ccm": [150.0, 151.0, 163.0, 155.0, 153.0, 154.0, 148.0, 157.0, 161.0, 160.0], "audio-oscillator": [117.0, 120.0, 167.0, 108.0, 110.0, 110.0, 154.0, 113.0, 112.0, 153.0], "stanford-crypto-aes": [95.0, 100.0, 101.0, 105.0, 104.0, 103.0, 99.0, 101.0, 102.0, 105.0], "imaging-desaturate": [124.0, 129.0, 130.0, 127.0, 124.0, 123.0, 130.0, 129.0, 129.0, 125.0]}, "summary": {"suite": 1837.6000000000001, "subtests": {"audio-fft": {"filtered": 100.0, "value": 100.0}, "stanford-crypto-pbkdf2": {"filtered": 178.9, "value": 178.9}, "audio-beat-detection": {"filtered": 177.2, "value": 177.2}, "stanford-crypto-ccm": {"filtered": 155.2, "value": 155.2}, "imaging-darkroom": {"filtered": 158.7, "value": 158.7}, "json-parse-financial": {"filtered": 75.8, "value": 75.8}, "audio-oscillator": {"filtered": 126.4, "value": 126.4}, "ai-astar": {"filtered": 129.0, "value": 129.0}, "audio-dft": {"filtered": 197.5, "value": 197.5}, "stanford-crypto-sha256-iterative": {"filtered": 82.7, "value": 82.7}, "json-stringify-tinderbox": {"filtered": 81.7, "value": 81.7}, "imaging-gaussian-blur": {"filtered": 146.0, "value": 146.0}, "stanford-crypto-aes": {"filtered": 101.5, "value": 101.5}, "imaging-desaturate": {"filtered": 127.0, "value": 127.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1448937209, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151130165432", "branch": "Mozilla-Aurora", "revision": "f6ecc28fba3dda2cb62312b51ca1e305abacd442"}}, {"talos_counters": {}, "results": {"DeltaBlue": [238.49272597185785], "Encrypt": [382.84839203675347], "NavierStokes": [6972.222222222223], "Decrypt": [6972.222222222223], "Splay": [696.8641114982578], "Richards": [199.96000799840033], "RegExp": [34931.03448275862], "Earley": [836.8200836820083], "Boyer": [14955.223880597016], "RayTrace": [1253.1328320802006]}, "summary": {"suite": 16867.57897922326, "subtests": {"DeltaBlue": {"filtered": 277.2327740000001, "value": 277.2327740000001}, "Encrypt": {"filtered": 695.2647719999998, "value": 695.2647719999998}, "NavierStokes": {"filtered": 212.8446215139441, "value": 212.8446215139441}, "Decrypt": {"filtered": 38.177354581673285, "value": 38.177354581673285}, "Splay": {"filtered": 116.93958500000001, "value": 116.93958500000001}, "RegExp": {"filtered": 26.079531095755197, "value": 26.079531095755197}, "Richards": {"filtered": 176.54530200000002, "value": 176.54530200000002}, "Earley": {"filtered": 796.423285, "value": 796.423285}, "Boyer": {"filtered": 44.56389321357285, "value": 44.56389321357285}, "RayTrace": {"filtered": 590.5112220000001, "value": 590.5112220000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0095"}, "testrun": {"date": 1448937209, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151130165432", "branch": "Mozilla-Aurora", "revision": "f6ecc28fba3dda2cb62312b51ca1e305abacd442"}}] 18:53:48 INFO - RETURN: dromaeo_css: 5495.64 18:53:48 INFO - RETURN: kraken: 1837.60 18:53:48 INFO - RETURN: v8_7: 16867.58 18:53:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "16867.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1837.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5495.64"}}} 18:53:48 INFO - Return code: 0 18:53:48 INFO - # TBPL SUCCESS # 18:53:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:53:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:53:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:53:48 INFO - 2015-11-30 18:53:48.604 screenresolution[1654:9863] starting screenresolution argv=screenresolution get 18:53:48 INFO - 2015-11-30 18:53:48.607 screenresolution[1654:9863] Display 0: 1600x1200x32@60 18:53:48 INFO - 2015-11-30 18:53:48.614 screenresolution[1655:9866] starting screenresolution argv=screenresolution list 18:53:48 INFO - Available Modes on Display 0 18:53:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:53:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:53:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:53:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:53:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:53:48 INFO - Intel HD Graphics 3000: 18:53:48 INFO - Chipset Model: Intel HD Graphics 3000 18:53:48 INFO - Type: GPU 18:53:48 INFO - Bus: Built-In 18:53:48 INFO - VRAM (Total): 512 MB 18:53:48 INFO - VRAM (Dynamic, Max): 10 18:53:48 INFO - Vendor: Intel (0x8086) 18:53:48 INFO - Device ID: 0x0116 18:53:48 INFO - Revision ID: 0x0009 18:53:48 INFO - Displays: 18:53:48 INFO - Display: 18:53:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:53:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:53:48 INFO - Display Serial Number: 1600x1200 60 18:53:48 INFO - Main Display: Yes 18:53:48 INFO - Mirror: Off 18:53:48 INFO - Online: Yes 18:53:48 INFO - Rotation: Supported 18:53:48 INFO - Return code: 0 18:53:48 INFO - Running post-action listener: _resource_record_post_action 18:53:48 INFO - Running post-run listener: _resource_record_post_run 18:53:49 INFO - Total resource usage - Wall time: 1263s; CPU: 30.0%; Read bytes: 39093248; Write bytes: 686809088; Read time: 4076; Write time: 52181 18:53:49 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 339995136; Write bytes: 334575616; Read time: 38425; Write time: 6133 18:53:50 INFO - run-tests - Wall time: 1220s; CPU: 30.0%; Read bytes: 37135360; Write bytes: 342091776; Read time: 3524; Write time: 45060 18:53:50 INFO - Running post-run listener: _upload_blobber_files 18:53:50 INFO - Blob upload gear active. 18:53:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:53:50 INFO - Copying logs to upload dir... 18:53:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1332.993314 ========= master_lag: 3.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 16 secs) (at 2015-11-30 18:53:53.445415) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 18:53:53.446588) ========= 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.LDbbcpRbAv/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.40bAtIXZhN/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/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010632 build_url: 'https://queue.taskcluster.net/v1/task/5uzhA4XoQpeRSvI9dlr6sw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.19 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 18:53:53.650070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 18:53:53.650441) ========= 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.LDbbcpRbAv/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.40bAtIXZhN/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.005961 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 18:53:53.675194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 18:53:53.675541) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 18:53:53.675992) ========= ========= Total master_lag: 4.00 =========