builder: mozilla-aurora_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0037 starttime: 1449012772.61 results: success (0) buildid: 20151201142430 builduid: 769d0d92c71042a2b930308744082032 revision: 6c630e37e53f15976e1bdad36852e74fd073f3f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.615011) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.615426) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.615747) ========= 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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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.005834 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.643061) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.643391) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.667156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.667676) ========= 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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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.004950 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.720253) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.720575) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.721153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:52.721490) ========= 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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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-12-01 15:32:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.40M=0.002s 2015-12-01 15:32:53 (7.40 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.349041 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.081425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.081745) ========= 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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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.019821 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.132230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.132714) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c630e37e53f15976e1bdad36852e74fd073f3f7 --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 6c630e37e53f15976e1bdad36852e74fd073f3f7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cWzKmPdfEL/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.AOTyCkEzE5/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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-12-01 15:32:53,213 truncating revision to first 12 chars 2015-12-01 15:32:53,213 Setting DEBUG logging. 2015-12-01 15:32:53,213 attempt 1/10 2015-12-01 15:32:53,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6c630e37e53f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-01 15:32:53,538 unpacking tar archive at: mozilla-aurora-6c630e37e53f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.719637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.719966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.728364) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.728650) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 15:32:53.729080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-12-01 15:32:53.729415) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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 15:32:53 INFO - MultiFileLogger online at 20151201 15:32:53 in /builds/slave/test 15:32:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:32:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:32:53 INFO - {'append_to_log': False, 15:32:53 INFO - 'base_work_dir': '/builds/slave/test', 15:32:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:32:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:32:53 INFO - 'branch': 'Mozilla-Aurora', 15:32:53 INFO - 'buildbot_json_path': 'buildprops.json', 15:32:53 INFO - 'config_files': ('talos/mac_config.py',), 15:32:53 INFO - 'default_actions': ('clobber', 15:32:53 INFO - 'read-buildbot-config', 15:32:53 INFO - 'download-and-extract', 15:32:53 INFO - 'populate-webroot', 15:32:53 INFO - 'create-virtualenv', 15:32:53 INFO - 'install', 15:32:53 INFO - 'run-tests'), 15:32:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:32:53 INFO - 'download_minidump_stackwalk': True, 15:32:53 INFO - 'download_symbols': 'ondemand', 15:32:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:32:53 INFO - 'tooltool.py': '/tools/tooltool.py', 15:32:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:32:53 INFO - '/tools/misc-python/virtualenv.py')}, 15:32:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:32:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:32:53 INFO - 'installer_path': 'installer.exe', 15:32:53 INFO - 'log_level': 'info', 15:32:53 INFO - 'log_name': 'talos', 15:32:53 INFO - 'log_to_console': True, 15:32:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:32:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:32:53 INFO - 'opt_config_files': (), 15:32:53 INFO - 'pip_index': False, 15:32:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:32:53 INFO - 'cmd': ('bash', 15:32:53 INFO - '-c', 15:32:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:32:53 INFO - 'enabled': True, 15:32:53 INFO - 'halt_on_failure': False, 15:32:53 INFO - 'name': 'check_screen_resolution'},), 15:32:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:32:53 INFO - 'cmd': ('bash', 15:32:53 INFO - '-c', 15:32:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:32:53 INFO - 'enabled': True, 15:32:53 INFO - 'halt_on_failure': False, 15:32:53 INFO - 'name': 'check_screen_resolution'},), 15:32:53 INFO - 'run_cmd_checks_enabled': True, 15:32:53 INFO - 'sps_profile': False, 15:32:53 INFO - 'sps_profile_interval': 0, 15:32:53 INFO - 'suite': 'dromaeojs-e10s', 15:32:53 INFO - 'system_bits': '64', 15:32:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:32:53 INFO - 'title': 't-yosemite-r5-0037', 15:32:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:32:53 INFO - 'use_talos_json': True, 15:32:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:32:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:32:53 INFO - 'work_dir': 'build'} 15:32:53 INFO - ##### 15:32:53 INFO - ##### Running clobber step. 15:32:53 INFO - ##### 15:32:53 INFO - Running pre-action listener: _resource_record_pre_action 15:32:53 INFO - Running main action method: clobber 15:32:53 INFO - rmtree: /builds/slave/test/build 15:32:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:32:56 INFO - Running post-action listener: _resource_record_post_action 15:32:56 INFO - ##### 15:32:56 INFO - ##### Running read-buildbot-config step. 15:32:56 INFO - ##### 15:32:56 INFO - Running pre-action listener: _resource_record_pre_action 15:32:56 INFO - Running main action method: read_buildbot_config 15:32:56 INFO - Using buildbot properties: 15:32:56 INFO - { 15:32:56 INFO - "properties": { 15:32:56 INFO - "buildnumber": 1, 15:32:56 INFO - "product": "firefox", 15:32:56 INFO - "script_repo_revision": "production", 15:32:56 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs-e10s", 15:32:56 INFO - "repository": "", 15:32:56 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs-e10s", 15:32:56 INFO - "buildid": "20151201142430", 15:32:56 INFO - "slavename": "t-yosemite-r5-0037", 15:32:56 INFO - "pgo_build": "False", 15:32:56 INFO - "basedir": "/builds/slave/test", 15:32:56 INFO - "project": "", 15:32:56 INFO - "platform": "yosemite", 15:32:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:32:56 INFO - "slavebuilddir": "test", 15:32:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:32:56 INFO - "branch": "mozilla-aurora", 15:32:56 INFO - "repo_path": "releases/mozilla-aurora", 15:32:56 INFO - "stage_platform": "macosx64", 15:32:56 INFO - "builduid": "769d0d92c71042a2b930308744082032", 15:32:56 INFO - "revision": "6c630e37e53f15976e1bdad36852e74fd073f3f7" 15:32:56 INFO - }, 15:32:56 INFO - "sourcestamp": { 15:32:56 INFO - "repository": "", 15:32:56 INFO - "hasPatch": false, 15:32:56 INFO - "project": "", 15:32:56 INFO - "branch": "mozilla-aurora-macosx64-talos", 15:32:56 INFO - "changes": [ 15:32:56 INFO - { 15:32:56 INFO - "category": null, 15:32:56 INFO - "files": [ 15:32:56 INFO - { 15:32:56 INFO - "url": null, 15:32:56 INFO - "name": "https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 15:32:56 INFO - } 15:32:56 INFO - ], 15:32:56 INFO - "repository": "", 15:32:56 INFO - "rev": "6c630e37e53f15976e1bdad36852e74fd073f3f7", 15:32:56 INFO - "who": "kwierso@gmail.com", 15:32:56 INFO - "when": 1449012745, 15:32:56 INFO - "number": 6730059, 15:32:56 INFO - "comments": "Bug 1119062 - enable unicode-range load test under Linux. r=dbaron a=ritu", 15:32:56 INFO - "project": "", 15:32:56 INFO - "at": "Tue 01 Dec 2015 15:32:25", 15:32:56 INFO - "branch": "mozilla-aurora-macosx64-talos", 15:32:56 INFO - "revlink": "", 15:32:56 INFO - "properties": [ 15:32:56 INFO - [ 15:32:56 INFO - "buildid", 15:32:56 INFO - "20151201142430", 15:32:56 INFO - "Change" 15:32:56 INFO - ], 15:32:56 INFO - [ 15:32:56 INFO - "builduid", 15:32:56 INFO - "769d0d92c71042a2b930308744082032", 15:32:56 INFO - "Change" 15:32:56 INFO - ], 15:32:56 INFO - [ 15:32:56 INFO - "pgo_build", 15:32:56 INFO - "False", 15:32:56 INFO - "Change" 15:32:56 INFO - ] 15:32:56 INFO - ], 15:32:56 INFO - "revision": "6c630e37e53f15976e1bdad36852e74fd073f3f7" 15:32:56 INFO - } 15:32:56 INFO - ], 15:32:56 INFO - "revision": "6c630e37e53f15976e1bdad36852e74fd073f3f7" 15:32:56 INFO - } 15:32:56 INFO - } 15:32:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 15:32:56 INFO - Running post-action listener: _resource_record_post_action 15:32:56 INFO - ##### 15:32:56 INFO - ##### Running download-and-extract step. 15:32:56 INFO - ##### 15:32:56 INFO - Running pre-action listener: _resource_record_pre_action 15:32:56 INFO - Running main action method: download_and_extract 15:32:56 INFO - mkdir: /builds/slave/test/build/tests 15:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:56 INFO - https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:32:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/test_packages.json 15:32:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/test_packages.json 15:32:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:32:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:33:01 INFO - Downloaded 1149 bytes. 15:33:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:33:01 INFO - Using the following test package requirements: 15:33:01 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:33:01 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:33:01 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 15:33:01 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:33:01 INFO - u'jsshell-mac.zip'], 15:33:01 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:33:01 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 15:33:01 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:33:01 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:33:01 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 15:33:01 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:33:01 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 15:33:01 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:33:01 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 15:33:01 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:33:01 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:33:01 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 15:33:01 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:33: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')]} 15:33:01 INFO - https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:33:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:33:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:33:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/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 15:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/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 15:33:02 INFO - Downloaded 17490075 bytes. 15:33:02 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 15:33:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:33:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 15:33:08 INFO - Return code: 0 15:33:08 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 15:33:08 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')]} 15:33:08 INFO - https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:33:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:33:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:33:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/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 15:33:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/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 15:33:11 INFO - Downloaded 17490075 bytes. 15:33:11 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 15:33:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:33:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 15:33:16 INFO - Return code: 0 15:33: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')]} 15:33:16 INFO - https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:33:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 15:33:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 15:33:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/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 15:33:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/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 15:33:17 INFO - Downloaded 11131307 bytes. 15:33:17 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 15:33:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 15:33:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:33:18 INFO - Return code: 0 15:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:18 INFO - https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 15:33:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 15:33:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 15:33:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 15:33:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/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 15:33:24 INFO - Downloaded 108651913 bytes. 15:33:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 15:33:24 INFO - mkdir: /builds/slave/test/properties 15:33:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:33:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:33:24 INFO - Contents: 15:33:24 INFO - build_url:https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 15:33:24 INFO - Running post-action listener: _resource_record_post_action 15:33:24 INFO - Running post-action listener: set_extra_try_arguments 15:33:24 INFO - ##### 15:33:24 INFO - ##### Running populate-webroot step. 15:33:24 INFO - ##### 15:33:24 INFO - Running pre-action listener: _resource_record_pre_action 15:33:24 INFO - Running main action method: populate_webroot 15:33:24 INFO - Guessing talos json url... 15:33:24 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')]} 15:33:24 INFO - https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 15:33:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 15:33:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 15:33:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 15:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0--mZNIRxeOdcq7F5S8RQ/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 15:33:25 INFO - Downloaded 107 bytes. 15:33:25 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 15:33:25 INFO - Contents: 15:33:25 INFO - 20151201142430 15:33:25 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/6c630e37e53f15976e1bdad36852e74fd073f3f7 15:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:25 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/6c630e37e5/testing/talos/talos.json 15:33:25 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/6c630e37e5/testing/talos/talos.json to /builds/slave/test/build/talos.json 15:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/6c630e37e5/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 15:33:25 INFO - Downloaded 4264 bytes. 15:33:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:33:25 INFO - '../fennec_ids.txt'], 15:33:25 INFO - 'tests': ['tcheck2']}, 15:33:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:25 INFO - '--tppagecycles', 15:33:25 INFO - '7'], 15:33:25 INFO - 'tests': ['tsvgm']}}, 15:33:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:33:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:33:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:33:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'tests': ['damp', 'tps']}, 15:33:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['damp', 'tps']}, 15:33:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:33:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:25 INFO - 'other': {'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore']}, 15:33:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore']}, 15:33:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore']}, 15:33:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore']}, 15:33:25 INFO - 'other_l64': {'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore']}, 15:33:25 INFO - 'other_nol64': {'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore']}, 15:33:25 INFO - 'svgr': {'tests': ['tsvgx', 15:33:25 INFO - 'tsvgr_opacity', 15:33:25 INFO - 'tart', 15:33:25 INFO - 'tscrollx', 15:33:25 INFO - 'cart']}, 15:33:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['tsvgx', 15:33:25 INFO - 'tsvgr_opacity', 15:33:25 INFO - 'tart', 15:33:25 INFO - 'tscrollx', 15:33:25 INFO - 'cart']}, 15:33:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'tests': ['tp5o']}, 15:33:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--e10s'], 15:33:25 INFO - 'tests': ['tp5o']}, 15:33:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--xperf_path', 15:33:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:25 INFO - 'tests': ['tp5n']}, 15:33:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--e10s', 15:33:25 INFO - '--xperf_path', 15:33:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 15:33:25 INFO - 'C:/slave/talos-data/talos/xperf.config'], 15:33:25 INFO - 'tests': ['tp5n']}}, 15:33:25 INFO - 'talos.zip': {'path': '', 15:33:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:25 INFO - Running post-action listener: _resource_record_post_action 15:33:25 INFO - ##### 15:33:25 INFO - ##### Running create-virtualenv step. 15:33:25 INFO - ##### 15:33:25 INFO - Running pre-action listener: _resource_record_pre_action 15:33:25 INFO - Running main action method: create_virtualenv 15:33:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:33:25 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 15:33:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:33:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:26 INFO - Using real prefix '/tools/python27' 15:33:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:33:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:30 INFO - Installing pip.................done. 15:33:30 INFO - Return code: 0 15:33:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:33:30 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')]} 15:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:30 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')]} 15:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:30 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 0x10318da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba1e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031429f0>, '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 0x102ea1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10310c990>, '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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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 15:33:30 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 15:33:30 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 15:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWzKmPdfEL/Render', 15:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:30 INFO - 'HOME': '/Users/cltbld', 15:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:30 INFO - 'LOGNAME': 'cltbld', 15:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:30 INFO - 'MOZ_NO_REMOTE': '1', 15:33:30 INFO - 'NO_EM_RESTART': '1', 15:33:30 INFO - 'PAGER': '/bin/cat', 15:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:30 INFO - 'PWD': '/builds/slave/test', 15:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:30 INFO - 'SHELL': '/bin/bash', 15:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AOTyCkEzE5/Listeners', 15:33:30 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 15:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:30 INFO - 'USER': 'cltbld', 15:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:30 INFO - 'XPC_FLAGS': '0x0', 15:33:30 INFO - 'XPC_SERVICE_NAME': '0', 15:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:30 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 15:33:30 INFO - Cleaning up... 15:33:30 INFO - Return code: 0 15:33:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:33:30 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')]} 15:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:30 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')]} 15:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:30 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 0x10318da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba1e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031429f0>, '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 0x102ea1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10310c990>, '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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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 15:33:30 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 15:33:30 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 15:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWzKmPdfEL/Render', 15:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:30 INFO - 'HOME': '/Users/cltbld', 15:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:30 INFO - 'LOGNAME': 'cltbld', 15:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:30 INFO - 'MOZ_NO_REMOTE': '1', 15:33:30 INFO - 'NO_EM_RESTART': '1', 15:33:30 INFO - 'PAGER': '/bin/cat', 15:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:30 INFO - 'PWD': '/builds/slave/test', 15:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:30 INFO - 'SHELL': '/bin/bash', 15:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AOTyCkEzE5/Listeners', 15:33:30 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 15:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:30 INFO - 'USER': 'cltbld', 15:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:30 INFO - 'XPC_FLAGS': '0x0', 15:33:30 INFO - 'XPC_SERVICE_NAME': '0', 15:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:30 INFO - Downloading/unpacking psutil>=0.7.1 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:33 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:33:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:33 INFO - Installing collected packages: psutil 15:33:33 INFO - Running setup.py install for psutil 15:33:33 INFO - building 'psutil._psutil_osx' extension 15:33:33 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 15:33:33 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 15:33:33 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 15:33:34 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 15:33:34 INFO - building 'psutil._psutil_posix' extension 15:33:34 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 15:33:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:33:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:33:34 INFO - ^ 15:33:34 INFO - 1 warning generated. 15:33:34 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 15:33:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:34 INFO - Successfully installed psutil 15:33:34 INFO - Cleaning up... 15:33:34 INFO - Return code: 0 15:33:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:33:34 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')]} 15:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:34 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')]} 15:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:34 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 0x10318da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba1e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031429f0>, '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 0x102ea1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10310c990>, '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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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 15:33:34 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 15:33:34 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 15:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWzKmPdfEL/Render', 15:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:34 INFO - 'HOME': '/Users/cltbld', 15:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:34 INFO - 'LOGNAME': 'cltbld', 15:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:34 INFO - 'MOZ_NO_REMOTE': '1', 15:33:34 INFO - 'NO_EM_RESTART': '1', 15:33:34 INFO - 'PAGER': '/bin/cat', 15:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:34 INFO - 'PWD': '/builds/slave/test', 15:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:34 INFO - 'SHELL': '/bin/bash', 15:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AOTyCkEzE5/Listeners', 15:33:34 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 15:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:34 INFO - 'USER': 'cltbld', 15:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:34 INFO - 'XPC_FLAGS': '0x0', 15:33:34 INFO - 'XPC_SERVICE_NAME': '0', 15:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:33:34 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 15:33:34 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 15:33:34 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 15:33:34 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 15:33:34 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 15:33:34 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 15:33:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:33:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:33:37 INFO - Installing collected packages: mozsystemmonitor 15:33:37 INFO - Running setup.py install for mozsystemmonitor 15:33:37 INFO - Successfully installed mozsystemmonitor 15:33:37 INFO - Cleaning up... 15:33:37 INFO - Return code: 0 15:33:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10318da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba1e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031429f0>, '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 0x102ea1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10310c990>, '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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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 15:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWzKmPdfEL/Render', 15:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:37 INFO - 'HOME': '/Users/cltbld', 15:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:37 INFO - 'LOGNAME': 'cltbld', 15:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:37 INFO - 'MOZ_NO_REMOTE': '1', 15:33:37 INFO - 'NO_EM_RESTART': '1', 15:33:37 INFO - 'PAGER': '/bin/cat', 15:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:37 INFO - 'PWD': '/builds/slave/test', 15:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:37 INFO - 'SHELL': '/bin/bash', 15:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AOTyCkEzE5/Listeners', 15:33:37 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 15:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:37 INFO - 'USER': 'cltbld', 15:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:37 INFO - 'XPC_FLAGS': '0x0', 15:33:37 INFO - 'XPC_SERVICE_NAME': '0', 15:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:41 INFO - Downloading docopt-0.6.1.tar.gz 15:33:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:41 INFO - Running setup.py install for blobuploader 15:33:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:41 INFO - Running setup.py install for requests 15:33:42 INFO - Running setup.py install for docopt 15:33:42 INFO - Successfully installed blobuploader requests docopt 15:33:42 INFO - Cleaning up... 15:33:42 INFO - Return code: 0 15:33:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:42 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 0x10318da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba1e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031429f0>, '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 0x102ea1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10310c990>, '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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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 15:33:42 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 15:33:42 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 15:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWzKmPdfEL/Render', 15:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:42 INFO - 'HOME': '/Users/cltbld', 15:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:42 INFO - 'LOGNAME': 'cltbld', 15:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:42 INFO - 'MOZ_NO_REMOTE': '1', 15:33:42 INFO - 'NO_EM_RESTART': '1', 15:33:42 INFO - 'PAGER': '/bin/cat', 15:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:42 INFO - 'PWD': '/builds/slave/test', 15:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:42 INFO - 'SHELL': '/bin/bash', 15:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AOTyCkEzE5/Listeners', 15:33:42 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 15:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:42 INFO - 'USER': 'cltbld', 15:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:42 INFO - 'XPC_FLAGS': '0x0', 15:33:42 INFO - 'XPC_SERVICE_NAME': '0', 15:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:42 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-40jU7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:43 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-9YboAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:43 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-7NYmMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:43 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-8BHFld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:43 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-1lYfPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:43 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-Misnqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:43 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-LdBIet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:43 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-ujFm7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:43 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-mA8519-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:44 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-083SvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:44 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-kWjRbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:44 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-Ty7Cho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:44 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-yRe3GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:44 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-g2vQEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:44 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-TZnWNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:44 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-ZhKaK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:44 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-GePEla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:45 INFO - Running setup.py install for manifestparser 15:33:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Running setup.py install for mozcrash 15:33:45 INFO - Running setup.py install for mozdebug 15:33:45 INFO - Running setup.py install for mozdevice 15:33:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Running setup.py install for mozfile 15:33:45 INFO - Running setup.py install for mozhttpd 15:33:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Running setup.py install for mozinfo 15:33:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Running setup.py install for mozInstall 15:33:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Running setup.py install for mozleak 15:33:46 INFO - Running setup.py install for mozlog 15:33:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Running setup.py install for moznetwork 15:33:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Running setup.py install for mozprocess 15:33:47 INFO - Running setup.py install for mozprofile 15:33:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:47 INFO - Running setup.py install for mozrunner 15:33:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:47 INFO - Running setup.py install for mozscreenshot 15:33:47 INFO - Running setup.py install for moztest 15:33:47 INFO - Running setup.py install for mozversion 15:33:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:48 INFO - Cleaning up... 15:33:48 INFO - Return code: 0 15:33:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:48 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')]} 15:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:48 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')]} 15:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:48 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 0x10318da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba1e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031429f0>, '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 0x102ea1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10310c990>, '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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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 15:33:48 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 15:33:48 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 15:33:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWzKmPdfEL/Render', 15:33:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:48 INFO - 'HOME': '/Users/cltbld', 15:33:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:48 INFO - 'LOGNAME': 'cltbld', 15:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:48 INFO - 'MOZ_NO_REMOTE': '1', 15:33:48 INFO - 'NO_EM_RESTART': '1', 15:33:48 INFO - 'PAGER': '/bin/cat', 15:33:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:48 INFO - 'PWD': '/builds/slave/test', 15:33:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:48 INFO - 'SHELL': '/bin/bash', 15:33:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AOTyCkEzE5/Listeners', 15:33:48 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 15:33:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:48 INFO - 'USER': 'cltbld', 15:33:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:48 INFO - 'XPC_FLAGS': '0x0', 15:33:48 INFO - 'XPC_SERVICE_NAME': '0', 15:33:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:48 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-BmwUdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:48 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)) 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:48 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-NlSUfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:48 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)) 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:48 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-q8AbyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:48 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)) 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:48 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-WQjhzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:48 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)) 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:48 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-3lzQHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:49 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)) 15:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:49 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-Oc6wXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:49 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)) 15:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:49 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-UIpvKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:49 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)) 15:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:49 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-Bx7oSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:49 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)) 15:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:49 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-doXQMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:49 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)) 15:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:49 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-0BaXBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:49 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)) 15:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:49 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-c8q80Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:49 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)) 15:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:49 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-8SaRSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:49 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)) 15:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:49 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-0kNttx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:50 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)) 15:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:50 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-DAnFSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:50 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)) 15:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:50 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-RZa_0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:50 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)) 15:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:50 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-I7iCzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:50 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)) 15:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:50 INFO - Running setup.py (path:/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/pip-qfu3kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:50 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)) 15:33:50 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)) 15:33:50 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)) 15:33:50 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)) 15:33:50 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)) 15:33:50 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)) 15:33:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:53 INFO - Downloading blessings-1.5.1.tar.gz 15:33:53 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 15:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:53 INFO - Installing collected packages: blessings 15:33:53 INFO - Running setup.py install for blessings 15:33:53 INFO - Successfully installed blessings 15:33:53 INFO - Cleaning up... 15:33:53 INFO - Return code: 0 15:33:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:53 INFO - Reading from file tmpfile_stdout 15:33:53 INFO - Current package versions: 15:33:53 INFO - blessings == 1.5.1 15:33:53 INFO - blobuploader == 1.2.4 15:33:53 INFO - docopt == 0.6.1 15:33:53 INFO - manifestparser == 1.1 15:33:53 INFO - mozInstall == 1.12 15:33:53 INFO - mozcrash == 0.16 15:33:53 INFO - mozdebug == 0.1 15:33:53 INFO - mozdevice == 0.46 15:33:53 INFO - mozfile == 1.2 15:33:53 INFO - mozhttpd == 0.7 15:33:53 INFO - mozinfo == 0.8 15:33:53 INFO - mozleak == 0.1 15:33:53 INFO - mozlog == 3.0 15:33:53 INFO - moznetwork == 0.27 15:33:53 INFO - mozprocess == 0.22 15:33:53 INFO - mozprofile == 0.27 15:33:53 INFO - mozrunner == 6.11 15:33:53 INFO - mozscreenshot == 0.1 15:33:53 INFO - mozsystemmonitor == 0.0 15:33:53 INFO - moztest == 0.7 15:33:53 INFO - mozversion == 1.4 15:33:53 INFO - psutil == 3.1.1 15:33:53 INFO - requests == 1.2.3 15:33:53 INFO - wsgiref == 0.1.2 15:33:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:53 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 0x10318da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba1e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031429f0>, '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 0x102ea1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10310c990>, '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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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 15:33:53 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 15:33:53 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 15:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWzKmPdfEL/Render', 15:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:53 INFO - 'HOME': '/Users/cltbld', 15:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:53 INFO - 'LOGNAME': 'cltbld', 15:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:53 INFO - 'MOZ_NO_REMOTE': '1', 15:33:53 INFO - 'NO_EM_RESTART': '1', 15:33:53 INFO - 'PAGER': '/bin/cat', 15:33:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:53 INFO - 'PWD': '/builds/slave/test', 15:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:53 INFO - 'SHELL': '/bin/bash', 15:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AOTyCkEzE5/Listeners', 15:33:53 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 15:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:53 INFO - 'USER': 'cltbld', 15:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:53 INFO - 'XPC_FLAGS': '0x0', 15:33:53 INFO - 'XPC_SERVICE_NAME': '0', 15:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 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)) 15:33:54 INFO - Cleaning up... 15:33:54 INFO - Return code: 0 15:33:54 INFO - Running post-action listener: _resource_record_post_action 15:33:54 INFO - Running post-action listener: _start_resource_monitoring 15:33:54 INFO - Starting resource monitoring. 15:33:54 INFO - ##### 15:33:54 INFO - ##### Running install step. 15:33:54 INFO - ##### 15:33:54 INFO - Running pre-action listener: _resource_record_pre_action 15:33:54 INFO - Running main action method: install 15:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:54 INFO - Reading from file tmpfile_stdout 15:33:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:33:54 INFO - Reading from file tmpfile_stdout 15:33:54 INFO - Output received: 15:33:54 INFO - Usage: mozinstall [options] installer 15:33:54 INFO - Options: 15:33:54 INFO - -h, --help show this help message and exit 15:33:54 INFO - -d DEST, --destination=DEST 15:33:54 INFO - Directory to install application into. [default: 15:33:54 INFO - "/builds/slave/test"] 15:33:54 INFO - --app=APP Application being installed. [default: firefox] 15:33:54 INFO - mkdir: /builds/slave/test/build/application 15:33:54 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'] 15:33:54 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 15:34:33 INFO - Reading from file tmpfile_stdout 15:34:33 INFO - Output received: 15:34:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:34:33 INFO - Running post-action listener: _resource_record_post_action 15:34:33 INFO - ##### 15:34:33 INFO - ##### Running run-tests step. 15:34:33 INFO - ##### 15:34:33 INFO - Running pre-action listener: _resource_record_pre_action 15:34:33 INFO - Running main action method: run_tests 15:34:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:34:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:34:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:34:33 INFO - 2015-12-01 15:34:33.760 screenresolution[1952:18250] starting screenresolution argv=screenresolution get 15:34:33 INFO - 2015-12-01 15:34:33.764 screenresolution[1952:18250] Display 0: 1600x1200x32@60 15:34:33 INFO - 2015-12-01 15:34:33.771 screenresolution[1953:18252] starting screenresolution argv=screenresolution list 15:34:33 INFO - Available Modes on Display 0 15:34:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:34:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:34:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:34:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:34:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:34:34 INFO - Intel HD Graphics 3000: 15:34:34 INFO - Chipset Model: Intel HD Graphics 3000 15:34:34 INFO - Type: GPU 15:34:34 INFO - Bus: Built-In 15:34:34 INFO - VRAM (Total): 512 MB 15:34:34 INFO - VRAM (Dynamic, Max): 10 15:34:34 INFO - Vendor: Intel (0x8086) 15:34:34 INFO - Device ID: 0x0116 15:34:34 INFO - Revision ID: 0x0009 15:34:34 INFO - Displays: 15:34:34 INFO - Display: 15:34:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:34:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:34:34 INFO - Display Serial Number: 1600x1200 60 15:34:34 INFO - Main Display: Yes 15:34:34 INFO - Mirror: Off 15:34:34 INFO - Online: Yes 15:34:34 INFO - Rotation: Supported 15:34:34 INFO - Return code: 0 15:34:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:34:34 INFO - Python 2.7.3 15:34:34 INFO - Return code: 0 15:34:34 INFO - grabbing minidump binary from tooltool 15:34:34 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')]} 15:34:34 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 0x1031429f0>, '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 0x102ea1cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10310c990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:34:34 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 15:34:34 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 15:34:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:34:34 INFO - Return code: 0 15:34:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:34:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:34:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:34:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:34:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:34:34 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0037', '--webServer', 'localhost'] in /builds/slave/test/build 15:34:34 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0037 --webServer localhost 15:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWzKmPdfEL/Render', 15:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:34 INFO - 'HOME': '/Users/cltbld', 15:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:34 INFO - 'LOGNAME': 'cltbld', 15:34:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:34:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:34 INFO - 'MOZ_NO_REMOTE': '1', 15:34:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:34:34 INFO - 'NO_EM_RESTART': '1', 15:34:34 INFO - 'PAGER': '/bin/cat', 15:34:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:34 INFO - 'PWD': '/builds/slave/test', 15:34:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:34 INFO - 'SHELL': '/bin/bash', 15:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AOTyCkEzE5/Listeners', 15:34:34 INFO - 'TMPDIR': '/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/', 15:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:34 INFO - 'USER': 'cltbld', 15:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:34 INFO - 'XPC_FLAGS': '0x0', 15:34:34 INFO - 'XPC_SERVICE_NAME': '0', 15:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:34:34 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0037', '--webServer', 'localhost'] with output_timeout 3600 15:34:34 INFO - mozversion INFO | application_buildid: 20151201142430 15:34:34 INFO - mozversion INFO | application_changeset: 6c630e37e53f15976e1bdad36852e74fd073f3f7 15:34:34 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 15:34:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:34:34 INFO - mozversion INFO | application_name: Firefox 15:34:34 INFO - mozversion INFO | application_remotingname: firefox-dev 15:34:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:34:34 INFO - mozversion INFO | application_vendor: Mozilla 15:34:34 INFO - mozversion INFO | application_version: 44.0a2 15:34:34 INFO - mozversion INFO | platform_buildid: 20151201142430 15:34:34 INFO - mozversion INFO | platform_changeset: 6c630e37e53f15976e1bdad36852e74fd073f3f7 15:34:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:34:34 INFO - mozversion INFO | platform_version: 44.0a2 15:34:34 INFO - 2015-12-01 15:34:34,411 DEBUG : using testdate: 1449012874 15:34:34 INFO - 2015-12-01 15:34:34,411 DEBUG : actual date: 1449012874 15:34:35 INFO - 2015-12-01 15:34:35,449 INFO : starting webserver on 'localhost:54232' 15:34:35 INFO - 2015-12-01 15:34:35,451 INFO : Starting test suite t-yosemite-r5-0037.e 15:34:35 INFO - 2015-12-01 15:34:35,451 INFO : Starting test dromaeo_css 15:34:35 INFO - 2015-12-01 15:34:35,451 DEBUG : operating with platform_type : mac_ 15:34:35 INFO - 2015-12-01 15:34:35,452 INFO : Initialising browser for dromaeo_css test... 15:34:35 INFO - 2015-12-01 15:34:35,465 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmp8qeYRA/profile http://localhost:54232/getInfo.html 15:34:38 INFO - 2015-12-01 15:34:38,370 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:34:38 INFO - 2015-12-01 15:34:38,370 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:34:38 INFO - 2015-12-01 15:34:38,370 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:34:38 INFO - 2015-12-01 15:34:38,370 DEBUG : BROWSER_OUTPUT: __metrics 15:34:38 INFO - 2015-12-01 15:34:38,977 INFO : Browser initialized. 15:34:38 INFO - 2015-12-01 15:34:38,977 INFO : Running cycle 1/1 for dromaeo_css test... 15:34:38 INFO - 2015-12-01 15:34:38,977 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmp8qeYRA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:34:51 INFO - 2015-12-01 15:34:51,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 210550784 15:34:51 INFO - 2015-12-01 15:34:51,009 DEBUG : BROWSER_OUTPUT: 15:35:40 INFO - 2015-12-01 15:35:40,725 DEBUG : BROWSER_OUTPUT: 1449012940724 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] 15:37:51 INFO - 2015-12-01 15:37:51,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54232/tests/dromaeo/cssquery-ext.html) 15:37:52 INFO - 2015-12-01 15:37:52,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 235065344 15:37:52 INFO - 2015-12-01 15:37:52,658 DEBUG : BROWSER_OUTPUT: 15:40:54 INFO - 2015-12-01 15:40:54,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/dromaeo/cssquery-ext.html (next: http://localhost:54232/tests/dromaeo/cssquery-jquery.html) 15:40:55 INFO - 2015-12-01 15:40:55,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 241537024 15:40:55 INFO - 2015-12-01 15:40:55,352 DEBUG : BROWSER_OUTPUT: 15:43:57 INFO - 2015-12-01 15:43:57,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54232/tests/dromaeo/cssquery-mootools.html) 15:43:57 INFO - 2015-12-01 15:43:57,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 243871744 15:43:57 INFO - 2015-12-01 15:43:57,688 DEBUG : BROWSER_OUTPUT: 15:46:59 INFO - 2015-12-01 15:46:59,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54232/tests/dromaeo/cssquery-prototype.html) 15:46:59 INFO - 2015-12-01 15:46:59,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 249278464 15:46:59 INFO - 2015-12-01 15:46:59,989 DEBUG : BROWSER_OUTPUT: 15:50:02 INFO - 2015-12-01 15:50:02,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54232/tests/dromaeo/cssquery-yui.html) 15:50:03 INFO - 2015-12-01 15:50:03,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 254095360 15:50:03 INFO - 2015-12-01 15:50:03,196 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/dromaeo/cssquery-yui.html (next: http://localhost:54232/tests/dromaeo/cssquery-dojo.html) 15:53:05 INFO - 2015-12-01 15:53:05,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 258895872 15:53:05 INFO - 2015-12-01 15:53:05,594 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,595 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:53:05 INFO - 2015-12-01 15:53:05,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:53:05 INFO - 2015-12-01 15:53:05,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:53:05 INFO - 2015-12-01 15:53:05,595 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:53:05 INFO - 2015-12-01 15:53:05,595 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2841.6447944006995;2950.7049295070497;2956.27571245045;3010.7139821716937;3015.3818467214223;4992.226204938236;5018.4228813686395;5039.571636410909;5057.822976195834;5079.5936325094;4992.151334273173;5040.395152581696;5044.672096313737;5076.314697515834;5119.718415487147;4491.910161796762;4614.423197100363;4667.39323887895;4676;4719.504452032538;4534.501204867462;4545.318202269669;4562.247229207177;4575.816967321303;4603.079384123172;4612.331211974261;4620.029793743318;4631.212693842038;4666.323383109447;4673.462551806551;4588.816447342102;4611.815527378901;4623.791929363187;4639.234526303173;4651.767411629405;4417.580329868657;4468.597826195625;4557.772111394417;4571;4621.514740952185;4719.976400118012;4922.926156107661;4936.062148191832;5000;5042.798288068473;5279.023380674587;5294.047071527124;5305.973470132663;5322.946770532284;5360.410354860962;5244.711540865251;5346.545543628797;5406.459354064601;5484.643498172606;5521.199426083235;5007.774650140753;5037.848864534069;5038.143515602356;5057.393112826484;5075.086484432837;5338.946610533845;5469.507744303032;5489.094299440548;5502.669839809624;5516.531094856902;5146.176611742103;5200.63595548308;5238.057149713089;5270.130428479258;5272.209168624737;5323.441038690882;5465.207544905967;5511.421300763443;5572.08060669993;5641.746121424546;5156.664816786972;5254.579633629301;5363.973180134152;5382.703951282639;5469.699166545799;5178.404483484373;5321.760520776575;5327.38735045467;5354.839354819362;5414.7021913795115;4193.1404062167185;4201.243776120266;4210.536840947493;4217.8523751668545;4229.555896630871;3680.3743363627714;3741.8877433677035;3780.905477363033;3786.8295926683363;3813.447050177764;4883.365162528919;4978.8257410990445;5035;5061.620378471629;5073.34046573943;5436.10304299794;5493.423190565013;5516.668999860021;5522.66863988162;5589.832305030855;4819.325294458778;4919.3358896549225;4928.112939670894;4946.5053494650965;4978.77595508203;4724.196886529298;4727.858164255078;4734.100520901018;4756.120117778222;4792.472827988919;5412.539934105566;5417.241586177859;5455.618106732491;5480.671159730429;5486.369067557122;5150.793968241228;5186.4035635902355;5188.481151884932;5247.2129180623215;5347.919781203207;5416.160495123105;5429.538489228302;5441.29263195782;5458.0721277382145;5467.9453205467435;5047.444781074152;5299.39057008449;5299.6290259681455;5348.358197016383;5367.919481207707;5359.249705041375;5396.622236443568;5443.673379597237;5460.645058071372;5547.861303467445;5221.895562088813;5265.236540701653;5270.288511051112;5293.179557168645;5306.389765176899;5108.361454818148;5156.845294641167;5213.504717051874;5227.843164705065;5275.604329675213;4812.35033270504;5088.516590923857;5148.43367229612;5176.301199338041;5186.766595503136;5251.159814429673;5360.785568577369;5377.193420986883;5379.112446446449;5457.69982650958;4994.875128121826;5071.315372424676;5159.896802063862;5263.052650522943;5325.653832500875 15:53:05 INFO - 2015-12-01 15:53:05,595 DEBUG : BROWSER_OUTPUT: |1;ext.html;518.9870253243669;521.908665983453;533.0644718518998;536.2894165231069;546.0171690956278;36255.63744362559;36811.63188368122;36852;37436.43845342322;38101.809490952575;40389.39415908756;40928.181436371255;41011.179776404526;41081.79459102708;41169.17661646765;8487.915120848775;8588.269997050258;8638.438501497383;8667.913320866774;8783.95608021959;8460.57697115145;8505.829883402328;8519.488830670149;8547.145285471433;8587.95706021469;8425.1153628869;8530.829383412329;8535.445196062235;8543.658253669846;8591.828163436727;8470.28002619778;8540.402171848003;8543.444676096035;8584.484930904135;8611.526366049864;8225.588720563948;8404.285635720971;8430.45202061864;8478.830423391497;8489.235968762841;37804;37942.620573794185;37954.81022594897;38001.23997520062;38031;2296.609576372021;2445.0252991535112;2563.8974441022337;2667.5331816932153;3398.847051882671;24858.5028299433;24965.251042468753;25693.743062569323;25714.74285257142;26034.349141271432;2087.7390326209224;2145.4743587820926;2146.195176808697;2229.108356657334;2239.361781892153;239714;240218;241588;241963;242351;53526.7323663387;55630;56367.71816140975;56614.43385566174;59731.402685972585;57268.14097788536;57636;57646.423535764945;57654;58116.41883581194;16078.919605401898;16343.918280408521;16398.67202655964;16431.26059327333;16434.917825410797;12034.398280085961;12053.698657533456;12059.879401206052;12072.275663460221;12170.269783812999;18372.265109395743;18555.35056273024;18703.625927481648;18791.24835006612;18829.811701883078;7557.697692092364;7720.227977202235;7799.9220007799195;7832.569208693462;7849.136594974662;958.7651025498798;997.8303688372994;999.8950110238466;1002.3785253143097;1032.566322144701;26707.866460667574;27068.864655676596;27826.582601260998;28688.856555717088;29660;996.1632228927591;998.8851282102506;1003.8393856982848;1065.898739619735;1108.4758457121459;11446.885531144748;12771.489140434465;13691.27248767042;13698.315084245747;14510.637234069232;231940;234951;235297;236329;236866;48329.75835120802;48708;48791;48860.267095993586;48868;1315.4869600855675;1323.3052647360214;1323.6823162441137;1324.1194605587368;1337.6455239361576;26143.215703528924;27841.44317113687;28013.579796302663;28400.715992839807;28424.147275581767;46453.53546464492;46713.2993005112;46747.532524674316;46766;46793.53206468028;288124;290679;291112;291496.0850391469;292817;28671.283217919718;28729.856350718113;28915.56626650644;29513.26216844596;30497;35899.82050089733;36010;36837.81581092077;37288;37423.43864842084;29876.850615746782;31244;33628;33633.15917102092;34066.31867362688;32980.67019329776;33168.336633266714;33170.50244246387;33309.83345083259;33586.16034599154;33504.329913402085;33909.66090339065;34166.487502687974;34233.31533369269;34604;26128.34679133037;28450;28473;29040.564391534568;29735.85132074326;21302.254421095186;21534.569308614053;21803.67294490552;21909.452263692896;22331.330060098222 15:53:05 INFO - 2015-12-01 15:53:05,596 DEBUG : BROWSER_OUTPUT: |2;jquery.html;295.49617901477984;295.7279303041202;312.75523416801116;325.7784706399648;326.9019294211737;13768.518101866437;14305.213213273266;16421.096839673828;16640;16903.83096169038;16129.193540322996;16572;17604;17991.460256192302;18059.90970045148;4917.72952487613;5014.097462456756;5020.59835213182;5040.1935690289565;5042.722650254234;3785.9053523661855;3913;4838.758062096898;5308.283381743473;5498.477644623775;5417.079096553595;5436.021516127095;5436.700981446019;5441.455854414547;5458.918116228259;4111.52717437494;4256.021115143519;4268.103698223345;4270.316749320125;5395.568354531628;3593.4250519916686;3634.9273014539826;3656.104254457675;3657.7805331680183;3659.9634003660153;11771.058315334838;12117.212381195282;12192.756144877141;12254.81617775734;12276.263424194576;1712.0925909268108;1733.8092809790912;1763.7795275590552;1809.8642601804786;1812.8640351973522;8751.606177722018;8773.34199935001;8832.205101540892;8886.466811991237;8970.192682658528;1406.8171137752129;1408.5633453629305;1443.3432788081502;1445.2629159128815;1445.544653434165;53307.466925330635;55791.721041394936;56029;56441.71779141078;56749.14876276859;5885.087811389241;6031.728572214261;6043.395660434009;6077.817665470043;6200.906986395207;7009.894851577231;7054.964725176341;7061.505694601328;7083.7520686775715;7095.964520177469;5222.97388513055;5235.7434215787935;5243.790248390098;5253.579713622901;5285.154375299933;5585.609007369445;5609.326880774333;5617.354004289559;5660.377358490563;5687.658740475585;2693.8922443102447;2738.151173136334;2744.8490333031477;2759.751622353998;2779.3051737065734;937.4281688170211;952.7713348796377;981.1807141037172;1015.9898401015895;1017.399734156851;409.30418288908976;412.9814158362881;419.7313719219702;427.17768296030016;428.1757616588055;10569;10981.231313807957;11026.724331891766;11193.94403027996;11265.94367028176;426.6373582454888;426.8740721487169;428.23773682844586;430.5371725395213;432.81821634912785;5548.140038294071;5943.494802941798;5985.461308482258;6021;6028.849278768066;351778;360649;362327;564193;566672;62137.68931155315;68027.65986170038;68398.91560020782;68532.657336714;69705.65147174231;411.9279126152911;419.4819398043414;424.1072542298479;425.55954587002304;426.1966193724789;9886.258530610377;10135.949320253352;10250.179985601284;10255.487225638539;10319.122874555447;32281.67718322787;32530.349393011533;32681.34637307288;32684.50973235451;32957;43439.78280108579;45137.77431112823;45830.770846145555;45921.31118033166;45927.31109033434;5728.598998070095;5733.684647344436;5761.5102716269585;5829.912551311819;5841.795537156179;10232.437215952896;10835.783284334111;10865.619703310345;10889.891101088888;10920.017198452177;7743.883841742266;7886.369090472863;8937.28501719848;9229.723108306762;9276.907230927603;8641.697540586048;8981.640734370552;9010.774730631787;9041.457512549268;9129.817403651758;9243.537823108683;9332.346735728433;9388.530573471437;9576.616935322787;9606;5734.5125664319;5876.882462350814;5902.2327097477055;5943.3759455258305;5960.612560183574;9415.199708024895;9463;9555.90444095578;9590.616375344907;9754.609815607297 15:53:05 INFO - 2015-12-01 15:53:05,599 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1348.8044233586136;1509.396241503399;1540.4685383542678;1588.4678632658058;1614.2009705195921;5910.763569457216;5938.762449502025;6385.680715964207;6495.610263384195;6530.542861999662;6341.904871426921;6510.739570417178;6637.037629543714;6641.800745977616;6649.468042556596;1891.7256997735356;1932.7970563090885;1937.0121238168565;1941.2914286285545;1954.1206457094365;1924.2976313645488;1951.834094102003;1959.255482916497;2018.9899050504728;2025.6758918573032;1932.690769476884;1943.2906988949003;1944.1445763863926;1958.265650381107;1961.7743959444633;1853.8794978326366;1901.3155264104912;1901.372547059467;1902.172554938606;1903.1911437639017;1946.902654867251;1948.133080779054;1972.8323092537153;1980.821726044663;1982.603479304145;6524.151860258184;6612.471002319851;6623.801285961381;6636.867262654768;6671.032700258435;4067.633912947819;4136.234796562646;4136.379543068534;4144.171165766858;4172.144710334374;2249.8200143988443;2310.6302991521275;2449.8040156787592;2513.3465299022387;2528.608065749812;735.2133217457323;753.8869169624545;774.6668932359083;781.4646966827742;782.6243403166455;8468.110848360895;8493.787655308604;8521.062683104854;8531.402801803939;8536.103709110515;3702.5371828521434;3735.3836616958442;3788.981055094762;3802.923941521154;3814.7138964577766;7464.925350746423;7477.102747670315;7489.28851759082;7507.211742766931;7518.28576285252;4203.26442872496;4206.41110244566;4214.283571792803;4221.092465119953;4245.490541135022;3849.6920246380223;3858.5176852893387;3868;3873.65137137659;3875.457435958968;3132.7807053506035;3186.5441606454583;3233.3856567252146;3244.902652920416;3263.6736326367172;1026.4457193115634;1027.984580231297;1030.7680771826429;1040.6825918094903;1045.1012129568564;1170.5025364220173;1180.816973369129;1191.9702007449882;1204.3797444316185;1209.4920133543933;6284.528660350401;6308.990561510228;6328.050792381179;6330.8100756977365;6346.174997250328;419.2014212924384;422.5267700175823;423.8516519218249;429.448159115535;429.787255308618;5014.774335154927;5088.465711100355;5122.564582010496;5139.408967968657;5148;6968.198657154391;7193.100862392201;7267.927320726831;7518.511296765692;7694.692212311445;7571.3564347031115;7587.241275872479;7610.961945190239;7629.656665450068;7652.846943061219;6117.051856962178;6174.475169610633;6212.254529456494;6224.657643829632;6292.590981586182;6040.36576159497;6042.939570604238;6069.635821850703;6084.513238940963;6101.786437474667;6729.192496900403;6871.175458944958;6881.243063262937;6882.277360877236;6885.2770459101075;6975.058367120374;7102.857942841011;7135.964320178366;7141.143062832493;7147;5896.410358964069;5934.080217566284;5950.2264705587995;5981.252343457068;5995.670238136944;6115.7247923844425;6176.073588961692;6192.752289908533;6205.968970155121;6234.812955611339;5771.480566749013;5906.616069955439;5996.37038110992;6049.546284028804;6083.847903802441;5656.179853921076;5866.970665146647;5870.7945221917025;5902.704864756831;5912.083627037816;6024.216851809237;6026.427489388501;6044.637321760709;6052.425019623129;6059.394060593905;5166.225066240094;5266.2363957225225;5312.335958005249;5328.440513746001;5418.945810541844;5468.753906074316;5474.343078830566;5484.972575137099;5485.780568777204;5494.203340515683 15:53:05 INFO - 2015-12-01 15:53:05,600 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.46284744747743;275.5343469536483;279.70630837620496;281.6887339489862;313.1060821355033;5444.7822087116565;5753.453421924921;5768.884622307552;5786.1610066540325;5799.246098007264;5655.688937108457;5666.121751128581;5678.34699009613;5689.118186681071;5696.430356964312;4239.894002649943;4261.211675839964;4263.211305908401;4290.742555446675;4302.440682711243;4247.023184667529;4272.124214536013;4281.35779633056;4285.849995250167;4298.656107511407;4117.938230926538;4233.978830105861;4243.787810609472;4269.893252668692;4292.6780491463105;4162.292410290258;4205.747655140702;4223.070924396628;4227.852025179104;4230.555791641895;3580.838862251205;3616.620254873253;3622.6558476944647;3635.0548857297294;3643.599204087548;5392.1911713242935;5441.863953401157;5444.237806707064;5449.754761035763;5452.482014208644;4746.5490778376;4784.569388755029;4792.281157826319;4824.8311309104365;4847.854564363075;5795.710214489301;5890.499307558863;5895.204147440127;5898.8230353089475;5899.439553242478;3984.183242435294;3987.4018897165365;4020.43713880057;4021.738586991836;4024.9195016099516;6099.268087829444;6155.107509411155;6166.7224974876235;6167.938320616781;6190.133381326618;3978.741381810173;4026.2953983053435;4035.6771458283856;4037.212743515045;4050.9189816204102;4126.3397856343445;4142.91714165715;4146.5853414658295;4157.729747566398;4158.189153115113;4739.715617062919;4801.303810947463;4807.95192048082;4810.013947140827;4824.782884770194;5856.326522449887;5896.587238893322;5920.259967504062;5931;5931.7627294907725;1387.257817067864;1398.5245016694168;1455.5924341184486;1469.0671423645847;1502.9398824047134;932.8507438809894;949.0367277213634;950.4344914775697;969.0987381735054;970.5195928015678;5468.37113731918;5487.6158668892795;5489.615726899158;5498;5525.475079867406;6060.848478788065;6066.332703402622;6092.847678807977;6093.177421048191;6102.72537735803;5460.5085542301385;5516.034693928626;5534.086875665551;5594.888102237933;5618.410066942912;3278.6229583597715;3368.3768502827056;3369.561956945581;3399.7450191235757;3410.7441941853963;6220.098085777628;6223.377662233831;6227.813165605039;6231.4391704746795;6236.469900058546;6260.624362538262;6289.182406287154;6293.96853015732;6302.306746257908;6323.462505686976;6194.132821405007;6219.098230756515;6219.191505104308;6225.595336303126;6239.313675495782;6164.106204600397;6175.135481032569;6176.382361763787;6201.162843016135;6207.96896015517;6058.878822423439;6059.242594675666;6060.090986351906;6061.878762424639;6079.361667024898;6119.424954614662;6242.875142497215;6251.593646412968;6259.906101408574;6276.089966954674;4124.546299907068;4126.051008268175;4128.401381799682;4140.15126898979;4159.33450647907;6030.246219222598;6152.200213972334;6185.969070154621;6186.226721659793;6207.6275423474735;5901.232839730807;5966.105084237225;5967.46292833647;5969.283685957713;5978.790742323998;5949.464548190684;5954.821355359346;5960.105984102246;5977.641341519523;6002.399760023963;5631.070873305859;5826.563007774349;5831.504322132666;5834.329052159056;5860.472557469848;6021.668808215591;6024.789132380346;6094.939050609437;6095.695215239309;6101.938980610137;5944.4352786485215;5957.3446920837805;5963.91054134197;5978.581499295007;5979.372165922689 15:53:05 INFO - 2015-12-01 15:53:05,602 DEBUG : BROWSER_OUTPUT: |5;yui.html;677.7492327838697;690.5718454558172;707.1867352544573;709.5919846088499;715.2882881532876;12584.937075314621;12699.873001269985;12965.870341296595;12970.286634235114;12976.026797990153;13246.867531324708;13440.19358838468;13482.797758033614;13527.32363381832;13553.254570998592;619.8295468746109;786.0881377601997;805.1827395193883;806.9233422824851;810.2586133687669;644.8484606117559;761.5697131120927;784.2118670735903;817.4278005396217;822.880682301066;832.063928080909;839.4417712221366;840.2185967050641;841.4194205997842;849.7875531117221;832.7168762620707;835.340081335744;835.6532039203723;845.2941793602349;846.3313981954249;604.8729766748944;605.9878802423971;613.4049971527611;614.213806327901;617.0651463033507;12466.563670271587;12570.497180112785;12576.81134782979;12618.55835045769;12620.116591838574;8867.689630862953;8893.199612034949;8973.955130224373;9071.909280907239;9319.534023298807;7789.9221007789765;7872.842543149162;8003.159668234868;8102.878456823152;8184.549849758261;2617.319496930793;2661.507621090085;2666.733326667337;2708.133397312861;2824.265690920355;42478;42977.71066867999;43057.35413968793;43064.1387172258;43247.35128973099;5708.4862362387585;5760.884782304331;5852.941470585325;5950.464458198783;6104.786332478342;11396.658100257006;11441.485133169028;11443;11483.31100133978;11492.195546311845;5204.739763011834;5277.709725965109;5332.626716129911;5338.492843179892;5400.189971504227;3409.3351796399465;3468.6531346865113;3482.1120614243205;3564.483149943244;3668.4680721295263;2406.482606239667;2438.8536687798787;2448.1676230081857;2449.179524859192;2457.1522824625476;350.59331175836417;354.4665278755508;359.71043310135593;359.73918908790915;359.83087948664087;402.2638571414305;419.6831392298795;422.12619876854615;520.0560981817988;526.6734624532814;6742.83142921421;6786.287439818847;6948.131483564554;6948.895766563505;6968.841333531441;519.8206618716537;524.6170295684171;540.8783023819609;548.259849203572;559.0663591801701;3319.7344212462945;3320.4521253993303;3334.849931753077;3368.494725791151;3384;54290;55113.44886551164;56022.15966760502;57125.71437142871;57559.42440575625;45678;45832;46273.537264626924;46336;48083.75958120257;44172.11655766867;44246;44406.33390499145;44463.11073778571;44506.77746611311;7368.815779605553;7430.92569074324;7694.846103078019;7737.381009519112;7995.200479951958;31952.20119496938;31977.6802231984;33134.83432582822;33729.15677108092;34337;43536.78231608822;44230;44755;44972.55027449814;45021.77489112534;6420.165378500765;6465.870682586416;6704.899426508704;6968.686409111703;7178.066851309296;10274.794504109726;10309.948450258;10321.277510574188;10628.89371106279;10735.302205356627;9323.067693230623;9433.151016408556;9632.95183524078;9653.662121825702;9974;9533.142017218484;9910.405375677483;9995.100440960348;10105.848412273675;10138.442385668564;9006.819863602823;9424.62301507932;9447.24422046221;9679.56217405965;9761.365511241747;8224.588770561568;8386.832263354576;8421.915780842113;8640.308775298086;8821.206091451544;8307.460015098999;8521.616527256412;8562.57187140628;8573.699920502753;8589.570521473775 15:53:05 INFO - 2015-12-01 15:53:05,602 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:53:05 INFO - 2015-12-01 15:53:05,603 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:53:05 INFO - 2015-12-01 15:53:05,603 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,278 15:53:05 INFO - 2015-12-01 15:53:05,603 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:53:05 INFO - 2015-12-01 15:53:05,603 DEBUG : BROWSER_OUTPUT: __startTimestamp1449013985588__endTimestamp 15:53:05 INFO - 2015-12-01 15:53:05,604 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,604 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:53:05 INFO - 2015-12-01 15:53:05,604 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:53:05 INFO - 2015-12-01 15:53:05,604 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,604 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4988.43 Median:5148.43 stddev:542.14 (10.5%) stddev-sans-first:516.99 15:53:05 INFO - 2015-12-01 15:53:05,604 DEBUG : BROWSER_OUTPUT: Values: 2841.6 2950.7 2956.3 3010.7 3015.4 4992.2 5018.4 5039.6 5057.8 5079.6 4992.2 5040.4 5044.7 5076.3 5119.7 4491.9 4614.4 4667.4 4676.0 4719.5 4534.5 4545.3 4562.2 4575.8 4603.1 4612.3 4620.0 4631.2 4666.3 4673.5 4588.8 4611.8 4623.8 4639.2 4651.8 4417.6 4468.6 4557.8 4571.0 4621.5 4720.0 4922.9 4936.1 5000.0 5042.8 5279.0 5294.0 5306.0 5322.9 5360.4 5244.7 5346.5 5406.5 5484.6 5521.2 5007.8 5037.8 5038.1 5057.4 5075.1 5338.9 5469.5 5489.1 5502.7 5516.5 5146.2 5200.6 5238.1 5270.1 5272.2 5323.4 5465.2 5511.4 5572.1 5641.7 5156.7 5254.6 5364.0 5382.7 5469.7 5178.4 5321.8 5327.4 5354.8 5414.7 4193.1 4201.2 4210.5 4217.9 4229.6 3680.4 3741.9 3780.9 3786.8 3813.4 4883.4 4978.8 5035.0 5061.6 5073.3 5436.1 5493.4 5516.7 5522.7 5589.8 4819.3 4919.3 4928.1 4946.5 4978.8 4724.2 4727.9 4734.1 4756.1 4792.5 5412.5 5417.2 5455.6 5480.7 5486.4 5150.8 5186.4 5188.5 5247.2 5347.9 5416.2 5429.5 5441.3 5458.1 5467.9 5047.4 5299.4 5299.6 5348.4 5367.9 5359.2 5396.6 5443.7 5460.6 5547.9 5221.9 5265.2 5270.3 5293.2 5306.4 5108.4 5156.8 5213.5 5227.8 5275.6 4812.4 5088.5 5148.4 5176.3 5186.8 5251.2 5360.8 5377.2 5379.1 5457.7 4994.9 5071.3 5159.9 5263.1 5325.7 15:53:05 INFO - 2015-12-01 15:53:05,605 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,606 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41917.35 Median:33545.25 stddev:67000.07 (199.7%) stddev-sans-first:67115.92 15:53:05 INFO - 2015-12-01 15:53:05,606 DEBUG : BROWSER_OUTPUT: Values: 519.0 521.9 533.1 536.3 546.0 36255.6 36811.6 36852.0 37436.4 38101.8 40389.4 40928.2 41011.2 41081.8 41169.2 8487.9 8588.3 8638.4 8667.9 8784.0 8460.6 8505.8 8519.5 8547.1 8588.0 8425.1 8530.8 8535.4 8543.7 8591.8 8470.3 8540.4 8543.4 8584.5 8611.5 8225.6 8404.3 8430.5 8478.8 8489.2 37804.0 37942.6 37954.8 38001.2 38031.0 2296.6 2445.0 2563.9 2667.5 3398.8 24858.5 24965.3 25693.7 25714.7 26034.3 2087.7 2145.5 2146.2 2229.1 2239.4 239714.0 240218.0 241588.0 241963.0 242351.0 53526.7 55630.0 56367.7 56614.4 59731.4 57268.1 57636.0 57646.4 57654.0 58116.4 16078.9 16343.9 16398.7 16431.3 16434.9 12034.4 12053.7 12059.9 12072.3 12170.3 18372.3 18555.4 18703.6 18791.2 18829.8 7557.7 7720.2 7799.9 7832.6 7849.1 958.8 997.8 999.9 1002.4 1032.6 26707.9 27068.9 27826.6 28688.9 29660.0 996.2 998.9 1003.8 1065.9 1108.5 11446.9 12771.5 13691.3 13698.3 14510.6 231940.0 234951.0 235297.0 236329.0 236866.0 48329.8 48708.0 48791.0 48860.3 48868.0 1315.5 1323.3 1323.7 1324.1 1337.6 26143.2 27841.4 28013.6 28400.7 28424.1 46453.5 46713.3 46747.5 46766.0 46793.5 288124.0 290679.0 291112.0 291496.1 292817.0 28671.3 28729.9 28915.6 29513.3 30497.0 35899.8 36010.0 36837.8 37288.0 37423.4 29876.9 31244.0 33628.0 33633.2 34066.3 32980.7 33168.3 33170.5 33309.8 33586.2 33504.3 33909.7 34166.5 34233.3 34604.0 26128.3 28450.0 28473.0 29040.6 29735.9 21302.3 21534.6 21803.7 21909.5 22331.3 15:53:05 INFO - 2015-12-01 15:53:05,606 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,606 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23267.54 Median:4878.24 stddev:74367.29 (1524.5%) stddev-sans-first:74555.90 15:53:05 INFO - 2015-12-01 15:53:05,607 DEBUG : BROWSER_OUTPUT: Values: 295.5 295.7 312.8 325.8 326.9 13768.5 14305.2 16421.1 16640.0 16903.8 16129.2 16572.0 17604.0 17991.5 18059.9 4917.7 5014.1 5020.6 5040.2 5042.7 3785.9 3913.0 4838.8 5308.3 5498.5 5417.1 5436.0 5436.7 5441.5 5458.9 4111.5 4256.0 4268.1 4270.3 5395.6 3593.4 3634.9 3656.1 3657.8 3660.0 11771.1 12117.2 12192.8 12254.8 12276.3 1712.1 1733.8 1763.8 1809.9 1812.9 8751.6 8773.3 8832.2 8886.5 8970.2 1406.8 1408.6 1443.3 1445.3 1445.5 53307.5 55791.7 56029.0 56441.7 56749.1 5885.1 6031.7 6043.4 6077.8 6200.9 7009.9 7055.0 7061.5 7083.8 7096.0 5223.0 5235.7 5243.8 5253.6 5285.2 5585.6 5609.3 5617.4 5660.4 5687.7 2693.9 2738.2 2744.8 2759.8 2779.3 937.4 952.8 981.2 1016.0 1017.4 409.3 413.0 419.7 427.2 428.2 10569.0 10981.2 11026.7 11193.9 11265.9 426.6 426.9 428.2 430.5 432.8 5548.1 5943.5 5985.5 6021.0 6028.8 351778.0 360649.0 362327.0 564193.0 566672.0 62137.7 68027.7 68398.9 68532.7 69705.7 411.9 419.5 424.1 425.6 426.2 9886.3 10135.9 10250.2 10255.5 10319.1 32281.7 32530.3 32681.3 32684.5 32957.0 43439.8 45137.8 45830.8 45921.3 45927.3 5728.6 5733.7 5761.5 5829.9 5841.8 10232.4 10835.8 10865.6 10889.9 10920.0 7743.9 7886.4 8937.3 9229.7 9276.9 8641.7 8981.6 9010.8 9041.5 9129.8 9243.5 9332.3 9388.5 9576.6 9606.0 5734.5 5876.9 5902.2 5943.4 5960.6 9415.2 9463.0 9555.9 9590.6 9754.6 15:53:05 INFO - 2015-12-01 15:53:05,608 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,608 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4584.03 Median:5713.83 stddev:2309.18 (40.4%) stddev-sans-first:2302.85 15:53:05 INFO - 2015-12-01 15:53:05,609 DEBUG : BROWSER_OUTPUT: Values: 1348.8 1509.4 1540.5 1588.5 1614.2 5910.8 5938.8 6385.7 6495.6 6530.5 6341.9 6510.7 6637.0 6641.8 6649.5 1891.7 1932.8 1937.0 1941.3 1954.1 1924.3 1951.8 1959.3 2019.0 2025.7 1932.7 1943.3 1944.1 1958.3 1961.8 1853.9 1901.3 1901.4 1902.2 1903.2 1946.9 1948.1 1972.8 1980.8 1982.6 6524.2 6612.5 6623.8 6636.9 6671.0 4067.6 4136.2 4136.4 4144.2 4172.1 2249.8 2310.6 2449.8 2513.3 2528.6 735.2 753.9 774.7 781.5 782.6 8468.1 8493.8 8521.1 8531.4 8536.1 3702.5 3735.4 3789.0 3802.9 3814.7 7464.9 7477.1 7489.3 7507.2 7518.3 4203.3 4206.4 4214.3 4221.1 4245.5 3849.7 3858.5 3868.0 3873.7 3875.5 3132.8 3186.5 3233.4 3244.9 3263.7 1026.4 1028.0 1030.8 1040.7 1045.1 1170.5 1180.8 1192.0 1204.4 1209.5 6284.5 6309.0 6328.1 6330.8 6346.2 419.2 422.5 423.9 429.4 429.8 5014.8 5088.5 5122.6 5139.4 5148.0 6968.2 7193.1 7267.9 7518.5 7694.7 7571.4 7587.2 7611.0 7629.7 7652.8 6117.1 6174.5 6212.3 6224.7 6292.6 6040.4 6042.9 6069.6 6084.5 6101.8 6729.2 6871.2 6881.2 6882.3 6885.3 6975.1 7102.9 7136.0 7141.1 7147.0 5896.4 5934.1 5950.2 5981.3 5995.7 6115.7 6176.1 6192.8 6206.0 6234.8 5771.5 5906.6 5996.4 6049.5 6083.8 5656.2 5867.0 5870.8 5902.7 5912.1 6024.2 6026.4 6044.6 6052.4 6059.4 5166.2 5266.2 5312.3 5328.4 5418.9 5468.8 5474.3 5485.0 5485.8 5494.2 15:53:05 INFO - 2015-12-01 15:53:05,609 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,610 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4932.80 Median:5692.77 stddev:1512.35 (26.6%) stddev-sans-first:1475.64 15:53:05 INFO - 2015-12-01 15:53:05,611 DEBUG : BROWSER_OUTPUT: Values: 275.5 275.5 279.7 281.7 313.1 5444.8 5753.5 5768.9 5786.2 5799.2 5655.7 5666.1 5678.3 5689.1 5696.4 4239.9 4261.2 4263.2 4290.7 4302.4 4247.0 4272.1 4281.4 4285.8 4298.7 4117.9 4234.0 4243.8 4269.9 4292.7 4162.3 4205.7 4223.1 4227.9 4230.6 3580.8 3616.6 3622.7 3635.1 3643.6 5392.2 5441.9 5444.2 5449.8 5452.5 4746.5 4784.6 4792.3 4824.8 4847.9 5795.7 5890.5 5895.2 5898.8 5899.4 3984.2 3987.4 4020.4 4021.7 4024.9 6099.3 6155.1 6166.7 6167.9 6190.1 3978.7 4026.3 4035.7 4037.2 4050.9 4126.3 4142.9 4146.6 4157.7 4158.2 4739.7 4801.3 4808.0 4810.0 4824.8 5856.3 5896.6 5920.3 5931.0 5931.8 1387.3 1398.5 1455.6 1469.1 1502.9 932.9 949.0 950.4 969.1 970.5 5468.4 5487.6 5489.6 5498.0 5525.5 6060.8 6066.3 6092.8 6093.2 6102.7 5460.5 5516.0 5534.1 5594.9 5618.4 3278.6 3368.4 3369.6 3399.7 3410.7 6220.1 6223.4 6227.8 6231.4 6236.5 6260.6 6289.2 6294.0 6302.3 6323.5 6194.1 6219.1 6219.2 6225.6 6239.3 6164.1 6175.1 6176.4 6201.2 6208.0 6058.9 6059.2 6060.1 6061.9 6079.4 6119.4 6242.9 6251.6 6259.9 6276.1 4124.5 4126.1 4128.4 4140.2 4159.3 6030.2 6152.2 6186.0 6186.2 6207.6 5901.2 5966.1 5967.5 5969.3 5978.8 5949.5 5954.8 5960.1 5977.6 6002.4 5631.1 5826.6 5831.5 5834.3 5860.5 6021.7 6024.8 6094.9 6095.7 6101.9 5944.4 5957.3 5963.9 5978.6 5979.4 15:53:05 INFO - 2015-12-01 15:53:05,611 DEBUG : BROWSER_OUTPUT: 15:53:05 INFO - 2015-12-01 15:53:05,611 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12262.37 Median:27419.13 stddev:15263.65 (55.7%) stddev-sans-first:15281.68 15:53:05 INFO - 2015-12-01 15:53:05,611 DEBUG : BROWSER_OUTPUT: Values: 677.7 690.6 707.2 709.6 715.3 12584.9 12699.9 12965.9 12970.3 12976.0 13246.9 13440.2 13482.8 13527.3 13553.3 619.8 786.1 805.2 806.9 810.3 644.8 761.6 784.2 817.4 822.9 832.1 839.4 840.2 841.4 849.8 832.7 835.3 835.7 845.3 846.3 604.9 606.0 613.4 614.2 617.1 12466.6 12570.5 12576.8 12618.6 12620.1 8867.7 8893.2 8974.0 9071.9 9319.5 7789.9 7872.8 8003.2 8102.9 8184.5 2617.3 2661.5 2666.7 2708.1 2824.3 42478.0 42977.7 43057.4 43064.1 43247.4 5708.5 5760.9 5852.9 5950.5 6104.8 11396.7 11441.5 11443.0 11483.3 11492.2 5204.7 5277.7 5332.6 5338.5 5400.2 3409.3 3468.7 3482.1 3564.5 3668.5 2406.5 2438.9 2448.2 2449.2 2457.2 350.6 354.5 359.7 359.7 359.8 402.3 419.7 422.1 520.1 526.7 6742.8 6786.3 6948.1 6948.9 6968.8 519.8 524.6 540.9 548.3 559.1 3319.7 3320.5 3334.8 3368.5 3384.0 54290.0 55113.4 56022.2 57125.7 57559.4 45678.0 45832.0 46273.5 46336.0 48083.8 44172.1 44246.0 44406.3 44463.1 44506.8 7368.8 7430.9 7694.8 7737.4 7995.2 31952.2 31977.7 33134.8 33729.2 34337.0 43536.8 44230.0 44755.0 44972.6 45021.8 6420.2 6465.9 6704.9 6968.7 7178.1 10274.8 10309.9 10321.3 10628.9 10735.3 9323.1 9433.2 9633.0 9653.7 9974.0 9533.1 9910.4 9995.1 10105.8 10138.4 9006.8 9424.6 9447.2 9679.6 9761.4 8224.6 8386.8 8421.9 8640.3 8821.2 8307.5 8521.6 8562.6 8573.7 8589.6 15:53:05 INFO - 2015-12-01 15:53:05,611 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:53:05 INFO - 2015-12-01 15:53:05,611 DEBUG : BROWSER_OUTPUT: 15:53:06 INFO - 2015-12-01 15:53:06,027 INFO : Browser exited with error code: 0 15:53:06 INFO - 2015-12-01 15:53:06,059 INFO : Completed test dromaeo_css (00:18:30) 15:53:06 INFO - 2015-12-01 15:53:06,059 INFO : Starting test kraken 15:53:06 INFO - 2015-12-01 15:53:06,059 DEBUG : operating with platform_type : mac_ 15:53:06 INFO - 2015-12-01 15:53:06,059 INFO : Initialising browser for kraken test... 15:53:06 INFO - 2015-12-01 15:53:06,074 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmpZ7lgt2/profile http://localhost:54232/getInfo.html 15:53:08 INFO - 2015-12-01 15:53:08,873 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:53:08 INFO - 2015-12-01 15:53:08,873 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:53:08 INFO - 2015-12-01 15:53:08,873 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:53:08 INFO - 2015-12-01 15:53:08,873 DEBUG : BROWSER_OUTPUT: __metrics 15:53:09 INFO - 2015-12-01 15:53:09,485 INFO : Browser initialized. 15:53:09 INFO - 2015-12-01 15:53:09,485 INFO : Running cycle 1/1 for kraken test... 15:53:09 INFO - 2015-12-01 15:53:09,486 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmpZ7lgt2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:53:21 INFO - 2015-12-01 15:53:21,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 210853888 15:53:21 INFO - 2015-12-01 15:53:21,501 DEBUG : BROWSER_OUTPUT: 15:53:24 INFO - 2015-12-01 15:53:24,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54232/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:24 INFO - 2015-12-01 15:53:24,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 230178816 15:53:24 INFO - 2015-12-01 15:53:24,796 DEBUG : BROWSER_OUTPUT: 15:53:27 INFO - 2015-12-01 15:53:27,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54232/tests/kraken/driver.html?testName=audio-dft) 15:53:28 INFO - 2015-12-01 15:53:28,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 238067712 15:53:28 INFO - 2015-12-01 15:53:28,269 DEBUG : BROWSER_OUTPUT: 15:53:31 INFO - 2015-12-01 15:53:31,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54232/tests/kraken/driver.html?testName=audio-fft) 15:53:31 INFO - 2015-12-01 15:53:31,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 238071808 15:53:31 INFO - 2015-12-01 15:53:31,971 DEBUG : BROWSER_OUTPUT: 15:53:34 INFO - 2015-12-01 15:53:34,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54232/tests/kraken/driver.html?testName=audio-oscillator) 15:53:34 INFO - 2015-12-01 15:53:34,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 237010944 15:53:34 INFO - 2015-12-01 15:53:34,722 DEBUG : BROWSER_OUTPUT: 15:53:37 INFO - 2015-12-01 15:53:37,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54232/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:53:37 INFO - 2015-12-01 15:53:37,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 238825472 15:53:37 INFO - 2015-12-01 15:53:37,612 DEBUG : BROWSER_OUTPUT: 15:53:40 INFO - 2015-12-01 15:53:40,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54232/tests/kraken/driver.html?testName=imaging-darkroom) 15:53:41 INFO - 2015-12-01 15:53:41,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 237056000 15:53:41 INFO - 2015-12-01 15:53:41,507 DEBUG : BROWSER_OUTPUT: 15:53:44 INFO - 2015-12-01 15:53:44,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54232/tests/kraken/driver.html?testName=imaging-desaturate) 15:53:45 INFO - 2015-12-01 15:53:45,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 237223936 15:53:45 INFO - 2015-12-01 15:53:45,510 DEBUG : BROWSER_OUTPUT: 15:53:48 INFO - 2015-12-01 15:53:48,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54232/tests/kraken/driver.html?testName=json-parse-financial) 15:53:49 INFO - 2015-12-01 15:53:49,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 239472640 15:53:49 INFO - 2015-12-01 15:53:49,246 DEBUG : BROWSER_OUTPUT: 15:53:50 INFO - 2015-12-01 15:53:50,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54232/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:51 INFO - 2015-12-01 15:53:51,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 237797376 15:53:51 INFO - 2015-12-01 15:53:51,534 DEBUG : BROWSER_OUTPUT: 15:53:53 INFO - 2015-12-01 15:53:53,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54232/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:54 INFO - 2015-12-01 15:53:54,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 238051328 15:53:54 INFO - 2015-12-01 15:53:54,095 DEBUG : BROWSER_OUTPUT: 15:53:56 INFO - 2015-12-01 15:53:56,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54232/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:56 INFO - 2015-12-01 15:53:56,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 238604288 15:53:56 INFO - 2015-12-01 15:53:56,917 DEBUG : BROWSER_OUTPUT: 15:53:59 INFO - 2015-12-01 15:53:59,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:00 INFO - 2015-12-01 15:54:00,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 238907392 15:54:00 INFO - 2015-12-01 15:54:00,330 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2015-12-01 15:54:03,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:03 INFO - 2015-12-01 15:54:03,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 239214592 15:54:03 INFO - 2015-12-01 15:54:03,734 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54232/tests/kraken/driver.html?testName=ai-astar) 15:54:05 INFO - 2015-12-01 15:54:05,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 239079424 15:54:05 INFO - 2015-12-01 15:54:05,805 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,806 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:54:05 INFO - 2015-12-01 15:54:05,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:54:05 INFO - 2015-12-01 15:54:05,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:54:05 INFO - 2015-12-01 15:54:05,806 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:54:05 INFO - 2015-12-01 15:54:05,806 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;120;119;126;141;130;126;122;122 15:54:05 INFO - 2015-12-01 15:54:05,806 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;150;183;178;149;170;146;181;172;147 15:54:05 INFO - 2015-12-01 15:54:05,806 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;183;193;192;187;185;187;185;185;192 15:54:05 INFO - 2015-12-01 15:54:05,806 DEBUG : BROWSER_OUTPUT: |3;audio-fft;83;80;93;132;77;78;81;84;135;79 15:54:05 INFO - 2015-12-01 15:54:05,807 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;100;149;101;105;103;143;104;101;142 15:54:05 INFO - 2015-12-01 15:54:05,807 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;137;136;135;131;143;142;141;136;136;136 15:54:05 INFO - 2015-12-01 15:54:05,807 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;147;142;147;149;147;143;149;149 15:54:05 INFO - 2015-12-01 15:54:05,807 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;126;127;122;121;120;121;115;121;122;122 15:54:05 INFO - 2015-12-01 15:54:05,807 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;70;72;73;77;76;77;83;70;71 15:54:05 INFO - 2015-12-01 15:54:05,807 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;73;78;77;81;77;77;77;76;75 15:54:05 INFO - 2015-12-01 15:54:05,807 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;98;98;99;99;98;100;97;99;105 15:54:05 INFO - 2015-12-01 15:54:05,807 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;143;145;152;148;147;148;145;154;144;153 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;168;172;174;178;172;156;169;173;172;174 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;78;78;82;81;80;79;82;82;77 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: __startTimestamp1449014045800__endTimestamp 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,808 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:54:05 INFO - 2015-12-01 15:54:05,809 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:54:05 INFO - 2015-12-01 15:54:05,809 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,809 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.70 Median:124.00 stddev:9.08 (7.3%) stddev-sans-first:8.93 15:54:05 INFO - 2015-12-01 15:54:05,809 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 120.0 119.0 126.0 141.0 130.0 126.0 122.0 122.0 15:54:05 INFO - 2015-12-01 15:54:05,809 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,809 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:164.40 Median:171.00 stddev:14.89 (8.7%) stddev-sans-first:15.73 15:54:05 INFO - 2015-12-01 15:54:05,809 DEBUG : BROWSER_OUTPUT: Values: 168.0 150.0 183.0 178.0 149.0 170.0 146.0 181.0 172.0 147.0 15:54:05 INFO - 2015-12-01 15:54:05,809 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,810 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:187.20 Median:187.00 stddev:3.79 (2.0%) stddev-sans-first:3.71 15:54:05 INFO - 2015-12-01 15:54:05,810 DEBUG : BROWSER_OUTPUT: Values: 183.0 183.0 193.0 192.0 187.0 185.0 187.0 185.0 185.0 192.0 15:54:05 INFO - 2015-12-01 15:54:05,810 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,810 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.20 Median:80.50 stddev:22.24 (27.6%) stddev-sans-first:23.33 15:54:05 INFO - 2015-12-01 15:54:05,810 DEBUG : BROWSER_OUTPUT: Values: 83.0 80.0 93.0 132.0 77.0 78.0 81.0 84.0 135.0 79.0 15:54:05 INFO - 2015-12-01 15:54:05,810 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,810 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.40 Median:123.50 stddev:21.10 (17.1%) stddev-sans-first:21.31 15:54:05 INFO - 2015-12-01 15:54:05,810 DEBUG : BROWSER_OUTPUT: Values: 96.0 100.0 149.0 101.0 105.0 103.0 143.0 104.0 101.0 142.0 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.30 Median:136.50 stddev:3.65 (2.7%) stddev-sans-first:3.87 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: Values: 137.0 136.0 135.0 131.0 143.0 142.0 141.0 136.0 136.0 136.0 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:148.50 stddev:2.54 (1.7%) stddev-sans-first:2.67 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 147.0 142.0 147.0 149.0 147.0 143.0 149.0 149.0 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:121.70 Median:122.00 stddev:3.27 (2.7%) stddev-sans-first:3.07 15:54:05 INFO - 2015-12-01 15:54:05,811 DEBUG : BROWSER_OUTPUT: Values: 126.0 127.0 122.0 121.0 120.0 121.0 115.0 121.0 122.0 122.0 15:54:05 INFO - 2015-12-01 15:54:05,812 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,812 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:74.50 stddev:5.63 (7.6%) stddev-sans-first:4.30 15:54:05 INFO - 2015-12-01 15:54:05,812 DEBUG : BROWSER_OUTPUT: Values: 62.0 70.0 72.0 73.0 77.0 76.0 77.0 83.0 70.0 71.0 15:54:05 INFO - 2015-12-01 15:54:05,812 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,812 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.10 Median:77.00 stddev:2.96 (3.8%) stddev-sans-first:2.17 15:54:05 INFO - 2015-12-01 15:54:05,812 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 78.0 77.0 81.0 77.0 77.0 77.0 76.0 75.0 15:54:05 INFO - 2015-12-01 15:54:05,812 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,812 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.70 Median:98.00 stddev:2.75 (2.8%) stddev-sans-first:2.33 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: Values: 94.0 98.0 98.0 99.0 99.0 98.0 100.0 97.0 99.0 105.0 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:148.00 stddev:3.90 (2.6%) stddev-sans-first:3.71 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: Values: 143.0 145.0 152.0 148.0 147.0 148.0 145.0 154.0 144.0 153.0 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:172.50 stddev:5.88 (3.4%) stddev-sans-first:6.15 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: Values: 168.0 172.0 174.0 178.0 172.0 156.0 169.0 173.0 172.0 174.0 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: 15:54:05 INFO - 2015-12-01 15:54:05,813 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:80.50 stddev:2.86 (3.6%) stddev-sans-first:1.96 15:54:05 INFO - 2015-12-01 15:54:05,814 DEBUG : BROWSER_OUTPUT: Values: 73.0 78.0 78.0 82.0 81.0 80.0 79.0 82.0 82.0 77.0 15:54:05 INFO - 2015-12-01 15:54:05,814 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:54:05 INFO - 2015-12-01 15:54:05,814 DEBUG : BROWSER_OUTPUT: 15:54:06 INFO - 2015-12-01 15:54:06,431 INFO : Browser exited with error code: 0 15:54:06 INFO - 2015-12-01 15:54:06,487 INFO : Completed test kraken (00:01:00) 15:54:06 INFO - 2015-12-01 15:54:06,487 INFO : Starting test v8_7 15:54:06 INFO - 2015-12-01 15:54:06,487 DEBUG : operating with platform_type : mac_ 15:54:06 INFO - 2015-12-01 15:54:06,487 INFO : Initialising browser for v8_7 test... 15:54:06 INFO - 2015-12-01 15:54:06,502 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmpz_614r/profile http://localhost:54232/getInfo.html 15:54:09 INFO - 2015-12-01 15:54:09,229 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:54:09 INFO - 2015-12-01 15:54:09,229 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:54:09 INFO - 2015-12-01 15:54:09,230 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:54:09 INFO - 2015-12-01 15:54:09,230 DEBUG : BROWSER_OUTPUT: __metrics 15:54:09 INFO - 2015-12-01 15:54:09,847 INFO : Browser initialized. 15:54:09 INFO - 2015-12-01 15:54:09,847 INFO : Running cycle 1/1 for v8_7 test... 15:54:09 INFO - 2015-12-01 15:54:09,848 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/T/tmpz_614r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:54:21 INFO - 2015-12-01 15:54:21,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 209670144 15:54:21 INFO - 2015-12-01 15:54:21,791 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54232/tests/v8_7/run.html (next: http://localhost:54232/tests/v8_7/run.html) 15:54:43 INFO - 2015-12-01 15:54:43,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 230674432 15:54:43 INFO - 2015-12-01 15:54:43,620 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,620 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:54:43 INFO - 2015-12-01 15:54:43,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:54:43 INFO - 2015-12-01 15:54:43,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:54:43 INFO - 2015-12-01 15:54:43,620 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |0;Richards;176.7096660187312 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.55215718047398 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.6636528028933 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6429.48717948718 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1107.4197120708748 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |5;Earley;750.1875468867216 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |6;Boyer;13916.666666666666 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |7;RegExp;32031.25 15:54:43 INFO - 2015-12-01 15:54:43,621 DEBUG : BROWSER_OUTPUT: |8;Splay;621.5040397762585 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6410.25641025641 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: __startTimestamp1449014083617__endTimestamp 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:176.71 Median:176.71 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: Values: 176.7 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.55 Median:202.55 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,622 DEBUG : BROWSER_OUTPUT: Values: 202.6 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.66 Median:361.66 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: Values: 361.7 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6429.49 Median:6429.49 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: Values: 6429.5 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: Values: 1107.4 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:750.19 Median:750.19 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: Values: 750.2 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13916.67 Median:13916.67 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,623 DEBUG : BROWSER_OUTPUT: Values: 13916.7 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32031.25 Median:32031.25 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: Values: 32031.3 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.50 Median:621.50 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: Values: 621.5 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6410.26 Median:6410.26 stddev:0.00 (0.0%) 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: Values: 6410.3 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:54:43 INFO - 2015-12-01 15:54:43,624 DEBUG : BROWSER_OUTPUT: 15:54:44 INFO - 2015-12-01 15:54:44,239 INFO : Browser exited with error code: 0 15:54:44 INFO - 2015-12-01 15:54:44,262 INFO : Completed test v8_7 (00:00:37) 15:54:44 INFO - 2015-12-01 15:54:44,699 INFO : Completed test suite (00:20:09) 15:54:44 INFO - 2015-12-01 15:54:44,699 DEBUG : Working with test: dromaeo_css 15:54:44 INFO - 2015-12-01 15:54:44,699 DEBUG : Generating results file: dromaeo_css 15:54:44 INFO - 2015-12-01 15:54:44,700 DEBUG : Working with test: kraken 15:54:44 INFO - 2015-12-01 15:54:44,700 DEBUG : Generating results file: kraken 15:54:44 INFO - 2015-12-01 15:54:44,700 INFO : javascript benchmark 15:54:44 INFO - 2015-12-01 15:54:44,700 DEBUG : Working with test: v8_7 15:54:44 INFO - 2015-12-01 15:54:44,700 DEBUG : Generating results file: v8_7 15:54:44 INFO - 2015-12-01 15:54:44,700 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:54:44 INFO - 2015-12-01 15:54:44,754 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,57]] 15:54:44 INFO - 2015-12-01 15:54:44,754 DEBUG : process_Request line: dromaeo_css 5999.80 graph.html#tests=[[72,52,57]] 15:54:44 INFO - 2015-12-01 15:54:44,754 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:54:44 INFO - 2015-12-01 15:54:44,797 DEBUG : process_Request line: kraken 1732.70 graph.html#tests=[[232,52,57]] 15:54:44 INFO - 2015-12-01 15:54:44,797 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:54:44 INFO - 2015-12-01 15:54:44,828 DEBUG : process_Request line: v8_7 18662.30 graph.html#tests=[[230,52,57]] 15:54:44 INFO - 2015-12-01 15:54:44,828 INFO : javascript benchmark 15:54:44 INFO - 2015-12-01 15:54:44,830 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [295.49617901477984, 295.7279303041202, 312.75523416801116, 325.7784706399648, 326.9019294211737, 13768.518101866437, 14305.213213273266, 16421.096839673828, 16640.0, 16903.83096169038, 16129.193540322996, 16572.0, 17604.0, 17991.460256192302, 18059.90970045148, 4917.72952487613, 5014.097462456756, 5020.59835213182, 5040.1935690289565, 5042.722650254234, 3785.9053523661855, 3913.0, 4838.758062096898, 5308.283381743473, 5498.477644623775, 5417.079096553595, 5436.021516127095, 5436.700981446019, 5441.455854414547, 5458.918116228259, 4111.52717437494, 4256.021115143519, 4268.103698223345, 4270.316749320125, 5395.568354531628, 3593.4250519916686, 3634.9273014539826, 3656.104254457675, 3657.7805331680183, 3659.9634003660153, 11771.058315334838, 12117.212381195282, 12192.756144877141, 12254.81617775734, 12276.263424194576, 1712.0925909268108, 1733.8092809790912, 1763.7795275590552, 1809.8642601804786, 1812.8640351973522, 8751.606177722018, 8773.34199935001, 8832.205101540892, 8886.466811991237, 8970.192682658528, 1406.8171137752129, 1408.5633453629305, 1443.3432788081502, 1445.2629159128815, 1445.544653434165, 53307.466925330635, 55791.721041394936, 56029.0, 56441.71779141078, 56749.14876276859, 5885.087811389241, 6031.728572214261, 6043.395660434009, 6077.817665470043, 6200.906986395207, 7009.894851577231, 7054.964725176341, 7061.505694601328, 7083.7520686775715, 7095.964520177469, 5222.97388513055, 5235.7434215787935, 5243.790248390098, 5253.579713622901, 5285.154375299933, 5585.609007369445, 5609.326880774333, 5617.354004289559, 5660.377358490563, 5687.658740475585, 2693.8922443102447, 2738.151173136334, 2744.8490333031477, 2759.751622353998, 2779.3051737065734, 937.4281688170211, 952.7713348796377, 981.1807141037172, 1015.9898401015895, 1017.399734156851, 409.30418288908976, 412.9814158362881, 419.7313719219702, 427.17768296030016, 428.1757616588055, 10569.0, 10981.231313807957, 11026.724331891766, 11193.94403027996, 11265.94367028176, 426.6373582454888, 426.8740721487169, 428.23773682844586, 430.5371725395213, 432.81821634912785, 5548.140038294071, 5943.494802941798, 5985.461308482258, 6021.0, 6028.849278768066, 351778.0, 360649.0, 362327.0, 564193.0, 566672.0, 62137.68931155315, 68027.65986170038, 68398.91560020782, 68532.657336714, 69705.65147174231, 411.9279126152911, 419.4819398043414, 424.1072542298479, 425.55954587002304, 426.1966193724789, 9886.258530610377, 10135.949320253352, 10250.179985601284, 10255.487225638539, 10319.122874555447, 32281.67718322787, 32530.349393011533, 32681.34637307288, 32684.50973235451, 32957.0, 43439.78280108579, 45137.77431112823, 45830.770846145555, 45921.31118033166, 45927.31109033434, 5728.598998070095, 5733.684647344436, 5761.5102716269585, 5829.912551311819, 5841.795537156179, 10232.437215952896, 10835.783284334111, 10865.619703310345, 10889.891101088888, 10920.017198452177, 7743.883841742266, 7886.369090472863, 8937.28501719848, 9229.723108306762, 9276.907230927603, 8641.697540586048, 8981.640734370552, 9010.774730631787, 9041.457512549268, 9129.817403651758, 9243.537823108683, 9332.346735728433, 9388.530573471437, 9576.616935322787, 9606.0, 5734.5125664319, 5876.882462350814, 5902.2327097477055, 5943.3759455258305, 5960.612560183574, 9415.199708024895, 9463.0, 9555.90444095578, 9590.616375344907, 9754.609815607297], "dojo.html": [2841.6447944006995, 2950.7049295070497, 2956.27571245045, 3010.7139821716937, 3015.3818467214223, 4992.226204938236, 5018.4228813686395, 5039.571636410909, 5057.822976195834, 5079.5936325094, 4992.151334273173, 5040.395152581696, 5044.672096313737, 5076.314697515834, 5119.718415487147, 4491.910161796762, 4614.423197100363, 4667.39323887895, 4676.0, 4719.504452032538, 4534.501204867462, 4545.318202269669, 4562.247229207177, 4575.816967321303, 4603.079384123172, 4612.331211974261, 4620.029793743318, 4631.212693842038, 4666.323383109447, 4673.462551806551, 4588.816447342102, 4611.815527378901, 4623.791929363187, 4639.234526303173, 4651.767411629405, 4417.580329868657, 4468.597826195625, 4557.772111394417, 4571.0, 4621.514740952185, 4719.976400118012, 4922.926156107661, 4936.062148191832, 5000.0, 5042.798288068473, 5279.023380674587, 5294.047071527124, 5305.973470132663, 5322.946770532284, 5360.410354860962, 5244.711540865251, 5346.545543628797, 5406.459354064601, 5484.643498172606, 5521.199426083235, 5007.774650140753, 5037.848864534069, 5038.143515602356, 5057.393112826484, 5075.086484432837, 5338.946610533845, 5469.507744303032, 5489.094299440548, 5502.669839809624, 5516.531094856902, 5146.176611742103, 5200.63595548308, 5238.057149713089, 5270.130428479258, 5272.209168624737, 5323.441038690882, 5465.207544905967, 5511.421300763443, 5572.08060669993, 5641.746121424546, 5156.664816786972, 5254.579633629301, 5363.973180134152, 5382.703951282639, 5469.699166545799, 5178.404483484373, 5321.760520776575, 5327.38735045467, 5354.839354819362, 5414.7021913795115, 4193.1404062167185, 4201.243776120266, 4210.536840947493, 4217.8523751668545, 4229.555896630871, 3680.3743363627714, 3741.8877433677035, 3780.905477363033, 3786.8295926683363, 3813.447050177764, 4883.365162528919, 4978.8257410990445, 5035.0, 5061.620378471629, 5073.34046573943, 5436.10304299794, 5493.423190565013, 5516.668999860021, 5522.66863988162, 5589.832305030855, 4819.325294458778, 4919.3358896549225, 4928.112939670894, 4946.5053494650965, 4978.77595508203, 4724.196886529298, 4727.858164255078, 4734.100520901018, 4756.120117778222, 4792.472827988919, 5412.539934105566, 5417.241586177859, 5455.618106732491, 5480.671159730429, 5486.369067557122, 5150.793968241228, 5186.4035635902355, 5188.481151884932, 5247.2129180623215, 5347.919781203207, 5416.160495123105, 5429.538489228302, 5441.29263195782, 5458.0721277382145, 5467.9453205467435, 5047.444781074152, 5299.39057008449, 5299.6290259681455, 5348.358197016383, 5367.919481207707, 5359.249705041375, 5396.622236443568, 5443.673379597237, 5460.645058071372, 5547.861303467445, 5221.895562088813, 5265.236540701653, 5270.288511051112, 5293.179557168645, 5306.389765176899, 5108.361454818148, 5156.845294641167, 5213.504717051874, 5227.843164705065, 5275.604329675213, 4812.35033270504, 5088.516590923857, 5148.43367229612, 5176.301199338041, 5186.766595503136, 5251.159814429673, 5360.785568577369, 5377.193420986883, 5379.112446446449, 5457.69982650958, 4994.875128121826, 5071.315372424676, 5159.896802063862, 5263.052650522943, 5325.653832500875], "mootools.html": [1348.8044233586136, 1509.396241503399, 1540.4685383542678, 1588.4678632658058, 1614.2009705195921, 5910.763569457216, 5938.762449502025, 6385.680715964207, 6495.610263384195, 6530.542861999662, 6341.904871426921, 6510.739570417178, 6637.037629543714, 6641.800745977616, 6649.468042556596, 1891.7256997735356, 1932.7970563090885, 1937.0121238168565, 1941.2914286285545, 1954.1206457094365, 1924.2976313645488, 1951.834094102003, 1959.255482916497, 2018.9899050504728, 2025.6758918573032, 1932.690769476884, 1943.2906988949003, 1944.1445763863926, 1958.265650381107, 1961.7743959444633, 1853.8794978326366, 1901.3155264104912, 1901.372547059467, 1902.172554938606, 1903.1911437639017, 1946.902654867251, 1948.133080779054, 1972.8323092537153, 1980.821726044663, 1982.603479304145, 6524.151860258184, 6612.471002319851, 6623.801285961381, 6636.867262654768, 6671.032700258435, 4067.633912947819, 4136.234796562646, 4136.379543068534, 4144.171165766858, 4172.144710334374, 2249.8200143988443, 2310.6302991521275, 2449.8040156787592, 2513.3465299022387, 2528.608065749812, 735.2133217457323, 753.8869169624545, 774.6668932359083, 781.4646966827742, 782.6243403166455, 8468.110848360895, 8493.787655308604, 8521.062683104854, 8531.402801803939, 8536.103709110515, 3702.5371828521434, 3735.3836616958442, 3788.981055094762, 3802.923941521154, 3814.7138964577766, 7464.925350746423, 7477.102747670315, 7489.28851759082, 7507.211742766931, 7518.28576285252, 4203.26442872496, 4206.41110244566, 4214.283571792803, 4221.092465119953, 4245.490541135022, 3849.6920246380223, 3858.5176852893387, 3868.0, 3873.65137137659, 3875.457435958968, 3132.7807053506035, 3186.5441606454583, 3233.3856567252146, 3244.902652920416, 3263.6736326367172, 1026.4457193115634, 1027.984580231297, 1030.7680771826429, 1040.6825918094903, 1045.1012129568564, 1170.5025364220173, 1180.816973369129, 1191.9702007449882, 1204.3797444316185, 1209.4920133543933, 6284.528660350401, 6308.990561510228, 6328.050792381179, 6330.8100756977365, 6346.174997250328, 419.2014212924384, 422.5267700175823, 423.8516519218249, 429.448159115535, 429.787255308618, 5014.774335154927, 5088.465711100355, 5122.564582010496, 5139.408967968657, 5148.0, 6968.198657154391, 7193.100862392201, 7267.927320726831, 7518.511296765692, 7694.692212311445, 7571.3564347031115, 7587.241275872479, 7610.961945190239, 7629.656665450068, 7652.846943061219, 6117.051856962178, 6174.475169610633, 6212.254529456494, 6224.657643829632, 6292.590981586182, 6040.36576159497, 6042.939570604238, 6069.635821850703, 6084.513238940963, 6101.786437474667, 6729.192496900403, 6871.175458944958, 6881.243063262937, 6882.277360877236, 6885.2770459101075, 6975.058367120374, 7102.857942841011, 7135.964320178366, 7141.143062832493, 7147.0, 5896.410358964069, 5934.080217566284, 5950.2264705587995, 5981.252343457068, 5995.670238136944, 6115.7247923844425, 6176.073588961692, 6192.752289908533, 6205.968970155121, 6234.812955611339, 5771.480566749013, 5906.616069955439, 5996.37038110992, 6049.546284028804, 6083.847903802441, 5656.179853921076, 5866.970665146647, 5870.7945221917025, 5902.704864756831, 5912.083627037816, 6024.216851809237, 6026.427489388501, 6044.637321760709, 6052.425019623129, 6059.394060593905, 5166.225066240094, 5266.2363957225225, 5312.335958005249, 5328.440513746001, 5418.945810541844, 5468.753906074316, 5474.343078830566, 5484.972575137099, 5485.780568777204, 5494.203340515683], "ext.html": [518.9870253243669, 521.908665983453, 533.0644718518998, 536.2894165231069, 546.0171690956278, 36255.63744362559, 36811.63188368122, 36852.0, 37436.43845342322, 38101.809490952575, 40389.39415908756, 40928.181436371255, 41011.179776404526, 41081.79459102708, 41169.17661646765, 8487.915120848775, 8588.269997050258, 8638.438501497383, 8667.913320866774, 8783.95608021959, 8460.57697115145, 8505.829883402328, 8519.488830670149, 8547.145285471433, 8587.95706021469, 8425.1153628869, 8530.829383412329, 8535.445196062235, 8543.658253669846, 8591.828163436727, 8470.28002619778, 8540.402171848003, 8543.444676096035, 8584.484930904135, 8611.526366049864, 8225.588720563948, 8404.285635720971, 8430.45202061864, 8478.830423391497, 8489.235968762841, 37804.0, 37942.620573794185, 37954.81022594897, 38001.23997520062, 38031.0, 2296.609576372021, 2445.0252991535112, 2563.8974441022337, 2667.5331816932153, 3398.847051882671, 24858.5028299433, 24965.251042468753, 25693.743062569323, 25714.74285257142, 26034.349141271432, 2087.7390326209224, 2145.4743587820926, 2146.195176808697, 2229.108356657334, 2239.361781892153, 239714.0, 240218.0, 241588.0, 241963.0, 242351.0, 53526.7323663387, 55630.0, 56367.71816140975, 56614.43385566174, 59731.402685972585, 57268.14097788536, 57636.0, 57646.423535764945, 57654.0, 58116.41883581194, 16078.919605401898, 16343.918280408521, 16398.67202655964, 16431.26059327333, 16434.917825410797, 12034.398280085961, 12053.698657533456, 12059.879401206052, 12072.275663460221, 12170.269783812999, 18372.265109395743, 18555.35056273024, 18703.625927481648, 18791.24835006612, 18829.811701883078, 7557.697692092364, 7720.227977202235, 7799.9220007799195, 7832.569208693462, 7849.136594974662, 958.7651025498798, 997.8303688372994, 999.8950110238466, 1002.3785253143097, 1032.566322144701, 26707.866460667574, 27068.864655676596, 27826.582601260998, 28688.856555717088, 29660.0, 996.1632228927591, 998.8851282102506, 1003.8393856982848, 1065.898739619735, 1108.4758457121459, 11446.885531144748, 12771.489140434465, 13691.27248767042, 13698.315084245747, 14510.637234069232, 231940.0, 234951.0, 235297.0, 236329.0, 236866.0, 48329.75835120802, 48708.0, 48791.0, 48860.267095993586, 48868.0, 1315.4869600855675, 1323.3052647360214, 1323.6823162441137, 1324.1194605587368, 1337.6455239361576, 26143.215703528924, 27841.44317113687, 28013.579796302663, 28400.715992839807, 28424.147275581767, 46453.53546464492, 46713.2993005112, 46747.532524674316, 46766.0, 46793.53206468028, 288124.0, 290679.0, 291112.0, 291496.0850391469, 292817.0, 28671.283217919718, 28729.856350718113, 28915.56626650644, 29513.26216844596, 30497.0, 35899.82050089733, 36010.0, 36837.81581092077, 37288.0, 37423.43864842084, 29876.850615746782, 31244.0, 33628.0, 33633.15917102092, 34066.31867362688, 32980.67019329776, 33168.336633266714, 33170.50244246387, 33309.83345083259, 33586.16034599154, 33504.329913402085, 33909.66090339065, 34166.487502687974, 34233.31533369269, 34604.0, 26128.34679133037, 28450.0, 28473.0, 29040.564391534568, 29735.85132074326, 21302.254421095186, 21534.569308614053, 21803.67294490552, 21909.452263692896, 22331.330060098222], "prototype.html": [275.46284744747743, 275.5343469536483, 279.70630837620496, 281.6887339489862, 313.1060821355033, 5444.7822087116565, 5753.453421924921, 5768.884622307552, 5786.1610066540325, 5799.246098007264, 5655.688937108457, 5666.121751128581, 5678.34699009613, 5689.118186681071, 5696.430356964312, 4239.894002649943, 4261.211675839964, 4263.211305908401, 4290.742555446675, 4302.440682711243, 4247.023184667529, 4272.124214536013, 4281.35779633056, 4285.849995250167, 4298.656107511407, 4117.938230926538, 4233.978830105861, 4243.787810609472, 4269.893252668692, 4292.6780491463105, 4162.292410290258, 4205.747655140702, 4223.070924396628, 4227.852025179104, 4230.555791641895, 3580.838862251205, 3616.620254873253, 3622.6558476944647, 3635.0548857297294, 3643.599204087548, 5392.1911713242935, 5441.863953401157, 5444.237806707064, 5449.754761035763, 5452.482014208644, 4746.5490778376, 4784.569388755029, 4792.281157826319, 4824.8311309104365, 4847.854564363075, 5795.710214489301, 5890.499307558863, 5895.204147440127, 5898.8230353089475, 5899.439553242478, 3984.183242435294, 3987.4018897165365, 4020.43713880057, 4021.738586991836, 4024.9195016099516, 6099.268087829444, 6155.107509411155, 6166.7224974876235, 6167.938320616781, 6190.133381326618, 3978.741381810173, 4026.2953983053435, 4035.6771458283856, 4037.212743515045, 4050.9189816204102, 4126.3397856343445, 4142.91714165715, 4146.5853414658295, 4157.729747566398, 4158.189153115113, 4739.715617062919, 4801.303810947463, 4807.95192048082, 4810.013947140827, 4824.782884770194, 5856.326522449887, 5896.587238893322, 5920.259967504062, 5931.0, 5931.7627294907725, 1387.257817067864, 1398.5245016694168, 1455.5924341184486, 1469.0671423645847, 1502.9398824047134, 932.8507438809894, 949.0367277213634, 950.4344914775697, 969.0987381735054, 970.5195928015678, 5468.37113731918, 5487.6158668892795, 5489.615726899158, 5498.0, 5525.475079867406, 6060.848478788065, 6066.332703402622, 6092.847678807977, 6093.177421048191, 6102.72537735803, 5460.5085542301385, 5516.034693928626, 5534.086875665551, 5594.888102237933, 5618.410066942912, 3278.6229583597715, 3368.3768502827056, 3369.561956945581, 3399.7450191235757, 3410.7441941853963, 6220.098085777628, 6223.377662233831, 6227.813165605039, 6231.4391704746795, 6236.469900058546, 6260.624362538262, 6289.182406287154, 6293.96853015732, 6302.306746257908, 6323.462505686976, 6194.132821405007, 6219.098230756515, 6219.191505104308, 6225.595336303126, 6239.313675495782, 6164.106204600397, 6175.135481032569, 6176.382361763787, 6201.162843016135, 6207.96896015517, 6058.878822423439, 6059.242594675666, 6060.090986351906, 6061.878762424639, 6079.361667024898, 6119.424954614662, 6242.875142497215, 6251.593646412968, 6259.906101408574, 6276.089966954674, 4124.546299907068, 4126.051008268175, 4128.401381799682, 4140.15126898979, 4159.33450647907, 6030.246219222598, 6152.200213972334, 6185.969070154621, 6186.226721659793, 6207.6275423474735, 5901.232839730807, 5966.105084237225, 5967.46292833647, 5969.283685957713, 5978.790742323998, 5949.464548190684, 5954.821355359346, 5960.105984102246, 5977.641341519523, 6002.399760023963, 5631.070873305859, 5826.563007774349, 5831.504322132666, 5834.329052159056, 5860.472557469848, 6021.668808215591, 6024.789132380346, 6094.939050609437, 6095.695215239309, 6101.938980610137, 5944.4352786485215, 5957.3446920837805, 5963.91054134197, 5978.581499295007, 5979.372165922689], "yui.html": [677.7492327838697, 690.5718454558172, 707.1867352544573, 709.5919846088499, 715.2882881532876, 12584.937075314621, 12699.873001269985, 12965.870341296595, 12970.286634235114, 12976.026797990153, 13246.867531324708, 13440.19358838468, 13482.797758033614, 13527.32363381832, 13553.254570998592, 619.8295468746109, 786.0881377601997, 805.1827395193883, 806.9233422824851, 810.2586133687669, 644.8484606117559, 761.5697131120927, 784.2118670735903, 817.4278005396217, 822.880682301066, 832.063928080909, 839.4417712221366, 840.2185967050641, 841.4194205997842, 849.7875531117221, 832.7168762620707, 835.340081335744, 835.6532039203723, 845.2941793602349, 846.3313981954249, 604.8729766748944, 605.9878802423971, 613.4049971527611, 614.213806327901, 617.0651463033507, 12466.563670271587, 12570.497180112785, 12576.81134782979, 12618.55835045769, 12620.116591838574, 8867.689630862953, 8893.199612034949, 8973.955130224373, 9071.909280907239, 9319.534023298807, 7789.9221007789765, 7872.842543149162, 8003.159668234868, 8102.878456823152, 8184.549849758261, 2617.319496930793, 2661.507621090085, 2666.733326667337, 2708.133397312861, 2824.265690920355, 42478.0, 42977.71066867999, 43057.35413968793, 43064.1387172258, 43247.35128973099, 5708.4862362387585, 5760.884782304331, 5852.941470585325, 5950.464458198783, 6104.786332478342, 11396.658100257006, 11441.485133169028, 11443.0, 11483.31100133978, 11492.195546311845, 5204.739763011834, 5277.709725965109, 5332.626716129911, 5338.492843179892, 5400.189971504227, 3409.3351796399465, 3468.6531346865113, 3482.1120614243205, 3564.483149943244, 3668.4680721295263, 2406.482606239667, 2438.8536687798787, 2448.1676230081857, 2449.179524859192, 2457.1522824625476, 350.59331175836417, 354.4665278755508, 359.71043310135593, 359.73918908790915, 359.83087948664087, 402.2638571414305, 419.6831392298795, 422.12619876854615, 520.0560981817988, 526.6734624532814, 6742.83142921421, 6786.287439818847, 6948.131483564554, 6948.895766563505, 6968.841333531441, 519.8206618716537, 524.6170295684171, 540.8783023819609, 548.259849203572, 559.0663591801701, 3319.7344212462945, 3320.4521253993303, 3334.849931753077, 3368.494725791151, 3384.0, 54290.0, 55113.44886551164, 56022.15966760502, 57125.71437142871, 57559.42440575625, 45678.0, 45832.0, 46273.537264626924, 46336.0, 48083.75958120257, 44172.11655766867, 44246.0, 44406.33390499145, 44463.11073778571, 44506.77746611311, 7368.815779605553, 7430.92569074324, 7694.846103078019, 7737.381009519112, 7995.200479951958, 31952.20119496938, 31977.6802231984, 33134.83432582822, 33729.15677108092, 34337.0, 43536.78231608822, 44230.0, 44755.0, 44972.55027449814, 45021.77489112534, 6420.165378500765, 6465.870682586416, 6704.899426508704, 6968.686409111703, 7178.066851309296, 10274.794504109726, 10309.948450258, 10321.277510574188, 10628.89371106279, 10735.302205356627, 9323.067693230623, 9433.151016408556, 9632.95183524078, 9653.662121825702, 9974.0, 9533.142017218484, 9910.405375677483, 9995.100440960348, 10105.848412273675, 10138.442385668564, 9006.819863602823, 9424.62301507932, 9447.24422046221, 9679.56217405965, 9761.365511241747, 8224.588770561568, 8386.832263354576, 8421.915780842113, 8640.308775298086, 8821.206091451544, 8307.460015098999, 8521.616527256412, 8562.57187140628, 8573.699920502753, 8589.570521473775]}, "summary": {"suite": 5999.795251895192, "subtests": {"jquery.html": {"filtered": 6269.359416240291, "value": 6269.359416240291}, "dojo.html": {"filtered": 4953.875741578378, "value": 4953.875741578378}, "mootools.html": {"filtered": 3741.425300592283, "value": 3741.425300592283}, "ext.html": {"filtered": 17100.46641539118, "value": 17100.46641539118}, "prototype.html": {"filtered": 4426.675074262224, "value": 4426.675074262224}, "yui.html": {"filtered": 5302.5347036888525, "value": 5302.5347036888525}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0037.e"}, "testrun": {"date": 1449012874, "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": "20151201142430", "branch": "Mozilla-Aurora", "revision": "6c630e37e53f15976e1bdad36852e74fd073f3f7"}}, {"talos_counters": {}, "results": {"audio-dft": [183.0, 183.0, 193.0, 192.0, 187.0, 185.0, 187.0, 185.0, 185.0, 192.0], "ai-astar": [113.0, 108.0, 120.0, 119.0, 126.0, 141.0, 130.0, 126.0, 122.0, 122.0], "imaging-gaussian-blur": [137.0, 136.0, 135.0, 131.0, 143.0, 142.0, 141.0, 136.0, 136.0, 136.0], "audio-beat-detection": [168.0, 150.0, 183.0, 178.0, 149.0, 170.0, 146.0, 181.0, 172.0, 147.0], "json-stringify-tinderbox": [70.0, 73.0, 78.0, 77.0, 81.0, 77.0, 77.0, 77.0, 76.0, 75.0], "stanford-crypto-pbkdf2": [168.0, 172.0, 174.0, 178.0, 172.0, 156.0, 169.0, 173.0, 172.0, 174.0], "json-parse-financial": [62.0, 70.0, 72.0, 73.0, 77.0, 76.0, 77.0, 83.0, 70.0, 71.0], "stanford-crypto-sha256-iterative": [73.0, 78.0, 78.0, 82.0, 81.0, 80.0, 79.0, 82.0, 82.0, 77.0], "audio-fft": [83.0, 80.0, 93.0, 132.0, 77.0, 78.0, 81.0, 84.0, 135.0, 79.0], "imaging-darkroom": [148.0, 149.0, 147.0, 142.0, 147.0, 149.0, 147.0, 143.0, 149.0, 149.0], "stanford-crypto-ccm": [143.0, 145.0, 152.0, 148.0, 147.0, 148.0, 145.0, 154.0, 144.0, 153.0], "audio-oscillator": [96.0, 100.0, 149.0, 101.0, 105.0, 103.0, 143.0, 104.0, 101.0, 142.0], "stanford-crypto-aes": [94.0, 98.0, 98.0, 99.0, 99.0, 98.0, 100.0, 97.0, 99.0, 105.0], "imaging-desaturate": [126.0, 127.0, 122.0, 121.0, 120.0, 121.0, 115.0, 121.0, 122.0, 122.0]}, "summary": {"suite": 1732.7, "subtests": {"audio-fft": {"filtered": 92.2, "value": 92.2}, "stanford-crypto-pbkdf2": {"filtered": 170.8, "value": 170.8}, "audio-beat-detection": {"filtered": 164.4, "value": 164.4}, "stanford-crypto-ccm": {"filtered": 147.9, "value": 147.9}, "imaging-darkroom": {"filtered": 147.0, "value": 147.0}, "json-parse-financial": {"filtered": 73.1, "value": 73.1}, "audio-oscillator": {"filtered": 114.4, "value": 114.4}, "ai-astar": {"filtered": 122.7, "value": 122.7}, "audio-dft": {"filtered": 187.2, "value": 187.2}, "stanford-crypto-sha256-iterative": {"filtered": 79.2, "value": 79.2}, "json-stringify-tinderbox": {"filtered": 76.1, "value": 76.1}, "imaging-gaussian-blur": {"filtered": 137.3, "value": 137.3}, "stanford-crypto-aes": {"filtered": 98.7, "value": 98.7}, "imaging-desaturate": {"filtered": 121.7, "value": 121.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0037.e"}, "testrun": {"date": 1449012874, "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": "20151201142430", "branch": "Mozilla-Aurora", "revision": "6c630e37e53f15976e1bdad36852e74fd073f3f7"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.55215718047398], "Encrypt": [361.6636528028933], "NavierStokes": [6410.25641025641], "Decrypt": [6429.48717948718], "Splay": [621.5040397762585], "Richards": [176.7096660187312], "RegExp": [32031.25], "Earley": [750.1875468867216], "Boyer": [13916.666666666666], "RayTrace": [1107.4197120708748]}, "summary": {"suite": 18662.30216921504, "subtests": {"DeltaBlue": {"filtered": 326.4245660000001, "value": 326.4245660000001}, "Encrypt": {"filtered": 735.990465, "value": 735.990465}, "NavierStokes": {"filtered": 231.5039999999999, "value": 231.5039999999999}, "Decrypt": {"filtered": 41.40003589232305, "value": 41.40003589232305}, "Splay": {"filtered": 131.11901899999998, "value": 131.11901899999998}, "RegExp": {"filtered": 28.440507317073152, "value": 28.440507317073152}, "Richards": {"filtered": 199.77401799999998, "value": 199.77401799999998}, "Earley": {"filtered": 888.3951789999996, "value": 888.3951789999996}, "Boyer": {"filtered": 47.88955688622753, "value": 47.88955688622753}, "RayTrace": {"filtered": 668.2100670000003, "value": 668.2100670000003}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0037.e"}, "testrun": {"date": 1449012874, "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": "20151201142430", "branch": "Mozilla-Aurora", "revision": "6c630e37e53f15976e1bdad36852e74fd073f3f7"}}] 15:54:44 INFO - RETURN: dromaeo_css: 5999.80 15:54:44 INFO - RETURN: kraken: 1732.70 15:54:44 INFO - RETURN: v8_7: 18662.30 15:54:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,57]]", "result": "18662.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,57]]", "result": "1732.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,57]]", "result": "5999.80"}}} 15:54:44 INFO - Return code: 0 15:54:44 INFO - # TBPL SUCCESS # 15:54:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:54:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:54:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:54:44 INFO - 2015-12-01 15:54:44.948 screenresolution[1983:21241] starting screenresolution argv=screenresolution get 15:54:44 INFO - 2015-12-01 15:54:44.951 screenresolution[1983:21241] Display 0: 1600x1200x32@60 15:54:44 INFO - 2015-12-01 15:54:44.957 screenresolution[1984:21244] starting screenresolution argv=screenresolution list 15:54:44 INFO - Available Modes on Display 0 15:54:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:54:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:54:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:54:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:54:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:54:45 INFO - Intel HD Graphics 3000: 15:54:45 INFO - Chipset Model: Intel HD Graphics 3000 15:54:45 INFO - Type: GPU 15:54:45 INFO - Bus: Built-In 15:54:45 INFO - VRAM (Total): 512 MB 15:54:45 INFO - VRAM (Dynamic, Max): 10 15:54:45 INFO - Vendor: Intel (0x8086) 15:54:45 INFO - Device ID: 0x0116 15:54:45 INFO - Revision ID: 0x0009 15:54:45 INFO - Displays: 15:54:45 INFO - Display: 15:54:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:54:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:54:45 INFO - Display Serial Number: 1600x1200 60 15:54:45 INFO - Main Display: Yes 15:54:45 INFO - Mirror: Off 15:54:45 INFO - Online: Yes 15:54:45 INFO - Rotation: Supported 15:54:45 INFO - Return code: 0 15:54:45 INFO - Running post-action listener: _resource_record_post_action 15:54:45 INFO - Running post-run listener: _resource_record_post_run 15:54:46 INFO - Total resource usage - Wall time: 1251s; CPU: 30.0%; Read bytes: 2154496; Write bytes: 689439744; Read time: 42; Write time: 48294 15:54:46 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 336413184; Write bytes: 340441600; Read time: 34387; Write time: 6365 15:54:46 INFO - run-tests - Wall time: 1211s; CPU: 30.0%; Read bytes: 2154496; Write bytes: 340931584; Read time: 42; Write time: 41209 15:54:46 INFO - Running post-run listener: _upload_blobber_files 15:54:46 INFO - Blob upload gear active. 15:54:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:54:46 INFO - Copying logs to upload dir... 15:54:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1312.613941 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-12-01 15:54:46.900894) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 15:54:46.907916) ========= 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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010098 build_url: 'https://queue.taskcluster.net/v1/task/A0--mZNIRxeOdcq7F5S8RQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.38 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 15:54:47.293822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2015-12-01 15:54:47.294186) ========= 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.cWzKmPdfEL/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.AOTyCkEzE5/Listeners TMPDIR=/var/folders/r8/6scj84k151l2d31q_f6wgmlr00000w/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.005177 ========= master_lag: 5.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2015-12-01 15:54:52.373034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 15:54:52.373478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 15:54:52.380536) ========= ========= Total master_lag: 6.13 =========