builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0022 starttime: 1447348102.5 results: success (0) buildid: 20151112075246 builduid: bb3c22d3ce594d3ebe6b5fb054bbdc64 revision: 056d07ff03c89ebe77ca4771fc0b02365a6a7b41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:22.501130) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:22.501608) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:22.501917) ========= 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.rjjiBjX6yE/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.kYQLXhOCle/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.006079 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:22.535839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:22.536168) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:22.566900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-11-12 09:08:22.567293) ========= 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.rjjiBjX6yE/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.kYQLXhOCle/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.006053 ========= master_lag: 3.85 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-11-12 09:08:26.420664) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:26.421000) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:26.421379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:26.421684) ========= 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.rjjiBjX6yE/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.kYQLXhOCle/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-12 09:08:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, :: Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.49M=0.002s 2015-11-12 09:08:26 (7.49 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142044 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:26.648315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:26.648660) ========= 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.rjjiBjX6yE/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.kYQLXhOCle/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.020891 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:26.696300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:26.696795) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 056d07ff03c89ebe77ca4771fc0b02365a6a7b41 --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 056d07ff03c89ebe77ca4771fc0b02365a6a7b41 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rjjiBjX6yE/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.kYQLXhOCle/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-12 09:08:26,775 truncating revision to first 12 chars 2015-11-12 09:08:26,776 Setting DEBUG logging. 2015-11-12 09:08:26,776 attempt 1/10 2015-11-12 09:08:26,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/056d07ff03c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 09:08:27,027 unpacking tar archive at: mozilla-aurora-056d07ff03c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516801 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:27.245962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:27.246315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:27.267294) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:27.267775) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 09:08:27.268275) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-11-12 09:08:27.268639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rjjiBjX6yE/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.kYQLXhOCle/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 09:08:27 INFO - MultiFileLogger online at 20151112 09:08:27 in /builds/slave/test 09:08:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:08:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:08:27 INFO - {'append_to_log': False, 09:08:27 INFO - 'base_work_dir': '/builds/slave/test', 09:08:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:08:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:08:27 INFO - 'branch': 'Mozilla-Aurora', 09:08:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:08:27 INFO - 'config_files': ('talos/mac_config.py',), 09:08:27 INFO - 'default_actions': ('clobber', 09:08:27 INFO - 'read-buildbot-config', 09:08:27 INFO - 'download-and-extract', 09:08:27 INFO - 'populate-webroot', 09:08:27 INFO - 'create-virtualenv', 09:08:27 INFO - 'install', 09:08:27 INFO - 'run-tests'), 09:08:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:08:27 INFO - 'download_minidump_stackwalk': True, 09:08:27 INFO - 'download_symbols': 'ondemand', 09:08:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:08:27 INFO - 'tooltool.py': '/tools/tooltool.py', 09:08:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:08:27 INFO - '/tools/misc-python/virtualenv.py')}, 09:08:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:08:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:08:27 INFO - 'installer_path': 'installer.exe', 09:08:27 INFO - 'log_level': 'info', 09:08:27 INFO - 'log_name': 'talos', 09:08:27 INFO - 'log_to_console': True, 09:08:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:08:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:08:27 INFO - 'opt_config_files': (), 09:08:27 INFO - 'pip_index': False, 09:08:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:08:27 INFO - 'cmd': ('bash', 09:08:27 INFO - '-c', 09:08:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:08:27 INFO - 'enabled': True, 09:08:27 INFO - 'halt_on_failure': False, 09:08:27 INFO - 'name': 'check_screen_resolution'},), 09:08:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:08:27 INFO - 'cmd': ('bash', 09:08:27 INFO - '-c', 09:08:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:08:27 INFO - 'enabled': True, 09:08:27 INFO - 'halt_on_failure': False, 09:08:27 INFO - 'name': 'check_screen_resolution'},), 09:08:27 INFO - 'run_cmd_checks_enabled': True, 09:08:27 INFO - 'sps_profile': False, 09:08:27 INFO - 'sps_profile_interval': 0, 09:08:27 INFO - 'suite': 'dromaeojs', 09:08:27 INFO - 'system_bits': '64', 09:08:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:08:27 INFO - 'title': 't-yosemite-r5-0022', 09:08:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:08:27 INFO - 'use_talos_json': True, 09:08:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:08:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:08:27 INFO - 'work_dir': 'build'} 09:08:27 INFO - ##### 09:08:27 INFO - ##### Running clobber step. 09:08:27 INFO - ##### 09:08:27 INFO - Running pre-action listener: _resource_record_pre_action 09:08:27 INFO - Running main action method: clobber 09:08:27 INFO - rmtree: /builds/slave/test/build 09:08:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:08:30 INFO - Running post-action listener: _resource_record_post_action 09:08:30 INFO - ##### 09:08:30 INFO - ##### Running read-buildbot-config step. 09:08:30 INFO - ##### 09:08:30 INFO - Running pre-action listener: _resource_record_pre_action 09:08:30 INFO - Running main action method: read_buildbot_config 09:08:30 INFO - Using buildbot properties: 09:08:30 INFO - { 09:08:30 INFO - "properties": { 09:08:30 INFO - "buildnumber": 417, 09:08:30 INFO - "product": "firefox", 09:08:30 INFO - "script_repo_revision": "production", 09:08:30 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 09:08:30 INFO - "repository": "", 09:08:30 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 09:08:30 INFO - "buildid": "20151112075246", 09:08:30 INFO - "slavename": "t-yosemite-r5-0022", 09:08:30 INFO - "pgo_build": "False", 09:08:30 INFO - "basedir": "/builds/slave/test", 09:08:30 INFO - "project": "", 09:08:30 INFO - "platform": "yosemite", 09:08:30 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:08:30 INFO - "slavebuilddir": "test", 09:08:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:08:30 INFO - "branch": "mozilla-aurora", 09:08:30 INFO - "repo_path": "releases/mozilla-aurora", 09:08:30 INFO - "stage_platform": "macosx64", 09:08:30 INFO - "builduid": "bb3c22d3ce594d3ebe6b5fb054bbdc64", 09:08:30 INFO - "revision": "056d07ff03c89ebe77ca4771fc0b02365a6a7b41" 09:08:30 INFO - }, 09:08:30 INFO - "sourcestamp": { 09:08:30 INFO - "repository": "", 09:08:30 INFO - "hasPatch": false, 09:08:30 INFO - "project": "", 09:08:30 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:08:30 INFO - "changes": [ 09:08:30 INFO - { 09:08:30 INFO - "category": null, 09:08:30 INFO - "files": [ 09:08:30 INFO - { 09:08:30 INFO - "url": null, 09:08:30 INFO - "name": "https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 09:08:30 INFO - } 09:08:30 INFO - ], 09:08:30 INFO - "repository": "", 09:08:30 INFO - "rev": "056d07ff03c89ebe77ca4771fc0b02365a6a7b41", 09:08:30 INFO - "who": "bkelly@mozilla.com", 09:08:30 INFO - "when": 1447347996, 09:08:30 INFO - "number": 6654030, 09:08:30 INFO - "comments": "Bug 1213932 - Restrict ServiceWorker logging to windows that match navigator.serviceWorker.controller.scriptURL;r=baku,r=past, a=ritu", 09:08:30 INFO - "project": "", 09:08:30 INFO - "at": "Thu 12 Nov 2015 09:06:36", 09:08:30 INFO - "branch": "mozilla-aurora-macosx64-talos", 09:08:30 INFO - "revlink": "", 09:08:30 INFO - "properties": [ 09:08:30 INFO - [ 09:08:30 INFO - "buildid", 09:08:30 INFO - "20151112075246", 09:08:30 INFO - "Change" 09:08:30 INFO - ], 09:08:30 INFO - [ 09:08:30 INFO - "builduid", 09:08:30 INFO - "bb3c22d3ce594d3ebe6b5fb054bbdc64", 09:08:30 INFO - "Change" 09:08:30 INFO - ], 09:08:30 INFO - [ 09:08:30 INFO - "pgo_build", 09:08:30 INFO - "False", 09:08:30 INFO - "Change" 09:08:30 INFO - ] 09:08:30 INFO - ], 09:08:30 INFO - "revision": "056d07ff03c89ebe77ca4771fc0b02365a6a7b41" 09:08:30 INFO - } 09:08:30 INFO - ], 09:08:30 INFO - "revision": "056d07ff03c89ebe77ca4771fc0b02365a6a7b41" 09:08:30 INFO - } 09:08:30 INFO - } 09:08:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 09:08:30 INFO - Running post-action listener: _resource_record_post_action 09:08:30 INFO - ##### 09:08:30 INFO - ##### Running download-and-extract step. 09:08:30 INFO - ##### 09:08:30 INFO - Running pre-action listener: _resource_record_pre_action 09:08:30 INFO - Running main action method: download_and_extract 09:08:30 INFO - mkdir: /builds/slave/test/build/tests 09:08: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')]} 09:08:30 INFO - https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/test_packages.json 09:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/test_packages.json 09:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:08:30 INFO - Downloaded 1149 bytes. 09:08:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:08:30 INFO - Using the following test package requirements: 09:08:30 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:08:30 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:08:30 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 09:08:30 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:08:30 INFO - u'jsshell-mac.zip'], 09:08:30 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:08:30 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 09:08:30 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:08:30 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:08:30 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 09:08:30 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:08:30 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 09:08:30 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:08:30 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 09:08:30 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 09:08:30 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 09:08:30 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 09:08:30 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:08: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')]} 09:08:30 INFO - https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:08:32 INFO - Downloaded 17447652 bytes. 09:08:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:08:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:08:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 09:08:37 INFO - Return code: 0 09:08:37 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:08: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')]} 09:08:37 INFO - https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:08:39 INFO - Downloaded 17447652 bytes. 09:08:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:08:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 09:08:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 09:08:44 INFO - Return code: 0 09:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:44 INFO - https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:08:46 INFO - Downloaded 11131307 bytes. 09:08:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 09:08:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 09:08:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:08:46 INFO - Return code: 0 09:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:46 INFO - https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 09:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 09:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 09:08:51 INFO - Downloaded 107717669 bytes. 09:08:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:08:51 INFO - mkdir: /builds/slave/test/properties 09:08:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:08:51 INFO - Writing to file /builds/slave/test/properties/build_url 09:08:51 INFO - Contents: 09:08:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 09:08:51 INFO - Running post-action listener: _resource_record_post_action 09:08:51 INFO - Running post-action listener: set_extra_try_arguments 09:08:51 INFO - ##### 09:08:51 INFO - ##### Running populate-webroot step. 09:08:51 INFO - ##### 09:08:51 INFO - Running pre-action listener: _resource_record_pre_action 09:08:51 INFO - Running main action method: populate_webroot 09:08:51 INFO - Guessing talos json url... 09:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:51 INFO - https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 09:08:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 09:08:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 09:08:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 09:08:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 09:08:52 INFO - Downloaded 107 bytes. 09:08:52 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 09:08:52 INFO - Contents: 09:08:52 INFO - 20151112075246 09:08:52 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/056d07ff03c89ebe77ca4771fc0b02365a6a7b41 09:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:52 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/056d07ff03/testing/talos/talos.json 09:08:52 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/056d07ff03/testing/talos/talos.json to /builds/slave/test/build/talos.json 09:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/056d07ff03/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 09:08:53 INFO - Downloaded 4264 bytes. 09:08:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:08:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:08:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:08:53 INFO - '../fennec_ids.txt'], 09:08:53 INFO - 'tests': ['tcheck2']}, 09:08:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:08:53 INFO - '--tppagecycles', 09:08:53 INFO - '7'], 09:08:53 INFO - 'tests': ['tsvgm']}}, 09:08:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:08:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:08:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:08:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:08:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:53 INFO - 'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:53 INFO - 'tests': ['damp', 'tps']}, 09:08:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:53 INFO - 'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['damp', 'tps']}, 09:08:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:08:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:08:53 INFO - 'other': {'tests': ['a11yr', 09:08:53 INFO - 'ts_paint', 09:08:53 INFO - 'tpaint', 09:08:53 INFO - 'sessionrestore', 09:08:53 INFO - 'sessionrestore_no_auto_restore']}, 09:08:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['a11yr', 09:08:53 INFO - 'ts_paint', 09:08:53 INFO - 'tpaint', 09:08:53 INFO - 'sessionrestore', 09:08:53 INFO - 'sessionrestore_no_auto_restore']}, 09:08:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['a11yr', 09:08:53 INFO - 'ts_paint', 09:08:53 INFO - 'tpaint', 09:08:53 INFO - 'sessionrestore', 09:08:53 INFO - 'sessionrestore_no_auto_restore']}, 09:08:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['a11yr', 09:08:53 INFO - 'ts_paint', 09:08:53 INFO - 'tpaint', 09:08:53 INFO - 'sessionrestore', 09:08:53 INFO - 'sessionrestore_no_auto_restore']}, 09:08:53 INFO - 'other_l64': {'tests': ['a11yr', 09:08:53 INFO - 'ts_paint', 09:08:53 INFO - 'tpaint', 09:08:53 INFO - 'sessionrestore', 09:08:53 INFO - 'sessionrestore_no_auto_restore']}, 09:08:53 INFO - 'other_nol64': {'tests': ['a11yr', 09:08:53 INFO - 'ts_paint', 09:08:53 INFO - 'tpaint', 09:08:53 INFO - 'sessionrestore', 09:08:53 INFO - 'sessionrestore_no_auto_restore']}, 09:08:53 INFO - 'svgr': {'tests': ['tsvgx', 09:08:53 INFO - 'tsvgr_opacity', 09:08:53 INFO - 'tart', 09:08:53 INFO - 'tscrollx', 09:08:53 INFO - 'cart']}, 09:08:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['tsvgx', 09:08:53 INFO - 'tsvgr_opacity', 09:08:53 INFO - 'tart', 09:08:53 INFO - 'tscrollx', 09:08:53 INFO - 'cart']}, 09:08:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:53 INFO - 'tests': ['tp5o']}, 09:08:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:53 INFO - 'talos_options': ['--e10s'], 09:08:53 INFO - 'tests': ['tp5o']}, 09:08:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:53 INFO - 'talos_options': ['--xperf_path', 09:08:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:53 INFO - 'tests': ['tp5n']}, 09:08:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:53 INFO - 'talos_options': ['--e10s', 09:08:53 INFO - '--xperf_path', 09:08:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 09:08:53 INFO - 'C:/slave/talos-data/talos/xperf.config'], 09:08:53 INFO - 'tests': ['tp5n']}}, 09:08:53 INFO - 'talos.zip': {'path': '', 09:08:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:08:53 INFO - Running post-action listener: _resource_record_post_action 09:08:53 INFO - ##### 09:08:53 INFO - ##### Running create-virtualenv step. 09:08:53 INFO - ##### 09:08:53 INFO - Running pre-action listener: _resource_record_pre_action 09:08:53 INFO - Running main action method: create_virtualenv 09:08:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:08:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:08:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:08:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:08:53 INFO - Using real prefix '/tools/python27' 09:08:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:08:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:08:57 INFO - Installing pip.................done. 09:08:57 INFO - Return code: 0 09:08:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:57 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 0x10d372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa0f4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3279f0>, '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 0x10d086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f1990>, '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.rjjiBjX6yE/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.kYQLXhOCle/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjjiBjX6yE/Render', 09:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:08:57 INFO - 'HOME': '/Users/cltbld', 09:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:08:57 INFO - 'LOGNAME': 'cltbld', 09:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:57 INFO - 'MOZ_NO_REMOTE': '1', 09:08:57 INFO - 'NO_EM_RESTART': '1', 09:08:57 INFO - 'PAGER': '/bin/cat', 09:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:57 INFO - 'PWD': '/builds/slave/test', 09:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:08:57 INFO - 'SHELL': '/bin/bash', 09:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kYQLXhOCle/Listeners', 09:08:57 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 09:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:08:57 INFO - 'USER': 'cltbld', 09:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:57 INFO - 'XPC_FLAGS': '0x0', 09:08:57 INFO - 'XPC_SERVICE_NAME': '0', 09:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:08:57 INFO - Cleaning up... 09:08:57 INFO - Return code: 0 09:08:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:57 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 0x10d372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa0f4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3279f0>, '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 0x10d086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f1990>, '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.rjjiBjX6yE/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.kYQLXhOCle/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjjiBjX6yE/Render', 09:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:08:57 INFO - 'HOME': '/Users/cltbld', 09:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:08:57 INFO - 'LOGNAME': 'cltbld', 09:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:57 INFO - 'MOZ_NO_REMOTE': '1', 09:08:57 INFO - 'NO_EM_RESTART': '1', 09:08:57 INFO - 'PAGER': '/bin/cat', 09:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:57 INFO - 'PWD': '/builds/slave/test', 09:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:08:57 INFO - 'SHELL': '/bin/bash', 09:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kYQLXhOCle/Listeners', 09:08:57 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 09:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:08:57 INFO - 'USER': 'cltbld', 09:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:57 INFO - 'XPC_FLAGS': '0x0', 09:08:57 INFO - 'XPC_SERVICE_NAME': '0', 09:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:58 INFO - Downloading/unpacking psutil>=0.7.1 09:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:09:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:09:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:01 INFO - Installing collected packages: psutil 09:09:01 INFO - Running setup.py install for psutil 09:09:01 INFO - building 'psutil._psutil_osx' extension 09:09:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:09:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:09:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:09:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:09:01 INFO - building 'psutil._psutil_posix' extension 09:09:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:09:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:09:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:09:01 INFO - ^ 09:09:01 INFO - 1 warning generated. 09:09:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:09:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:02 INFO - Successfully installed psutil 09:09:02 INFO - Cleaning up... 09:09:02 INFO - Return code: 0 09:09:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa0f4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3279f0>, '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 0x10d086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f1990>, '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.rjjiBjX6yE/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.kYQLXhOCle/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjjiBjX6yE/Render', 09:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:02 INFO - 'HOME': '/Users/cltbld', 09:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:02 INFO - 'LOGNAME': 'cltbld', 09:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:02 INFO - 'MOZ_NO_REMOTE': '1', 09:09:02 INFO - 'NO_EM_RESTART': '1', 09:09:02 INFO - 'PAGER': '/bin/cat', 09:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:02 INFO - 'PWD': '/builds/slave/test', 09:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:02 INFO - 'SHELL': '/bin/bash', 09:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kYQLXhOCle/Listeners', 09:09:02 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 09:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:02 INFO - 'USER': 'cltbld', 09:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:02 INFO - 'XPC_FLAGS': '0x0', 09:09:02 INFO - 'XPC_SERVICE_NAME': '0', 09:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:09:05 INFO - Installing collected packages: mozsystemmonitor 09:09:05 INFO - Running setup.py install for mozsystemmonitor 09:09:05 INFO - Successfully installed mozsystemmonitor 09:09:05 INFO - Cleaning up... 09:09:05 INFO - Return code: 0 09:09:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:05 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 0x10d372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa0f4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3279f0>, '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 0x10d086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f1990>, '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.rjjiBjX6yE/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.kYQLXhOCle/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjjiBjX6yE/Render', 09:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:05 INFO - 'HOME': '/Users/cltbld', 09:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:05 INFO - 'LOGNAME': 'cltbld', 09:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:05 INFO - 'MOZ_NO_REMOTE': '1', 09:09:05 INFO - 'NO_EM_RESTART': '1', 09:09:05 INFO - 'PAGER': '/bin/cat', 09:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:05 INFO - 'PWD': '/builds/slave/test', 09:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:05 INFO - 'SHELL': '/bin/bash', 09:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kYQLXhOCle/Listeners', 09:09:05 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 09:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:05 INFO - 'USER': 'cltbld', 09:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:05 INFO - 'XPC_FLAGS': '0x0', 09:09:05 INFO - 'XPC_SERVICE_NAME': '0', 09:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:09 INFO - Downloading docopt-0.6.1.tar.gz 09:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:09 INFO - Running setup.py install for blobuploader 09:09:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:10 INFO - Running setup.py install for requests 09:09:10 INFO - Running setup.py install for docopt 09:09:10 INFO - Successfully installed blobuploader requests docopt 09:09:10 INFO - Cleaning up... 09:09:11 INFO - Return code: 0 09:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:11 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 0x10d372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa0f4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3279f0>, '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 0x10d086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f1990>, '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.rjjiBjX6yE/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.kYQLXhOCle/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjjiBjX6yE/Render', 09:09:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:11 INFO - 'HOME': '/Users/cltbld', 09:09:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:11 INFO - 'LOGNAME': 'cltbld', 09:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:11 INFO - 'MOZ_NO_REMOTE': '1', 09:09:11 INFO - 'NO_EM_RESTART': '1', 09:09:11 INFO - 'PAGER': '/bin/cat', 09:09:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:11 INFO - 'PWD': '/builds/slave/test', 09:09:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:11 INFO - 'SHELL': '/bin/bash', 09:09:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kYQLXhOCle/Listeners', 09:09:11 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 09:09:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:11 INFO - 'USER': 'cltbld', 09:09:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:11 INFO - 'XPC_FLAGS': '0x0', 09:09:11 INFO - 'XPC_SERVICE_NAME': '0', 09:09:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:11 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-0b55Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:11 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-xZicyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:11 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-hgB3h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:11 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-qfHR7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:11 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-BftnzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:12 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-E2x85u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:12 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-k3MNJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:12 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-bGyoCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:12 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-K3q4CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:12 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-BnlVX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:12 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-Yk4LGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:12 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-FVpxfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:12 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-gmaArx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:13 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-VTUX0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:13 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-EJo7VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:13 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-3zH3Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:13 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-HKBaHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:13 INFO - Running setup.py install for manifestparser 09:09:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:13 INFO - Running setup.py install for mozcrash 09:09:13 INFO - Running setup.py install for mozdebug 09:09:14 INFO - Running setup.py install for mozdevice 09:09:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:09:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:14 INFO - Running setup.py install for mozfile 09:09:14 INFO - Running setup.py install for mozhttpd 09:09:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:14 INFO - Running setup.py install for mozinfo 09:09:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:14 INFO - Running setup.py install for mozInstall 09:09:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:15 INFO - Running setup.py install for mozleak 09:09:15 INFO - Running setup.py install for mozlog 09:09:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:15 INFO - Running setup.py install for moznetwork 09:09:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:15 INFO - Running setup.py install for mozprocess 09:09:15 INFO - Running setup.py install for mozprofile 09:09:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:16 INFO - Running setup.py install for mozrunner 09:09:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:16 INFO - Running setup.py install for mozscreenshot 09:09:16 INFO - Running setup.py install for moztest 09:09:16 INFO - Running setup.py install for mozversion 09:09:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:16 INFO - Cleaning up... 09:09:16 INFO - Return code: 0 09:09:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10d372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa0f4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3279f0>, '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 0x10d086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f1990>, '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.rjjiBjX6yE/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.kYQLXhOCle/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjjiBjX6yE/Render', 09:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:16 INFO - 'HOME': '/Users/cltbld', 09:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:16 INFO - 'LOGNAME': 'cltbld', 09:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:16 INFO - 'MOZ_NO_REMOTE': '1', 09:09:16 INFO - 'NO_EM_RESTART': '1', 09:09:16 INFO - 'PAGER': '/bin/cat', 09:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:16 INFO - 'PWD': '/builds/slave/test', 09:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:16 INFO - 'SHELL': '/bin/bash', 09:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kYQLXhOCle/Listeners', 09:09:16 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 09:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:16 INFO - 'USER': 'cltbld', 09:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:16 INFO - 'XPC_FLAGS': '0x0', 09:09:16 INFO - 'XPC_SERVICE_NAME': '0', 09:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:17 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-oe_RdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:17 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-23MXgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:17 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-mVtXnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:17 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-xwmWMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:17 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-HygpM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:17 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-iftxkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:18 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-d4ripg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:18 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-4hGuBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:18 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-6fzQo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:18 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-aUr34_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:18 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-Xw5LJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:18 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-hZrC6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:18 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-GLhYSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:19 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-rqX68P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:19 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-Vvhv3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:19 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-WCJDn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:19 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-kbJDuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:22 INFO - Downloading blessings-1.5.1.tar.gz 09:09:22 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:22 INFO - Installing collected packages: blessings 09:09:22 INFO - Running setup.py install for blessings 09:09:22 INFO - Successfully installed blessings 09:09:22 INFO - Cleaning up... 09:09:22 INFO - Return code: 0 09:09:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:22 INFO - Reading from file tmpfile_stdout 09:09:22 INFO - Current package versions: 09:09:22 INFO - blessings == 1.5.1 09:09:22 INFO - blobuploader == 1.2.4 09:09:22 INFO - docopt == 0.6.1 09:09:22 INFO - manifestparser == 1.1 09:09:22 INFO - mozInstall == 1.12 09:09:22 INFO - mozcrash == 0.16 09:09:22 INFO - mozdebug == 0.1 09:09:22 INFO - mozdevice == 0.46 09:09:22 INFO - mozfile == 1.2 09:09:22 INFO - mozhttpd == 0.7 09:09:22 INFO - mozinfo == 0.8 09:09:22 INFO - mozleak == 0.1 09:09:22 INFO - mozlog == 3.0 09:09:22 INFO - moznetwork == 0.27 09:09:22 INFO - mozprocess == 0.22 09:09:22 INFO - mozprofile == 0.27 09:09:22 INFO - mozrunner == 6.11 09:09:22 INFO - mozscreenshot == 0.1 09:09:22 INFO - mozsystemmonitor == 0.0 09:09:22 INFO - moztest == 0.7 09:09:22 INFO - mozversion == 1.4 09:09:22 INFO - psutil == 3.1.1 09:09:22 INFO - requests == 1.2.3 09:09:22 INFO - wsgiref == 0.1.2 09:09:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10d372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa0f4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3279f0>, '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 0x10d086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f1990>, '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.rjjiBjX6yE/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.kYQLXhOCle/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjjiBjX6yE/Render', 09:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:22 INFO - 'HOME': '/Users/cltbld', 09:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:22 INFO - 'LOGNAME': 'cltbld', 09:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:22 INFO - 'MOZ_NO_REMOTE': '1', 09:09:22 INFO - 'NO_EM_RESTART': '1', 09:09:22 INFO - 'PAGER': '/bin/cat', 09:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:22 INFO - 'PWD': '/builds/slave/test', 09:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:22 INFO - 'SHELL': '/bin/bash', 09:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kYQLXhOCle/Listeners', 09:09:22 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 09:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:22 INFO - 'USER': 'cltbld', 09:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:22 INFO - 'XPC_FLAGS': '0x0', 09:09:22 INFO - 'XPC_SERVICE_NAME': '0', 09:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:09:23 INFO - Cleaning up... 09:09:23 INFO - Return code: 0 09:09:23 INFO - Running post-action listener: _resource_record_post_action 09:09:23 INFO - Running post-action listener: _start_resource_monitoring 09:09:23 INFO - Starting resource monitoring. 09:09:23 INFO - ##### 09:09:23 INFO - ##### Running install step. 09:09:23 INFO - ##### 09:09:23 INFO - Running pre-action listener: _resource_record_pre_action 09:09:23 INFO - Running main action method: install 09:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:23 INFO - Reading from file tmpfile_stdout 09:09:23 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:23 INFO - Reading from file tmpfile_stdout 09:09:23 INFO - Output received: 09:09:23 INFO - Usage: mozinstall [options] installer 09:09:23 INFO - Options: 09:09:23 INFO - -h, --help show this help message and exit 09:09:23 INFO - -d DEST, --destination=DEST 09:09:23 INFO - Directory to install application into. [default: 09:09:23 INFO - "/builds/slave/test"] 09:09:23 INFO - --app=APP Application being installed. [default: firefox] 09:09:23 INFO - mkdir: /builds/slave/test/build/application 09:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:10:04 INFO - Reading from file tmpfile_stdout 09:10:04 INFO - Output received: 09:10:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:10:04 INFO - Running post-action listener: _resource_record_post_action 09:10:04 INFO - ##### 09:10:04 INFO - ##### Running run-tests step. 09:10:04 INFO - ##### 09:10:04 INFO - Running pre-action listener: _resource_record_pre_action 09:10:04 INFO - Running main action method: run_tests 09:10:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:04 INFO - 2015-11-12 09:10:04.880 screenresolution[2296:20717] starting screenresolution argv=screenresolution get 09:10:04 INFO - 2015-11-12 09:10:04.884 screenresolution[2296:20717] Display 0: 1600x1200x32@60 09:10:04 INFO - 2015-11-12 09:10:04.890 screenresolution[2297:20719] starting screenresolution argv=screenresolution list 09:10:04 INFO - Available Modes on Display 0 09:10:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:05 INFO - Intel HD Graphics 3000: 09:10:05 INFO - Chipset Model: Intel HD Graphics 3000 09:10:05 INFO - Type: GPU 09:10:05 INFO - Bus: Built-In 09:10:05 INFO - VRAM (Total): 512 MB 09:10:05 INFO - VRAM (Dynamic, Max): 10 09:10:05 INFO - Vendor: Intel (0x8086) 09:10:05 INFO - Device ID: 0x0116 09:10:05 INFO - Revision ID: 0x0009 09:10:05 INFO - Displays: 09:10:05 INFO - Display: 09:10:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:05 INFO - Display Serial Number: 1600x1200 60 09:10:05 INFO - Main Display: Yes 09:10:05 INFO - Mirror: Off 09:10:05 INFO - Online: Yes 09:10:05 INFO - Rotation: Supported 09:10:05 INFO - Return code: 0 09:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:05 INFO - Python 2.7.3 09:10:05 INFO - Return code: 0 09:10:05 INFO - grabbing minidump binary from tooltool 09:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:05 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 0x10d3279f0>, '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 0x10d086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f1990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:10:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:10:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:05 INFO - Return code: 0 09:10:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:10:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:10:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0022', '--webServer', 'localhost'] in /builds/slave/test/build 09:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0022 --webServer localhost 09:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjjiBjX6yE/Render', 09:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:05 INFO - 'HOME': '/Users/cltbld', 09:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:05 INFO - 'LOGNAME': 'cltbld', 09:10:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:05 INFO - 'MOZ_NO_REMOTE': '1', 09:10:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:05 INFO - 'NO_EM_RESTART': '1', 09:10:05 INFO - 'PAGER': '/bin/cat', 09:10:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:05 INFO - 'PWD': '/builds/slave/test', 09:10:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:05 INFO - 'SHELL': '/bin/bash', 09:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kYQLXhOCle/Listeners', 09:10:05 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 09:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:05 INFO - 'USER': 'cltbld', 09:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:05 INFO - 'XPC_FLAGS': '0x0', 09:10:05 INFO - 'XPC_SERVICE_NAME': '0', 09:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:10:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0022', '--webServer', 'localhost'] with output_timeout 3600 09:10:05 INFO - mozversion INFO | application_buildid: 20151112075246 09:10:05 INFO - mozversion INFO | application_changeset: 056d07ff03c89ebe77ca4771fc0b02365a6a7b41 09:10:05 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:10:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:05 INFO - mozversion INFO | application_name: Firefox 09:10:05 INFO - mozversion INFO | application_remotingname: firefox-dev 09:10:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:10:05 INFO - mozversion INFO | application_vendor: Mozilla 09:10:05 INFO - mozversion INFO | application_version: 44.0a2 09:10:05 INFO - mozversion INFO | platform_buildid: 20151112075246 09:10:05 INFO - mozversion INFO | platform_changeset: 056d07ff03c89ebe77ca4771fc0b02365a6a7b41 09:10:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:10:05 INFO - mozversion INFO | platform_version: 44.0a2 09:10:05 INFO - 2015-11-12 09:10:05,551 DEBUG : using testdate: 1447348205 09:10:05 INFO - 2015-11-12 09:10:05,551 DEBUG : actual date: 1447348205 09:10:05 INFO - 2015-11-12 09:10:05,560 INFO : starting webserver on 'localhost:50668' 09:10:05 INFO - 2015-11-12 09:10:05,562 INFO : Starting test suite t-yosemite-r5-0022 09:10:05 INFO - 2015-11-12 09:10:05,562 INFO : Starting test dromaeo_css 09:10:05 INFO - 2015-11-12 09:10:05,562 DEBUG : operating with platform_type : mac_ 09:10:05 INFO - 2015-11-12 09:10:05,563 INFO : Initialising browser for dromaeo_css test... 09:10:05 INFO - 2015-11-12 09:10:05,578 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmp9jJlGI/profile http://localhost:50668/getInfo.html 09:10:08 INFO - 2015-11-12 09:10:08,084 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:10:08 INFO - 2015-11-12 09:10:08,084 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:10:08 INFO - 2015-11-12 09:10:08,084 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:10:08 INFO - 2015-11-12 09:10:08,084 DEBUG : BROWSER_OUTPUT: __metrics 09:10:08 INFO - 2015-11-12 09:10:08,100 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:08 INFO - 2015-11-12 09:10:08,825 INFO : Browser initialized. 09:10:08 INFO - 2015-11-12 09:10:08,825 INFO : Running cycle 1/1 for dromaeo_css test... 09:10:08 INFO - 2015-11-12 09:10:08,825 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmp9jJlGI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:10:20 INFO - 2015-11-12 09:10:20,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 199811072 09:10:20 INFO - 2015-11-12 09:10:20,880 DEBUG : BROWSER_OUTPUT: 09:11:12 INFO - 2015-11-12 09:11:12,490 DEBUG : BROWSER_OUTPUT: 1447348272486 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:13:22 INFO - 2015-11-12 09:13:22,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50668/tests/dromaeo/cssquery-ext.html) 09:13:24 INFO - 2015-11-12 09:13:24,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 326762496 09:13:24 INFO - 2015-11-12 09:13:24,105 DEBUG : BROWSER_OUTPUT: 09:16:27 INFO - 2015-11-12 09:16:27,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-ext.html (next: http://localhost:50668/tests/dromaeo/cssquery-jquery.html) 09:16:27 INFO - 2015-11-12 09:16:27,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 344764416 09:16:27 INFO - 2015-11-12 09:16:27,601 DEBUG : BROWSER_OUTPUT: 09:19:29 INFO - 2015-11-12 09:19:29,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50668/tests/dromaeo/cssquery-mootools.html) 09:19:30 INFO - 2015-11-12 09:19:30,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 311115776 09:19:30 INFO - 2015-11-12 09:19:30,483 DEBUG : BROWSER_OUTPUT: 09:22:32 INFO - 2015-11-12 09:22:32,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50668/tests/dromaeo/cssquery-prototype.html) 09:22:33 INFO - 2015-11-12 09:22:33,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 301039616 09:22:33 INFO - 2015-11-12 09:22:33,156 DEBUG : BROWSER_OUTPUT: 09:25:36 INFO - 2015-11-12 09:25:36,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50668/tests/dromaeo/cssquery-yui.html) 09:25:37 INFO - 2015-11-12 09:25:37,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 302788608 09:25:37 INFO - 2015-11-12 09:25:37,044 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-yui.html (next: http://localhost:50668/tests/dromaeo/cssquery-dojo.html) 09:28:39 INFO - 2015-11-12 09:28:39,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 346271744 09:28:39 INFO - 2015-11-12 09:28:39,950 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,951 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:28:39 INFO - 2015-11-12 09:28:39,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:28:39 INFO - 2015-11-12 09:28:39,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:28:39 INFO - 2015-11-12 09:28:39,951 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:28:39 INFO - 2015-11-12 09:28:39,955 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2766.0318888389065;2789.7489225969657;2839.219214715953;2848.6866444691095;2876.4966130927082;4781.354517140189;4816.206664841594;4819.3734814474155;4855.32025516428;4944.4066711994565;4887.266909963507;4905.975470122645;4924.655274130812;4933.358663373765;4960.578350840183;4389.912201755963;4486.685931984763;4505.90988180237;4593.770311484429;4616.607588354994;4349.608535231829;4467.5755803198645;4479.372887795711;4502.414686090804;4510.571495707903;4350.303951367781;4462.419885414892;4489.506154323022;4500.729956202622;4524.208263553882;4485.170243504962;4532.410786597738;4561.475430325505;4565.748883811389;4603.148417542765;4323.870283891489;4345.587169218919;4442.133783912106;4455.309427038814;4473.306637471197;4707.5763181313505;4730.881727956794;4735.857924262277;4738.218193997986;4787.090452813989;5032.748362581856;5044.319016932704;5081.66969147008;5111.514406131411;5129.615278854101;4943.357363542752;5077.365329333833;5111.003354345904;5111.821086262;5198.948010519922;4893.510648935078;4908.558229759303;4911.115999120193;4937.185364414903;4954.083494553519;5331.013762453958;5340.546053585489;5416.377116631559;5452.372977107604;5466.180072989004;4843.176659967814;4981.62637802159;4995.150824359867;5028.472010438924;5197.29836472079;5199.038177937094;5279.841604751864;5284.524392804666;5338.97330513345;5365.839024829262;5067.1639179535705;5092.032513822436;5126.077306084941;5145.408278048072;5148.948510514847;4960.727160006234;5066.113430149709;5122.385313762298;5131.204663277198;5134.743262836843;3863.4011728182177;3888.902777430587;3942.2706799242233;3944.3886197639413;4006.318925782624;3627.528421305213;3630.2013557017412;3654.524911761507;3659.1035196376524;3662.6520480554304;4701.106789709944;4806.591439727592;4829.758512074382;4900.044491324157;4919.2867034279825;5070.239464080344;5178.275041494194;5183.5593974512585;5203.14148165556;5237.292965449616;4745.430548334222;4810.254410566367;4826.276058591239;4837.612990960714;4838.0082083172865;4452.933206001912;4503.144402563503;4523.683342166082;4558.407407037131;4583.335416364675;5167.844964651066;5182.481751824863;5236.345456817898;5264.31563896691;5282.917002014655;5224.477552244745;5316.175992721134;5322.8935421292135;5325.573954083587;5335.546478549211;5113.130767769414;5364.114921037985;5366.0877650798675;5382.327209098863;5384.596155288447;4990.4011518618;5093.796248150181;5102.642815002914;5112.74436278192;5180.7409629519125;5265.315508983807;5290.920636190383;5304.9204261936875;5313.654612450178;5319.0691628964005;4862.246351815475;5153.175491921274;5154.845354639367;5163.09645811989;5191.32512773337;4758.833440829554;5022.74886255693;5055.595552355876;5057.367829021372;5078;4978.701277923336;5016.849494515171;5024.070546948826;5026.396832379992;5070.847874563769;4971.055499455092;5149.9742501287255;5160.354955630546;5163.561097306771;5196.064708352533;4829.4204695435365;4923.97538012322;4933.58064564516;4954.8761280968265;4975.577075948585 09:28:39 INFO - 2015-11-12 09:28:39,956 DEBUG : BROWSER_OUTPUT: |1;ext.html;500.099820323418;507.9161938280183;508.5473928203899;520.3469645594779;524.9737513124343;28756.28109297266;30084.849575752145;35105;35466.82266588663;35582.8220858896;37680.811595942054;38131;38286.42570361447;38302.616973830256;38422.23155536895;7393.55638661682;7975.880361794578;8104.1085480597085;8159.95920020402;8190.672373105069;7451.813704657373;7632.923670763277;9504.477253751042;9637.325387222898;9709.514524273793;9388;9493.288003399739;9529.80940381192;9533.761655958588;9568.229877472655;7464.440166987498;7753;9301.209397201246;9526.047395260419;9526.71419857402;9225.630974761069;9341.486218258062;9393.248540116774;9430.10414010668;9434.952825235898;34504.137396565035;34867.825660871786;34871;34954;35012.12469688253;2544.5547029269806;2569.8586577738215;2582.9483410331686;2621.7247189045065;3072.5544796004456;24094.638580421306;24159;24466.388340291458;24891.751082489125;25342.493150137077;1930.8841469511874;1987.9801201987939;1991.9004049797452;2009.5378063045582;2035.643762341599;231457;231666;233179;234778;236846;45747.54252457433;46853.5314646856;52476.73761631167;52815.47184528183;52933;59236.70381648064;59670;59920.10119848206;60403;60474;15193.62015949588;15374.231288435534;15567.610809729847;15571.7542596592;15586;11370.94314528422;11648.53405863773;11687;11833.112516561292;11838.940805295919;16824.663506729798;16832.32670693183;16912.069836159128;16985.660286794195;17012.57468563271;7358.77923662291;7471.4396420268695;7488.887666685004;7609.467337286337;7624.961875190699;773.6247919758913;774.6971976818667;831.5052543736588;869.5391442535466;923.7459698582943;24812.875935620206;25701.228963131136;26016.34959126037;26219;26272.868635657083;876.6931573949195;984.8325784616633;1024.8770147582188;1030.649579143095;1046.8063408269495;10709.625163119254;12054.819177712341;12267.202631829081;12292.323922184365;12452.688682783002;245822;253716;409949;415746;415758;44046.11907761891;44272.55727442749;44688.10623787506;44788.3281750774;44801;1132.3375825142218;1172.056494521918;1268.0996492490435;1268.9302088385227;1282.3460035381836;23077.19229827015;24620.138295159584;24891.377715557257;25764.484710305314;27235.455290894468;44557.55442445664;44889.77555112204;44935;44985.77507112444;45191.54808452005;234378;235139;235215;235485;235829;27908.720912790614;28161.577576336782;28437.573436398885;28593.857030714713;28644.427111457237;36245.63754362528;36618.45072323864;37037;37235.441468378536;37273;30418.39163216679;31362.843185784837;31389;31592.210194745316;31651.36697266088;29805.403891922473;30108.24729381783;30244.546331804602;30841.537376939814;31057.689423106385;27832.8608356965;28355;30837.229069273446;31022;31075.223119422197;25853.741462585134;27261.182164535097;27571.448571028868;27884;27890.163295101178;20218.94070894646;20976.47558811042;20981.685274720585;21013.684794727786;21112.68330975006 09:28:39 INFO - 2015-11-12 09:28:39,957 DEBUG : BROWSER_OUTPUT: |2;jquery.html;301.2889580589809;302.06661416223864;302.3710681781894;311.5793678533978;311.99532007019894;13335.066545341806;13633.931830340834;15091.189057313124;15255.23723813809;15654.530364089067;9285.164335209829;9589;9670.854937175947;12910.419031143598;15593.816865638792;3630.509881166042;3720.125770443957;3720.274546463441;3737.9065523361996;3743.3262012837677;3021;3107.549405336225;3671.320805650963;3706.5366829146355;3984.8406063757416;4023.7585744855255;4047.089404883907;4057.472528571296;4061.472008638873;4066.8983275418054;3839.2513459875336;4044.474218351625;4053.229886321604;4061.451704019949;4069.9186016279805;3390.7287417006582;3390.881319153818;3398.898033059012;3404.608470025954;3405.540252065989;10171.54228059739;10198.643047493377;10393.740156496147;10446.425446600433;10483.266171368008;1501.3994402239082;1537.9231038448033;1547.5280039587922;1553.5339398180613;1627.072568635878;7731.497452665559;7805.492642978188;7910.090339610903;8050.074241462248;8066.959665201636;1348.514534767483;1377.8484366719654;1385.3627331427556;1386.6671998720335;1407.472197925778;51772.48227517714;52477;52479.212811807854;53314.73342633262;53954.46045539534;5448.863778405493;5513.834584962377;5533.6956467393875;5544.029794785896;5554.72226388679;6268.811935641938;6278.183836101278;6320.273168585672;6332.335104813928;6357.332480089524;4589.58693717567;4642.558956899089;4647.976760116246;4650.09323181983;4690.953090469052;5006.274090256965;5041.01700168471;5049.596032317406;5067.011932673167;5068.82259120929;2373.003338597793;2415.456522282472;2417.468157005456;2430.6597076409316;2446.2783478873775;845.222395396237;854.7435769269318;886.7650072730731;901.724973882972;919.7516670498928;339.73500669477846;341.521869382866;354.9627289134655;356.57211346383923;363.54193715917603;9508.139679383621;9528.190103841112;9569.61721531145;9610.471424071744;9714.417134971924;332.3154302137604;349.7726477789406;356.09551738583707;357.64235764235764;358.5088428852489;4964.652474326835;5093.159628661304;5126.53861152498;5132.101882170605;5189.766460509286;467249;477805;498400;503093;509258;62119.6894015527;62146.68926655338;62570.37429625646;63023;63158;378.33602028440464;378.55519764276863;379.95820459749405;381.83390225252106;382.829640809837;8575.91424085776;8918.598663060047;9012.188902998761;9054.637814487347;9158.725238242863;30944.690553095083;31327.21681957878;31481.21296967594;31515.52726709147;31947.36105277835;41829.79085104555;42135.578644213165;42554.57445425506;42911.570884290755;42921.35617965795;5204.531592156724;5254.211868219798;5292.444293349143;5296.04671159195;5300.337457817773;9320.254379649747;9444.716658500256;9604.567794449405;9604.807903841744;9643.9035609643;7684.154742978156;7701.345385642059;7830.725924592612;8384.077751447214;8392.412531122764;8014.799630009296;8091.87862182056;8093.757187284391;8164.265216130577;8221.383396245425;7095.751648692271;8123;8189.140140285184;8353.916460835557;8551.230389264747;4751.453582838018;4765.189917713928;5013.649044566845;5105.28526006352;5158.690478571298;7725.884111738441;7741.92258077412;7825.295723384923;7846.843063138819;8346.624401901807 09:28:39 INFO - 2015-11-12 09:28:39,961 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1147.3230793831638;1523.8247601525823;1615.143973693942;1636.4190712297132;1651.7357222844348;6187.257529096509;6510.96744516278;6619.040239165324;6695.866082678343;6718.731250749976;6742.662866856662;6782.253952065269;6818.181818181813;6846.931530684692;6847.486438517106;1860.348877892737;1891.498752830501;1892.2903911033363;1894.48848810821;1897.2505860185217;1924.4322924737166;1932.70043143313;1933.5166208447888;1937.0508450859118;1942.9028548572585;1900.429871038683;1908.9522761930994;1916.6070955454168;1917.3289348727974;1922.3848368522079;1813.5556788586748;1865.4869910774578;1868.1966754295647;1869.5045812859603;1874.0348720409;1881.7930027696943;1921.1834970137775;1927.87468814528;1930.4305229957197;1938.9612207755765;6085.574009819315;6818.386345228903;6845.349691779273;6854.3145685431555;6875.656217189171;3759.774413535197;3923.117298607819;4015.578364271768;4019.517657881073;4025.677945764332;2395.532871090138;2398.2805158452393;2425.9029638814427;2432.0514999150346;2435.8903849326643;604.9788257410969;749.3405802893474;753.5629334985695;762.5386641082176;765.8238605120798;8880.289576833839;8880.689175878813;8888.288936885034;8915.375923685344;8943.195112439847;3540.3096396202495;3700.611435799256;3752.3245815753426;3757.229767897574;3765.5104836371097;7786.844263114706;7831.882521762178;7851.097123830718;7865.331446826969;7885.763427097197;4174.979125104355;4190.057237121684;4193.97903010483;4199.013231890503;4205.768682722419;3842.558105817867;3845.1540661054523;3847.6537111660086;3848.749831261015;3854.479645247856;3168.3663267346624;3169.8256595887447;3173.238422778563;3203.183287739368;3233.1755402372246;1020.1685626214611;1040.0743338428804;1041.0890470838017;1042.103790739963;1057.0222544146634;1121.6522877907876;1123.3540714089431;1149.270213414471;1177.2230327983489;1182.994454713504;6275.309715931244;6328.430441260309;6368.076628888785;6371;6381.3937675920715;373.60584583264375;377.4489245701252;380.85717855804074;382.868623218389;383.76398514913126;4976.0794253063295;4985.302057711923;5033.597312215014;5040.521150490697;5042.4705405931845;7733.729319473791;7798.493097948615;7867.685292588347;7897.368210543143;7947.5231486111015;7864;7865.410094242955;7873.645685944146;7893.407994400443;7906.5651389174145;5709.314882214161;5871.2073870027;6071.2714474263375;6199.380061993855;6293.024581189923;6161.661108639068;6206.844828879133;6208.068789681584;6223.533235007483;6234.251889773256;6994.860102797814;7122.893156602759;7234.74678386254;7275.927240727525;7285.890711639436;7160.534565253241;7394.630268486661;7416.221296763762;7421.480496365419;7443.18125006238;5854.707264636666;5896.8820623586425;5900.0264956281735;5905.852353691193;5906.468417842415;6269.62382257066;6393.328700486382;6422.165118534561;6433.453156481752;6447.161868957006;6011.008183649649;6044.214252147192;6072.544559158169;6125.693715314127;6148.139260503623;5403.6217464778665;5580.581456390706;5646.830595082154;5662.5469962402085;5920.644761314163;5814.30228372598;5843.766249349978;5843.94156058434;5857.7949771757785;5859.794907178229;5168.250603662373;5333.43998880112;5341.412444631165;5354.973225134006;5362.436944120811;5311.49540793624;5314.574834013347;5329.493698098674;5336.226247194213;5347.491988261265 09:28:39 INFO - 2015-11-12 09:28:39,962 DEBUG : BROWSER_OUTPUT: |4;prototype.html;284.4339763869899;286.1030668853145;295.9600453938718;296.4145812021258;300.83303766409637;5265.289185959894;5312.203169524573;5315.309009828722;5318.095923692972;5325.7869685212645;5270.868228294285;5274.81538146165;5278.762455689493;5289.444608316119;5313.601479889005;4122.340425531916;4149.896252593687;4153.190127925056;4153.979230103845;4159.625633692967;3956.703247256453;4016.2569924563904;4030.435738996543;4080.449139366192;4091.4067460218253;4026.7382620129597;4028.194361127786;4036.031352475414;4048.9595104049026;4087.2438598859308;3949.4273330367223;4024.074462873526;4038.0308725905866;4044.7168698191285;4063.390491426295;3456.7580269381156;3525.11872031992;3550.55618047744;3554.8578056877695;3570.1967057412135;5082.237664350377;5101.081805275049;5101.897962040738;5117.027764724728;5137.61467889906;4572.679912406133;4586.334981427708;4593.954060459386;4597.747123908183;4611.723296602181;5330;5511.063119269734;5515.503604675599;5532.114861622121;5545.223668686387;3890.0858298299877;3893.0267433141717;3896.883093507199;3898.2788184186015;3907.1208977980014;5849.736761845685;5861.325947516005;5870.442307980735;5871.207387002785;5876.941230587639;3937.1928754605237;3952;3959.5842436544326;3962.900927476836;3965.0285680008005;3993.101552150801;3999.1002024544828;4010.7192496524963;4016.3774614934146;4020.597940205956;4428.601425871687;4600.5169457207185;4618.330342100444;4624.398828152319;4637.86086417408;5562.332520097614;5596.384397716248;5596.440355964371;5601.243832082698;5624.3250809903075;1429.171080773149;1453.25157543865;1463.4073200353873;1466.6186791434304;1467.9926600367144;958.7603099225194;970.6942313171328;970.8301047316692;982.9017098290257;988.0021178609657;5306.708131052752;5367.194920761839;5378.542823859937;5379.058664733656;5397.811076612378;5835.824925252249;5856.326522449887;5860.062390017662;5870.559708021916;5903.793367232126;5356.0626890294825;5370.812021579304;5371.543418809367;5383.865403364869;5383.892322153535;3121.141686036313;3156.889508867225;3197.1207917822785;3225.306559089807;3256.4301247281633;5830.854228644318;5848.619839710405;5909.23179986599;5963.075723262901;5972.522198224132;5938.61399009063;6009.819705408845;6020.759169633253;6030.427109424598;6041.18444010053;5911.852203694856;5925.940740592711;5937.079752638348;5939.732712027969;5965.492933100735;5643.040683083967;5864.208331875313;5878.882422351615;5879.265091863517;5974.850628734316;5793.681347525927;5801.332846722512;5827.970860145672;5834.854128646818;5853.707314634166;5998.130271110752;6008.789692360921;6033.879322413615;6035.818925432244;6055.212822333068;3693.464447655021;3758.285925674113;3760.247950409984;3795.487609172837;3810.142717888453;5925.911111333419;5926.407359264039;5930.34766175729;5934.584579079596;5941.494972927177;5746.367899530965;5748.137779333133;5763.913541296968;5768.221290125779;5772.365039845529;5568.916466252928;5733.483986441241;5743.081107023024;5743.655380677173;5762.164486149569;5627;5632.5493960482245;5641.435856414326;5646.887062258814;5647.068233741551;5774.8845023098465;5775.624584402;5779.422057794355;5791.449812267828;5794.449527294901;5639.295088113986;5647.29408823897;5653.293338332708;5670.121131224667;5681.289838770153 09:28:39 INFO - 2015-11-12 09:28:39,965 DEBUG : BROWSER_OUTPUT: |5;yui.html;666.9254735668567;680.6664734280198;681.5093132944278;693.1681981622054;701.3722718167239;11413.372264525447;12182.634520964375;12182.634520964386;12187.817182742243;12193.51225950963;11141.331520108799;11453.026492748126;11462.828057579143;11553.711157221052;11554.364509951949;629.7858728032468;644.1207751419325;793.7539362797537;822.0341099208406;825.3191117328198;759.3204082346297;793.8848866914294;809.6720828064614;818.5048045932215;819.7704642700054;829.5976451421056;831.9833603327929;838.5010918503511;840.8318336332727;841.5329492131864;646.83182372583;654.5679851298167;821.2239433735062;823.5141266652704;838.8490071787076;612.3876123876124;616.3713012727038;620.184457438467;620.4354037825557;626.1640709652619;11666;11823.527058917633;11842.28946263227;11979.940100299442;12064.276143431422;10011.19910407173;10316.381017138996;10480.318779279323;10862.728431789268;10933.234673572853;7799.181085985946;7981.561014144219;8135.511869287861;8160.510369377797;8182.959085204596;2848.5015122353507;2991.5637901118853;3008.2629755709772;3018.170003249102;3097.0863595239457;41465.475434588094;41682.37476437856;42209.788951055045;42257.154856903;42933.35599966003;7558.281963213486;7927.079979194039;7968.12350641429;8042.839143217103;8219.095899451055;17139.48581542531;17143.485695429157;17150.228239728993;17191.226394812264;17223.65552688964;6100.0849872519475;6184.752609895554;6236;6286;6448.871022579522;3340.3820293245826;3383.4417321142228;3482.1294676330917;3492.5634295713035;3510.0347404463464;2687.8252913560555;2712.986435067812;2717.171262764876;2721.115637417847;2733.139061195717;369.57868030445314;387.13282247764806;388.4774977655106;388.52987884659876;407.5720493481832;397.715633322176;425.2536797919631;427.38883396742335;487.60747598183804;512.7308163214342;6559.278479367265;6605.339466053356;6712.664366781642;6794.9660251699415;6873.20958089816;370.44803243167485;416.3317874810945;525.5427777833233;532.7203218310418;535.8044313825503;3021.1389753920025;3135.846798324384;3231.5475833383343;3268.0522648432166;3270.444024515838;54672.17991730127;54703;54848.45151548513;54940.17589736157;55099;46269.305960410624;46488;46884.06231875344;47159.29261061087;47197;42145.78927105345;42147.367789483185;42173.15653686909;42184;42374.152516950104;6318.905216421849;6487.22153341602;6706.39642432164;6790.626515541495;6885.724571017103;28860.42279154363;29517.524123793293;29787.55318670265;30252;31001.689983100783;39877.401838971855;41528.58471415247;41856.79071604623;42235.577644224395;42911.35632965445;6414.10202571631;6644.136262285871;6691.665416729047;6706.865862682622;6707;9663.903360966582;9676.22590192797;9890.554925028247;9941.353812002197;10089.19286457067;9204.631814727336;9362.391444556082;9375.906240937504;9604.85592716096;9617.807643847224;9068.773280668036;9264.212541934012;9480.95259523698;9650.179734722346;9654.806903862023;6849.383555480031;8306.293965013041;8527.403081784463;8715.128487151487;8748.25639820597;7681.577513236825;7811.765647030598;7926.088499822364;7974.641141148546;8214.301784348398;7426.591537465275;7884.881726774218;8148.266656000988;8211.917880821115;8402.537860417491 09:28:39 INFO - 2015-11-12 09:28:39,965 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:28:39 INFO - 2015-11-12 09:28:39,965 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:28:39 INFO - 2015-11-12 09:28:39,965 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1048 09:28:39 INFO - 2015-11-12 09:28:39,966 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:28:39 INFO - 2015-11-12 09:28:39,966 DEBUG : BROWSER_OUTPUT: __startTimestamp1447349319950__endTimestamp 09:28:39 INFO - 2015-11-12 09:28:39,966 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,966 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:28:39 INFO - 2015-11-12 09:28:39,966 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:28:39 INFO - 2015-11-12 09:28:39,967 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,967 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4820.19 Median:4960.58 stddev:530.33 (10.7%) stddev-sans-first:506.88 09:28:39 INFO - 2015-11-12 09:28:39,967 DEBUG : BROWSER_OUTPUT: Values: 2766.0 2789.7 2839.2 2848.7 2876.5 4781.4 4816.2 4819.4 4855.3 4944.4 4887.3 4906.0 4924.7 4933.4 4960.6 4389.9 4486.7 4505.9 4593.8 4616.6 4349.6 4467.6 4479.4 4502.4 4510.6 4350.3 4462.4 4489.5 4500.7 4524.2 4485.2 4532.4 4561.5 4565.7 4603.1 4323.9 4345.6 4442.1 4455.3 4473.3 4707.6 4730.9 4735.9 4738.2 4787.1 5032.7 5044.3 5081.7 5111.5 5129.6 4943.4 5077.4 5111.0 5111.8 5198.9 4893.5 4908.6 4911.1 4937.2 4954.1 5331.0 5340.5 5416.4 5452.4 5466.2 4843.2 4981.6 4995.2 5028.5 5197.3 5199.0 5279.8 5284.5 5339.0 5365.8 5067.2 5092.0 5126.1 5145.4 5148.9 4960.7 5066.1 5122.4 5131.2 5134.7 3863.4 3888.9 3942.3 3944.4 4006.3 3627.5 3630.2 3654.5 3659.1 3662.7 4701.1 4806.6 4829.8 4900.0 4919.3 5070.2 5178.3 5183.6 5203.1 5237.3 4745.4 4810.3 4826.3 4837.6 4838.0 4452.9 4503.1 4523.7 4558.4 4583.3 5167.8 5182.5 5236.3 5264.3 5282.9 5224.5 5316.2 5322.9 5325.6 5335.5 5113.1 5364.1 5366.1 5382.3 5384.6 4990.4 5093.8 5102.6 5112.7 5180.7 5265.3 5290.9 5304.9 5313.7 5319.1 4862.2 5153.2 5154.8 5163.1 5191.3 4758.8 5022.7 5055.6 5057.4 5078.0 4978.7 5016.8 5024.1 5026.4 5070.8 4971.1 5150.0 5160.4 5163.6 5196.1 4829.4 4924.0 4933.6 4954.9 4975.6 09:28:39 INFO - 2015-11-12 09:28:39,967 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,969 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42195.36 Median:31039.84 stddev:74125.99 (238.8%) stddev-sans-first:74267.83 09:28:39 INFO - 2015-11-12 09:28:39,969 DEBUG : BROWSER_OUTPUT: Values: 500.1 507.9 508.5 520.3 525.0 28756.3 30084.8 35105.0 35466.8 35582.8 37680.8 38131.0 38286.4 38302.6 38422.2 7393.6 7975.9 8104.1 8160.0 8190.7 7451.8 7632.9 9504.5 9637.3 9709.5 9388.0 9493.3 9529.8 9533.8 9568.2 7464.4 7753.0 9301.2 9526.0 9526.7 9225.6 9341.5 9393.2 9430.1 9435.0 34504.1 34867.8 34871.0 34954.0 35012.1 2544.6 2569.9 2582.9 2621.7 3072.6 24094.6 24159.0 24466.4 24891.8 25342.5 1930.9 1988.0 1991.9 2009.5 2035.6 231457.0 231666.0 233179.0 234778.0 236846.0 45747.5 46853.5 52476.7 52815.5 52933.0 59236.7 59670.0 59920.1 60403.0 60474.0 15193.6 15374.2 15567.6 15571.8 15586.0 11370.9 11648.5 11687.0 11833.1 11838.9 16824.7 16832.3 16912.1 16985.7 17012.6 7358.8 7471.4 7488.9 7609.5 7625.0 773.6 774.7 831.5 869.5 923.7 24812.9 25701.2 26016.3 26219.0 26272.9 876.7 984.8 1024.9 1030.6 1046.8 10709.6 12054.8 12267.2 12292.3 12452.7 245822.0 253716.0 409949.0 415746.0 415758.0 44046.1 44272.6 44688.1 44788.3 44801.0 1132.3 1172.1 1268.1 1268.9 1282.3 23077.2 24620.1 24891.4 25764.5 27235.5 44557.6 44889.8 44935.0 44985.8 45191.5 234378.0 235139.0 235215.0 235485.0 235829.0 27908.7 28161.6 28437.6 28593.9 28644.4 36245.6 36618.5 37037.0 37235.4 37273.0 30418.4 31362.8 31389.0 31592.2 31651.4 29805.4 30108.2 30244.5 30841.5 31057.7 27832.9 28355.0 30837.2 31022.0 31075.2 25853.7 27261.2 27571.4 27884.0 27890.2 20218.9 20976.5 20981.7 21013.7 21112.7 09:28:39 INFO - 2015-11-12 09:28:39,969 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,969 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23555.74 Median:241384.83 stddev:80559.51 (33.4%) stddev-sans-first:80766.57 09:28:39 INFO - 2015-11-12 09:28:39,970 DEBUG : BROWSER_OUTPUT: Values: 301.3 302.1 302.4 311.6 312.0 13335.1 13633.9 15091.2 15255.2 15654.5 9285.2 9589.0 9670.9 12910.4 15593.8 3630.5 3720.1 3720.3 3737.9 3743.3 3021.0 3107.5 3671.3 3706.5 3984.8 4023.8 4047.1 4057.5 4061.5 4066.9 3839.3 4044.5 4053.2 4061.5 4069.9 3390.7 3390.9 3398.9 3404.6 3405.5 10171.5 10198.6 10393.7 10446.4 10483.3 1501.4 1537.9 1547.5 1553.5 1627.1 7731.5 7805.5 7910.1 8050.1 8067.0 1348.5 1377.8 1385.4 1386.7 1407.5 51772.5 52477.0 52479.2 53314.7 53954.5 5448.9 5513.8 5533.7 5544.0 5554.7 6268.8 6278.2 6320.3 6332.3 6357.3 4589.6 4642.6 4648.0 4650.1 4691.0 5006.3 5041.0 5049.6 5067.0 5068.8 2373.0 2415.5 2417.5 2430.7 2446.3 845.2 854.7 886.8 901.7 919.8 339.7 341.5 355.0 356.6 363.5 9508.1 9528.2 9569.6 9610.5 9714.4 332.3 349.8 356.1 357.6 358.5 4964.7 5093.2 5126.5 5132.1 5189.8 467249.0 477805.0 498400.0 503093.0 509258.0 62119.7 62146.7 62570.4 63023.0 63158.0 378.3 378.6 380.0 381.8 382.8 8575.9 8918.6 9012.2 9054.6 9158.7 30944.7 31327.2 31481.2 31515.5 31947.4 41829.8 42135.6 42554.6 42911.6 42921.4 5204.5 5254.2 5292.4 5296.0 5300.3 9320.3 9444.7 9604.6 9604.8 9643.9 7684.2 7701.3 7830.7 8384.1 8392.4 8014.8 8091.9 8093.8 8164.3 8221.4 7095.8 8123.0 8189.1 8353.9 8551.2 4751.5 4765.2 5013.6 5105.3 5158.7 7725.9 7741.9 7825.3 7846.8 8346.6 09:28:39 INFO - 2015-11-12 09:28:39,971 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,971 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4633.03 Median:5492.10 stddev:2413.80 (44.0%) stddev-sans-first:2406.36 09:28:39 INFO - 2015-11-12 09:28:39,972 DEBUG : BROWSER_OUTPUT: Values: 1147.3 1523.8 1615.1 1636.4 1651.7 6187.3 6511.0 6619.0 6695.9 6718.7 6742.7 6782.3 6818.2 6846.9 6847.5 1860.3 1891.5 1892.3 1894.5 1897.3 1924.4 1932.7 1933.5 1937.1 1942.9 1900.4 1909.0 1916.6 1917.3 1922.4 1813.6 1865.5 1868.2 1869.5 1874.0 1881.8 1921.2 1927.9 1930.4 1939.0 6085.6 6818.4 6845.3 6854.3 6875.7 3759.8 3923.1 4015.6 4019.5 4025.7 2395.5 2398.3 2425.9 2432.1 2435.9 605.0 749.3 753.6 762.5 765.8 8880.3 8880.7 8888.3 8915.4 8943.2 3540.3 3700.6 3752.3 3757.2 3765.5 7786.8 7831.9 7851.1 7865.3 7885.8 4175.0 4190.1 4194.0 4199.0 4205.8 3842.6 3845.2 3847.7 3848.7 3854.5 3168.4 3169.8 3173.2 3203.2 3233.2 1020.2 1040.1 1041.1 1042.1 1057.0 1121.7 1123.4 1149.3 1177.2 1183.0 6275.3 6328.4 6368.1 6371.0 6381.4 373.6 377.4 380.9 382.9 383.8 4976.1 4985.3 5033.6 5040.5 5042.5 7733.7 7798.5 7867.7 7897.4 7947.5 7864.0 7865.4 7873.6 7893.4 7906.6 5709.3 5871.2 6071.3 6199.4 6293.0 6161.7 6206.8 6208.1 6223.5 6234.3 6994.9 7122.9 7234.7 7275.9 7285.9 7160.5 7394.6 7416.2 7421.5 7443.2 5854.7 5896.9 5900.0 5905.9 5906.5 6269.6 6393.3 6422.2 6433.5 6447.2 6011.0 6044.2 6072.5 6125.7 6148.1 5403.6 5580.6 5646.8 5662.5 5920.6 5814.3 5843.8 5843.9 5857.8 5859.8 5168.3 5333.4 5341.4 5355.0 5362.4 5311.5 5314.6 5329.5 5336.2 5347.5 09:28:39 INFO - 2015-11-12 09:28:39,972 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,972 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4716.07 Median:5375.04 stddev:1430.90 (26.6%) stddev-sans-first:1395.71 09:28:39 INFO - 2015-11-12 09:28:39,972 DEBUG : BROWSER_OUTPUT: Values: 284.4 286.1 296.0 296.4 300.8 5265.3 5312.2 5315.3 5318.1 5325.8 5270.9 5274.8 5278.8 5289.4 5313.6 4122.3 4149.9 4153.2 4154.0 4159.6 3956.7 4016.3 4030.4 4080.4 4091.4 4026.7 4028.2 4036.0 4049.0 4087.2 3949.4 4024.1 4038.0 4044.7 4063.4 3456.8 3525.1 3550.6 3554.9 3570.2 5082.2 5101.1 5101.9 5117.0 5137.6 4572.7 4586.3 4594.0 4597.7 4611.7 5330.0 5511.1 5515.5 5532.1 5545.2 3890.1 3893.0 3896.9 3898.3 3907.1 5849.7 5861.3 5870.4 5871.2 5876.9 3937.2 3952.0 3959.6 3962.9 3965.0 3993.1 3999.1 4010.7 4016.4 4020.6 4428.6 4600.5 4618.3 4624.4 4637.9 5562.3 5596.4 5596.4 5601.2 5624.3 1429.2 1453.3 1463.4 1466.6 1468.0 958.8 970.7 970.8 982.9 988.0 5306.7 5367.2 5378.5 5379.1 5397.8 5835.8 5856.3 5860.1 5870.6 5903.8 5356.1 5370.8 5371.5 5383.9 5383.9 3121.1 3156.9 3197.1 3225.3 3256.4 5830.9 5848.6 5909.2 5963.1 5972.5 5938.6 6009.8 6020.8 6030.4 6041.2 5911.9 5925.9 5937.1 5939.7 5965.5 5643.0 5864.2 5878.9 5879.3 5974.9 5793.7 5801.3 5828.0 5834.9 5853.7 5998.1 6008.8 6033.9 6035.8 6055.2 3693.5 3758.3 3760.2 3795.5 3810.1 5925.9 5926.4 5930.3 5934.6 5941.5 5746.4 5748.1 5763.9 5768.2 5772.4 5568.9 5733.5 5743.1 5743.7 5762.2 5627.0 5632.5 5641.4 5646.9 5647.1 5774.9 5775.6 5779.4 5791.4 5794.4 5639.3 5647.3 5653.3 5670.1 5681.3 09:28:39 INFO - 2015-11-12 09:28:39,973 DEBUG : BROWSER_OUTPUT: 09:28:39 INFO - 2015-11-12 09:28:39,974 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12048.70 Median:30599.54 stddev:14755.69 (48.2%) stddev-sans-first:14772.33 09:28:39 INFO - 2015-11-12 09:28:39,974 DEBUG : BROWSER_OUTPUT: Values: 666.9 680.7 681.5 693.2 701.4 11413.4 12182.6 12182.6 12187.8 12193.5 11141.3 11453.0 11462.8 11553.7 11554.4 629.8 644.1 793.8 822.0 825.3 759.3 793.9 809.7 818.5 819.8 829.6 832.0 838.5 840.8 841.5 646.8 654.6 821.2 823.5 838.8 612.4 616.4 620.2 620.4 626.2 11666.0 11823.5 11842.3 11979.9 12064.3 10011.2 10316.4 10480.3 10862.7 10933.2 7799.2 7981.6 8135.5 8160.5 8183.0 2848.5 2991.6 3008.3 3018.2 3097.1 41465.5 41682.4 42209.8 42257.2 42933.4 7558.3 7927.1 7968.1 8042.8 8219.1 17139.5 17143.5 17150.2 17191.2 17223.7 6100.1 6184.8 6236.0 6286.0 6448.9 3340.4 3383.4 3482.1 3492.6 3510.0 2687.8 2713.0 2717.2 2721.1 2733.1 369.6 387.1 388.5 388.5 407.6 397.7 425.3 427.4 487.6 512.7 6559.3 6605.3 6712.7 6795.0 6873.2 370.4 416.3 525.5 532.7 535.8 3021.1 3135.8 3231.5 3268.1 3270.4 54672.2 54703.0 54848.5 54940.2 55099.0 46269.3 46488.0 46884.1 47159.3 47197.0 42145.8 42147.4 42173.2 42184.0 42374.2 6318.9 6487.2 6706.4 6790.6 6885.7 28860.4 29517.5 29787.6 30252.0 31001.7 39877.4 41528.6 41856.8 42235.6 42911.4 6414.1 6644.1 6691.7 6706.9 6707.0 9663.9 9676.2 9890.6 9941.4 10089.2 9204.6 9362.4 9375.9 9604.9 9617.8 9068.8 9264.2 9481.0 9650.2 9654.8 6849.4 8306.3 8527.4 8715.1 8748.3 7681.6 7811.8 7926.1 7974.6 8214.3 7426.6 7884.9 8148.3 8211.9 8402.5 09:28:39 INFO - 2015-11-12 09:28:39,974 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:28:39 INFO - 2015-11-12 09:28:39,974 DEBUG : BROWSER_OUTPUT: 09:28:40 INFO - 2015-11-12 09:28:40,640 INFO : Browser exited with error code: 0 09:28:40 INFO - 2015-11-12 09:28:40,672 INFO : Completed test dromaeo_css (00:18:35) 09:28:40 INFO - 2015-11-12 09:28:40,672 INFO : Starting test kraken 09:28:40 INFO - 2015-11-12 09:28:40,672 DEBUG : operating with platform_type : mac_ 09:28:40 INFO - 2015-11-12 09:28:40,672 INFO : Initialising browser for kraken test... 09:28:40 INFO - 2015-11-12 09:28:40,691 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmp5UFJaa/profile http://localhost:50668/getInfo.html 09:28:43 INFO - 2015-11-12 09:28:43,168 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:28:43 INFO - 2015-11-12 09:28:43,168 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:28:43 INFO - 2015-11-12 09:28:43,169 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:28:43 INFO - 2015-11-12 09:28:43,169 DEBUG : BROWSER_OUTPUT: __metrics 09:28:43 INFO - 2015-11-12 09:28:43,185 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:28:43 INFO - 2015-11-12 09:28:43,944 INFO : Browser initialized. 09:28:43 INFO - 2015-11-12 09:28:43,945 INFO : Running cycle 1/1 for kraken test... 09:28:43 INFO - 2015-11-12 09:28:43,945 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmp5UFJaa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:28:55 INFO - 2015-11-12 09:28:55,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 199663616 09:28:55 INFO - 2015-11-12 09:28:55,976 DEBUG : BROWSER_OUTPUT: 09:28:58 INFO - 2015-11-12 09:28:58,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50668/tests/kraken/driver.html?testName=audio-beat-detection) 09:28:59 INFO - 2015-11-12 09:28:59,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 263819264 09:28:59 INFO - 2015-11-12 09:28:59,422 DEBUG : BROWSER_OUTPUT: 09:29:02 INFO - 2015-11-12 09:29:02,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50668/tests/kraken/driver.html?testName=audio-dft) 09:29:02 INFO - 2015-11-12 09:29:02,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 276316160 09:29:02 INFO - 2015-11-12 09:29:02,952 DEBUG : BROWSER_OUTPUT: 09:29:06 INFO - 2015-11-12 09:29:06,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50668/tests/kraken/driver.html?testName=audio-fft) 09:29:06 INFO - 2015-11-12 09:29:06,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 265715712 09:29:06 INFO - 2015-11-12 09:29:06,699 DEBUG : BROWSER_OUTPUT: 09:29:08 INFO - 2015-11-12 09:29:08,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50668/tests/kraken/driver.html?testName=audio-oscillator) 09:29:09 INFO - 2015-11-12 09:29:09,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 266473472 09:29:09 INFO - 2015-11-12 09:29:09,512 DEBUG : BROWSER_OUTPUT: 09:29:11 INFO - 2015-11-12 09:29:11,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:12 INFO - 2015-11-12 09:29:12,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 266629120 09:29:12 INFO - 2015-11-12 09:29:12,532 DEBUG : BROWSER_OUTPUT: 09:29:15 INFO - 2015-11-12 09:29:15,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50668/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:16 INFO - 2015-11-12 09:29:16,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 267112448 09:29:16 INFO - 2015-11-12 09:29:16,526 DEBUG : BROWSER_OUTPUT: 09:29:20 INFO - 2015-11-12 09:29:20,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50668/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:20 INFO - 2015-11-12 09:29:20,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 264642560 09:29:20 INFO - 2015-11-12 09:29:20,639 DEBUG : BROWSER_OUTPUT: 09:29:23 INFO - 2015-11-12 09:29:23,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50668/tests/kraken/driver.html?testName=json-parse-financial) 09:29:24 INFO - 2015-11-12 09:29:24,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 264716288 09:29:24 INFO - 2015-11-12 09:29:24,460 DEBUG : BROWSER_OUTPUT: 09:29:26 INFO - 2015-11-12 09:29:26,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:29:26 INFO - 2015-11-12 09:29:26,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 296636416 09:29:26 INFO - 2015-11-12 09:29:26,786 DEBUG : BROWSER_OUTPUT: 09:29:28 INFO - 2015-11-12 09:29:28,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:29:29 INFO - 2015-11-12 09:29:29,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 300036096 09:29:29 INFO - 2015-11-12 09:29:29,418 DEBUG : BROWSER_OUTPUT: 09:29:31 INFO - 2015-11-12 09:29:31,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:29:32 INFO - 2015-11-12 09:29:32,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 305541120 09:29:32 INFO - 2015-11-12 09:29:32,291 DEBUG : BROWSER_OUTPUT: 09:29:35 INFO - 2015-11-12 09:29:35,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:29:35 INFO - 2015-11-12 09:29:35,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 307539968 09:29:35 INFO - 2015-11-12 09:29:35,770 DEBUG : BROWSER_OUTPUT: 09:29:38 INFO - 2015-11-12 09:29:38,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:29:39 INFO - 2015-11-12 09:29:39,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 307482624 09:29:39 INFO - 2015-11-12 09:29:39,198 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50668/tests/kraken/driver.html?testName=ai-astar) 09:29:41 INFO - 2015-11-12 09:29:41,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 366141440 09:29:41 INFO - 2015-11-12 09:29:41,353 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,353 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:29:41 INFO - 2015-11-12 09:29:41,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:29:41 INFO - 2015-11-12 09:29:41,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:29:41 INFO - 2015-11-12 09:29:41,354 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:29:41 INFO - 2015-11-12 09:29:41,354 DEBUG : BROWSER_OUTPUT: |0;ai-astar;121;129;121;126;128;127;114;125;126;110 09:29:41 INFO - 2015-11-12 09:29:41,354 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;176;151;185;181;152;169;147;183;176;146 09:29:41 INFO - 2015-11-12 09:29:41,354 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;188;189;188;187;178;187;188;189;189 09:29:41 INFO - 2015-11-12 09:29:41,354 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;90;95;144;79;80;82;82;142;76 09:29:41 INFO - 2015-11-12 09:29:41,355 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;112;118;161;104;106;105;148;103;102;147 09:29:41 INFO - 2015-11-12 09:29:41,355 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;136;142;136;135;142;139;130;135;135 09:29:41 INFO - 2015-11-12 09:29:41,355 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;147;146;145;143;146;146;147 09:29:41 INFO - 2015-11-12 09:29:41,355 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;122;118;119;118;119;118;118;116;121 09:29:41 INFO - 2015-11-12 09:29:41,355 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;68;70;73;72;72;73;81;66;66 09:29:41 INFO - 2015-11-12 09:29:41,356 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;73;75;76;82;84;80;77;76;79 09:29:41 INFO - 2015-11-12 09:29:41,356 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;95;95;96;99;99;99;97;98;101 09:29:41 INFO - 2015-11-12 09:29:41,356 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;147;144;155;142;140;144;150;157;147;150 09:29:41 INFO - 2015-11-12 09:29:41,356 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;166;168;172;168;154;169;169;170;170;169 09:29:41 INFO - 2015-11-12 09:29:41,356 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;81;80;80;80;81;84;80;80;80 09:29:41 INFO - 2015-11-12 09:29:41,356 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:29:41 INFO - 2015-11-12 09:29:41,357 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:29:41 INFO - 2015-11-12 09:29:41,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,929 09:29:41 INFO - 2015-11-12 09:29:41,357 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:29:41 INFO - 2015-11-12 09:29:41,357 DEBUG : BROWSER_OUTPUT: __startTimestamp1447349381348__endTimestamp 09:29:41 INFO - 2015-11-12 09:29:41,357 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,357 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:29:41 INFO - 2015-11-12 09:29:41,357 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:29:41 INFO - 2015-11-12 09:29:41,357 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,358 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.70 Median:126.00 stddev:6.29 (5.0%) stddev-sans-first:6.64 09:29:41 INFO - 2015-11-12 09:29:41,358 DEBUG : BROWSER_OUTPUT: Values: 121.0 129.0 121.0 126.0 128.0 127.0 114.0 125.0 126.0 110.0 09:29:41 INFO - 2015-11-12 09:29:41,358 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,358 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:166.60 Median:176.00 stddev:15.85 (9.0%) stddev-sans-first:16.45 09:29:41 INFO - 2015-11-12 09:29:41,358 DEBUG : BROWSER_OUTPUT: Values: 176.0 151.0 185.0 181.0 152.0 169.0 147.0 183.0 176.0 146.0 09:29:41 INFO - 2015-11-12 09:29:41,359 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,359 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:186.70 Median:188.00 stddev:3.40 (1.8%) stddev-sans-first:3.46 09:29:41 INFO - 2015-11-12 09:29:41,359 DEBUG : BROWSER_OUTPUT: Values: 184.0 188.0 189.0 188.0 187.0 178.0 187.0 188.0 189.0 189.0 09:29:41 INFO - 2015-11-12 09:29:41,359 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,359 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:95.60 Median:82.00 stddev:25.59 (31.2%) stddev-sans-first:26.90 09:29:41 INFO - 2015-11-12 09:29:41,360 DEBUG : BROWSER_OUTPUT: Values: 86.0 90.0 95.0 144.0 79.0 80.0 82.0 82.0 142.0 76.0 09:29:41 INFO - 2015-11-12 09:29:41,360 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,360 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:120.60 Median:115.00 stddev:22.48 (19.5%) stddev-sans-first:23.63 09:29:41 INFO - 2015-11-12 09:29:41,360 DEBUG : BROWSER_OUTPUT: Values: 112.0 118.0 161.0 104.0 106.0 105.0 148.0 103.0 102.0 147.0 09:29:41 INFO - 2015-11-12 09:29:41,360 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,360 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.20 Median:137.50 stddev:3.97 (2.9%) stddev-sans-first:3.81 09:29:41 INFO - 2015-11-12 09:29:41,361 DEBUG : BROWSER_OUTPUT: Values: 142.0 136.0 142.0 136.0 135.0 142.0 139.0 130.0 135.0 135.0 09:29:41 INFO - 2015-11-12 09:29:41,361 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,361 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.50 stddev:1.25 (0.9%) stddev-sans-first:1.32 09:29:41 INFO - 2015-11-12 09:29:41,361 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 147.0 146.0 145.0 143.0 146.0 146.0 147.0 09:29:41 INFO - 2015-11-12 09:29:41,361 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,361 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:118.70 Median:118.50 stddev:1.70 (1.4%) stddev-sans-first:1.79 09:29:41 INFO - 2015-11-12 09:29:41,363 DEBUG : BROWSER_OUTPUT: Values: 118.0 122.0 118.0 119.0 118.0 119.0 118.0 118.0 116.0 121.0 09:29:41 INFO - 2015-11-12 09:29:41,363 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,363 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.00 Median:72.00 stddev:5.81 (8.1%) stddev-sans-first:4.60 09:29:41 INFO - 2015-11-12 09:29:41,363 DEBUG : BROWSER_OUTPUT: Values: 59.0 68.0 70.0 73.0 72.0 72.0 73.0 81.0 66.0 66.0 09:29:41 INFO - 2015-11-12 09:29:41,364 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,364 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:77.30 Median:78.00 stddev:4.00 (5.1%) stddev-sans-first:3.54 09:29:41 INFO - 2015-11-12 09:29:41,364 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 75.0 76.0 82.0 84.0 80.0 77.0 76.0 79.0 09:29:41 INFO - 2015-11-12 09:29:41,364 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,364 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.10 Median:97.50 stddev:2.64 (2.7%) stddev-sans-first:2.06 09:29:41 INFO - 2015-11-12 09:29:41,364 DEBUG : BROWSER_OUTPUT: Values: 92.0 95.0 95.0 96.0 99.0 99.0 99.0 97.0 98.0 101.0 09:29:41 INFO - 2015-11-12 09:29:41,364 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,365 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:148.50 stddev:5.48 (3.7%) stddev-sans-first:5.81 09:29:41 INFO - 2015-11-12 09:29:41,365 DEBUG : BROWSER_OUTPUT: Values: 147.0 144.0 155.0 142.0 140.0 144.0 150.0 157.0 147.0 150.0 09:29:41 INFO - 2015-11-12 09:29:41,365 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,365 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:169.00 stddev:4.99 (3.0%) stddev-sans-first:5.27 09:29:41 INFO - 2015-11-12 09:29:41,365 DEBUG : BROWSER_OUTPUT: Values: 166.0 168.0 172.0 168.0 154.0 169.0 169.0 170.0 170.0 169.0 09:29:41 INFO - 2015-11-12 09:29:41,365 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-12 09:29:41,365 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.40 Median:80.00 stddev:1.51 (1.9%) stddev-sans-first:1.32 09:29:41 INFO - 2015-11-12 09:29:41,365 DEBUG : BROWSER_OUTPUT: Values: 78.0 81.0 80.0 80.0 80.0 81.0 84.0 80.0 80.0 80.0 09:29:41 INFO - 2015-11-12 09:29:41,366 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:29:41 INFO - 2015-11-12 09:29:41,366 DEBUG : BROWSER_OUTPUT: 09:29:42 INFO - 2015-11-12 09:29:42,104 INFO : Browser exited with error code: 0 09:29:42 INFO - 2015-11-12 09:29:42,159 INFO : Completed test kraken (00:01:01) 09:29:42 INFO - 2015-11-12 09:29:42,159 INFO : Starting test v8_7 09:29:42 INFO - 2015-11-12 09:29:42,159 DEBUG : operating with platform_type : mac_ 09:29:42 INFO - 2015-11-12 09:29:42,159 INFO : Initialising browser for v8_7 test... 09:29:42 INFO - 2015-11-12 09:29:42,178 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpMIPlgY/profile http://localhost:50668/getInfo.html 09:29:44 INFO - 2015-11-12 09:29:44,581 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:29:44 INFO - 2015-11-12 09:29:44,581 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:29:44 INFO - 2015-11-12 09:29:44,581 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:29:44 INFO - 2015-11-12 09:29:44,581 DEBUG : BROWSER_OUTPUT: __metrics 09:29:44 INFO - 2015-11-12 09:29:44,597 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:29:45 INFO - 2015-11-12 09:29:45,445 INFO : Browser initialized. 09:29:45 INFO - 2015-11-12 09:29:45,445 INFO : Running cycle 1/1 for v8_7 test... 09:29:45 INFO - 2015-11-12 09:29:45,445 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpMIPlgY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:29:57 INFO - 2015-11-12 09:29:57,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 199888896 09:29:57 INFO - 2015-11-12 09:29:57,454 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50668/tests/v8_7/run.html (next: http://localhost:50668/tests/v8_7/run.html) 09:30:20 INFO - 2015-11-12 09:30:20,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 513597440 09:30:20 INFO - 2015-11-12 09:30:20,575 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,575 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:30:20 INFO - 2015-11-12 09:30:20,575 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:30:20 INFO - 2015-11-12 09:30:20,575 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:30:20 INFO - 2015-11-12 09:30:20,575 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:30:20 INFO - 2015-11-12 09:30:20,575 DEBUG : BROWSER_OUTPUT: |0;Richards;191.64430816404752 09:30:20 INFO - 2015-11-12 09:30:20,575 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;220.99447513812154 09:30:20 INFO - 2015-11-12 09:30:20,576 DEBUG : BROWSER_OUTPUT: |2;Encrypt;366.3003663003663 09:30:20 INFO - 2015-11-12 09:30:20,576 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6724.832214765101 09:30:20 INFO - 2015-11-12 09:30:20,576 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1179.245283018868 09:30:20 INFO - 2015-11-12 09:30:20,576 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 09:30:20 INFO - 2015-11-12 09:30:20,576 DEBUG : BROWSER_OUTPUT: |6;Boyer;15196.969696969696 09:30:20 INFO - 2015-11-12 09:30:20,576 DEBUG : BROWSER_OUTPUT: |7;RegExp;33916.666666666664 09:30:20 INFO - 2015-11-12 09:30:20,576 DEBUG : BROWSER_OUTPUT: |8;Splay;664.0106241699867 09:30:20 INFO - 2015-11-12 09:30:20,576 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6680 09:30:20 INFO - 2015-11-12 09:30:20,577 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:30:20 INFO - 2015-11-12 09:30:20,577 DEBUG : BROWSER_OUTPUT: __startTimestamp1447349420569__endTimestamp 09:30:20 INFO - 2015-11-12 09:30:20,577 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,577 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:30:20 INFO - 2015-11-12 09:30:20,577 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:30:20 INFO - 2015-11-12 09:30:20,577 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,577 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:191.64 Median:191.64 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,578 DEBUG : BROWSER_OUTPUT: Values: 191.6 09:30:20 INFO - 2015-11-12 09:30:20,578 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,578 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:220.99 Median:220.99 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,578 DEBUG : BROWSER_OUTPUT: Values: 221.0 09:30:20 INFO - 2015-11-12 09:30:20,578 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,578 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:366.30 Median:366.30 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,578 DEBUG : BROWSER_OUTPUT: Values: 366.3 09:30:20 INFO - 2015-11-12 09:30:20,579 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,579 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6724.83 Median:6724.83 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,579 DEBUG : BROWSER_OUTPUT: Values: 6724.8 09:30:20 INFO - 2015-11-12 09:30:20,579 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,579 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1179.25 Median:1179.25 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,579 DEBUG : BROWSER_OUTPUT: Values: 1179.2 09:30:20 INFO - 2015-11-12 09:30:20,579 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,580 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,580 DEBUG : BROWSER_OUTPUT: Values: 789.9 09:30:20 INFO - 2015-11-12 09:30:20,580 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,580 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15196.97 Median:15196.97 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,580 DEBUG : BROWSER_OUTPUT: Values: 15197.0 09:30:20 INFO - 2015-11-12 09:30:20,580 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,580 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33916.67 Median:33916.67 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,581 DEBUG : BROWSER_OUTPUT: Values: 33916.7 09:30:20 INFO - 2015-11-12 09:30:20,581 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,581 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:664.01 Median:664.01 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,581 DEBUG : BROWSER_OUTPUT: Values: 664.0 09:30:20 INFO - 2015-11-12 09:30:20,581 DEBUG : BROWSER_OUTPUT: 09:30:20 INFO - 2015-11-12 09:30:20,581 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6680.00 Median:6680.00 stddev:0.00 (0.0%) 09:30:20 INFO - 2015-11-12 09:30:20,581 DEBUG : BROWSER_OUTPUT: Values: 6680.0 09:30:20 INFO - 2015-11-12 09:30:20,582 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:30:20 INFO - 2015-11-12 09:30:20,582 DEBUG : BROWSER_OUTPUT: 09:30:21 INFO - 2015-11-12 09:30:21,283 INFO : Browser exited with error code: 0 09:30:21 INFO - 2015-11-12 09:30:21,306 INFO : Completed test v8_7 (00:00:39) 09:30:21 INFO - 2015-11-12 09:30:21,359 INFO : Completed test suite (00:20:15) 09:30:21 INFO - 2015-11-12 09:30:21,359 DEBUG : Working with test: dromaeo_css 09:30:21 INFO - 2015-11-12 09:30:21,359 DEBUG : Generating results file: dromaeo_css 09:30:21 INFO - 2015-11-12 09:30:21,360 DEBUG : Working with test: kraken 09:30:21 INFO - 2015-11-12 09:30:21,360 DEBUG : Generating results file: kraken 09:30:21 INFO - 2015-11-12 09:30:21,360 INFO : javascript benchmark 09:30:21 INFO - 2015-11-12 09:30:21,360 DEBUG : Working with test: v8_7 09:30:21 INFO - 2015-11-12 09:30:21,360 DEBUG : Generating results file: v8_7 09:30:21 INFO - 2015-11-12 09:30:21,361 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:21 INFO - 2015-11-12 09:30:21,423 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 09:30:21 INFO - 2015-11-12 09:30:21,424 DEBUG : process_Request line: dromaeo_css 5757.12 graph.html#tests=[[72,52,55]] 09:30:21 INFO - 2015-11-12 09:30:21,424 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:21 INFO - 2015-11-12 09:30:21,473 DEBUG : process_Request line: kraken 1734.00 graph.html#tests=[[232,52,55]] 09:30:21 INFO - 2015-11-12 09:30:21,473 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:21 INFO - 2015-11-12 09:30:21,509 DEBUG : process_Request line: v8_7 17593.75 graph.html#tests=[[230,52,55]] 09:30:21 INFO - 2015-11-12 09:30:21,510 INFO : javascript benchmark 09:30:21 INFO - 2015-11-12 09:30:21,512 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [301.2889580589809, 302.06661416223864, 302.3710681781894, 311.5793678533978, 311.99532007019894, 13335.066545341806, 13633.931830340834, 15091.189057313124, 15255.23723813809, 15654.530364089067, 9285.164335209829, 9589.0, 9670.854937175947, 12910.419031143598, 15593.816865638792, 3630.509881166042, 3720.125770443957, 3720.274546463441, 3737.9065523361996, 3743.3262012837677, 3021.0, 3107.549405336225, 3671.320805650963, 3706.5366829146355, 3984.8406063757416, 4023.7585744855255, 4047.089404883907, 4057.472528571296, 4061.472008638873, 4066.8983275418054, 3839.2513459875336, 4044.474218351625, 4053.229886321604, 4061.451704019949, 4069.9186016279805, 3390.7287417006582, 3390.881319153818, 3398.898033059012, 3404.608470025954, 3405.540252065989, 10171.54228059739, 10198.643047493377, 10393.740156496147, 10446.425446600433, 10483.266171368008, 1501.3994402239082, 1537.9231038448033, 1547.5280039587922, 1553.5339398180613, 1627.072568635878, 7731.497452665559, 7805.492642978188, 7910.090339610903, 8050.074241462248, 8066.959665201636, 1348.514534767483, 1377.8484366719654, 1385.3627331427556, 1386.6671998720335, 1407.472197925778, 51772.48227517714, 52477.0, 52479.212811807854, 53314.73342633262, 53954.46045539534, 5448.863778405493, 5513.834584962377, 5533.6956467393875, 5544.029794785896, 5554.72226388679, 6268.811935641938, 6278.183836101278, 6320.273168585672, 6332.335104813928, 6357.332480089524, 4589.58693717567, 4642.558956899089, 4647.976760116246, 4650.09323181983, 4690.953090469052, 5006.274090256965, 5041.01700168471, 5049.596032317406, 5067.011932673167, 5068.82259120929, 2373.003338597793, 2415.456522282472, 2417.468157005456, 2430.6597076409316, 2446.2783478873775, 845.222395396237, 854.7435769269318, 886.7650072730731, 901.724973882972, 919.7516670498928, 339.73500669477846, 341.521869382866, 354.9627289134655, 356.57211346383923, 363.54193715917603, 9508.139679383621, 9528.190103841112, 9569.61721531145, 9610.471424071744, 9714.417134971924, 332.3154302137604, 349.7726477789406, 356.09551738583707, 357.64235764235764, 358.5088428852489, 4964.652474326835, 5093.159628661304, 5126.53861152498, 5132.101882170605, 5189.766460509286, 467249.0, 477805.0, 498400.0, 503093.0, 509258.0, 62119.6894015527, 62146.68926655338, 62570.37429625646, 63023.0, 63158.0, 378.33602028440464, 378.55519764276863, 379.95820459749405, 381.83390225252106, 382.829640809837, 8575.91424085776, 8918.598663060047, 9012.188902998761, 9054.637814487347, 9158.725238242863, 30944.690553095083, 31327.21681957878, 31481.21296967594, 31515.52726709147, 31947.36105277835, 41829.79085104555, 42135.578644213165, 42554.57445425506, 42911.570884290755, 42921.35617965795, 5204.531592156724, 5254.211868219798, 5292.444293349143, 5296.04671159195, 5300.337457817773, 9320.254379649747, 9444.716658500256, 9604.567794449405, 9604.807903841744, 9643.9035609643, 7684.154742978156, 7701.345385642059, 7830.725924592612, 8384.077751447214, 8392.412531122764, 8014.799630009296, 8091.87862182056, 8093.757187284391, 8164.265216130577, 8221.383396245425, 7095.751648692271, 8123.0, 8189.140140285184, 8353.916460835557, 8551.230389264747, 4751.453582838018, 4765.189917713928, 5013.649044566845, 5105.28526006352, 5158.690478571298, 7725.884111738441, 7741.92258077412, 7825.295723384923, 7846.843063138819, 8346.624401901807], "dojo.html": [2766.0318888389065, 2789.7489225969657, 2839.219214715953, 2848.6866444691095, 2876.4966130927082, 4781.354517140189, 4816.206664841594, 4819.3734814474155, 4855.32025516428, 4944.4066711994565, 4887.266909963507, 4905.975470122645, 4924.655274130812, 4933.358663373765, 4960.578350840183, 4389.912201755963, 4486.685931984763, 4505.90988180237, 4593.770311484429, 4616.607588354994, 4349.608535231829, 4467.5755803198645, 4479.372887795711, 4502.414686090804, 4510.571495707903, 4350.303951367781, 4462.419885414892, 4489.506154323022, 4500.729956202622, 4524.208263553882, 4485.170243504962, 4532.410786597738, 4561.475430325505, 4565.748883811389, 4603.148417542765, 4323.870283891489, 4345.587169218919, 4442.133783912106, 4455.309427038814, 4473.306637471197, 4707.5763181313505, 4730.881727956794, 4735.857924262277, 4738.218193997986, 4787.090452813989, 5032.748362581856, 5044.319016932704, 5081.66969147008, 5111.514406131411, 5129.615278854101, 4943.357363542752, 5077.365329333833, 5111.003354345904, 5111.821086262, 5198.948010519922, 4893.510648935078, 4908.558229759303, 4911.115999120193, 4937.185364414903, 4954.083494553519, 5331.013762453958, 5340.546053585489, 5416.377116631559, 5452.372977107604, 5466.180072989004, 4843.176659967814, 4981.62637802159, 4995.150824359867, 5028.472010438924, 5197.29836472079, 5199.038177937094, 5279.841604751864, 5284.524392804666, 5338.97330513345, 5365.839024829262, 5067.1639179535705, 5092.032513822436, 5126.077306084941, 5145.408278048072, 5148.948510514847, 4960.727160006234, 5066.113430149709, 5122.385313762298, 5131.204663277198, 5134.743262836843, 3863.4011728182177, 3888.902777430587, 3942.2706799242233, 3944.3886197639413, 4006.318925782624, 3627.528421305213, 3630.2013557017412, 3654.524911761507, 3659.1035196376524, 3662.6520480554304, 4701.106789709944, 4806.591439727592, 4829.758512074382, 4900.044491324157, 4919.2867034279825, 5070.239464080344, 5178.275041494194, 5183.5593974512585, 5203.14148165556, 5237.292965449616, 4745.430548334222, 4810.254410566367, 4826.276058591239, 4837.612990960714, 4838.0082083172865, 4452.933206001912, 4503.144402563503, 4523.683342166082, 4558.407407037131, 4583.335416364675, 5167.844964651066, 5182.481751824863, 5236.345456817898, 5264.31563896691, 5282.917002014655, 5224.477552244745, 5316.175992721134, 5322.8935421292135, 5325.573954083587, 5335.546478549211, 5113.130767769414, 5364.114921037985, 5366.0877650798675, 5382.327209098863, 5384.596155288447, 4990.4011518618, 5093.796248150181, 5102.642815002914, 5112.74436278192, 5180.7409629519125, 5265.315508983807, 5290.920636190383, 5304.9204261936875, 5313.654612450178, 5319.0691628964005, 4862.246351815475, 5153.175491921274, 5154.845354639367, 5163.09645811989, 5191.32512773337, 4758.833440829554, 5022.74886255693, 5055.595552355876, 5057.367829021372, 5078.0, 4978.701277923336, 5016.849494515171, 5024.070546948826, 5026.396832379992, 5070.847874563769, 4971.055499455092, 5149.9742501287255, 5160.354955630546, 5163.561097306771, 5196.064708352533, 4829.4204695435365, 4923.97538012322, 4933.58064564516, 4954.8761280968265, 4975.577075948585], "mootools.html": [1147.3230793831638, 1523.8247601525823, 1615.143973693942, 1636.4190712297132, 1651.7357222844348, 6187.257529096509, 6510.96744516278, 6619.040239165324, 6695.866082678343, 6718.731250749976, 6742.662866856662, 6782.253952065269, 6818.181818181813, 6846.931530684692, 6847.486438517106, 1860.348877892737, 1891.498752830501, 1892.2903911033363, 1894.48848810821, 1897.2505860185217, 1924.4322924737166, 1932.70043143313, 1933.5166208447888, 1937.0508450859118, 1942.9028548572585, 1900.429871038683, 1908.9522761930994, 1916.6070955454168, 1917.3289348727974, 1922.3848368522079, 1813.5556788586748, 1865.4869910774578, 1868.1966754295647, 1869.5045812859603, 1874.0348720409, 1881.7930027696943, 1921.1834970137775, 1927.87468814528, 1930.4305229957197, 1938.9612207755765, 6085.574009819315, 6818.386345228903, 6845.349691779273, 6854.3145685431555, 6875.656217189171, 3759.774413535197, 3923.117298607819, 4015.578364271768, 4019.517657881073, 4025.677945764332, 2395.532871090138, 2398.2805158452393, 2425.9029638814427, 2432.0514999150346, 2435.8903849326643, 604.9788257410969, 749.3405802893474, 753.5629334985695, 762.5386641082176, 765.8238605120798, 8880.289576833839, 8880.689175878813, 8888.288936885034, 8915.375923685344, 8943.195112439847, 3540.3096396202495, 3700.611435799256, 3752.3245815753426, 3757.229767897574, 3765.5104836371097, 7786.844263114706, 7831.882521762178, 7851.097123830718, 7865.331446826969, 7885.763427097197, 4174.979125104355, 4190.057237121684, 4193.97903010483, 4199.013231890503, 4205.768682722419, 3842.558105817867, 3845.1540661054523, 3847.6537111660086, 3848.749831261015, 3854.479645247856, 3168.3663267346624, 3169.8256595887447, 3173.238422778563, 3203.183287739368, 3233.1755402372246, 1020.1685626214611, 1040.0743338428804, 1041.0890470838017, 1042.103790739963, 1057.0222544146634, 1121.6522877907876, 1123.3540714089431, 1149.270213414471, 1177.2230327983489, 1182.994454713504, 6275.309715931244, 6328.430441260309, 6368.076628888785, 6371.0, 6381.3937675920715, 373.60584583264375, 377.4489245701252, 380.85717855804074, 382.868623218389, 383.76398514913126, 4976.0794253063295, 4985.302057711923, 5033.597312215014, 5040.521150490697, 5042.4705405931845, 7733.729319473791, 7798.493097948615, 7867.685292588347, 7897.368210543143, 7947.5231486111015, 7864.0, 7865.410094242955, 7873.645685944146, 7893.407994400443, 7906.5651389174145, 5709.314882214161, 5871.2073870027, 6071.2714474263375, 6199.380061993855, 6293.024581189923, 6161.661108639068, 6206.844828879133, 6208.068789681584, 6223.533235007483, 6234.251889773256, 6994.860102797814, 7122.893156602759, 7234.74678386254, 7275.927240727525, 7285.890711639436, 7160.534565253241, 7394.630268486661, 7416.221296763762, 7421.480496365419, 7443.18125006238, 5854.707264636666, 5896.8820623586425, 5900.0264956281735, 5905.852353691193, 5906.468417842415, 6269.62382257066, 6393.328700486382, 6422.165118534561, 6433.453156481752, 6447.161868957006, 6011.008183649649, 6044.214252147192, 6072.544559158169, 6125.693715314127, 6148.139260503623, 5403.6217464778665, 5580.581456390706, 5646.830595082154, 5662.5469962402085, 5920.644761314163, 5814.30228372598, 5843.766249349978, 5843.94156058434, 5857.7949771757785, 5859.794907178229, 5168.250603662373, 5333.43998880112, 5341.412444631165, 5354.973225134006, 5362.436944120811, 5311.49540793624, 5314.574834013347, 5329.493698098674, 5336.226247194213, 5347.491988261265], "ext.html": [500.099820323418, 507.9161938280183, 508.5473928203899, 520.3469645594779, 524.9737513124343, 28756.28109297266, 30084.849575752145, 35105.0, 35466.82266588663, 35582.8220858896, 37680.811595942054, 38131.0, 38286.42570361447, 38302.616973830256, 38422.23155536895, 7393.55638661682, 7975.880361794578, 8104.1085480597085, 8159.95920020402, 8190.672373105069, 7451.813704657373, 7632.923670763277, 9504.477253751042, 9637.325387222898, 9709.514524273793, 9388.0, 9493.288003399739, 9529.80940381192, 9533.761655958588, 9568.229877472655, 7464.440166987498, 7753.0, 9301.209397201246, 9526.047395260419, 9526.71419857402, 9225.630974761069, 9341.486218258062, 9393.248540116774, 9430.10414010668, 9434.952825235898, 34504.137396565035, 34867.825660871786, 34871.0, 34954.0, 35012.12469688253, 2544.5547029269806, 2569.8586577738215, 2582.9483410331686, 2621.7247189045065, 3072.5544796004456, 24094.638580421306, 24159.0, 24466.388340291458, 24891.751082489125, 25342.493150137077, 1930.8841469511874, 1987.9801201987939, 1991.9004049797452, 2009.5378063045582, 2035.643762341599, 231457.0, 231666.0, 233179.0, 234778.0, 236846.0, 45747.54252457433, 46853.5314646856, 52476.73761631167, 52815.47184528183, 52933.0, 59236.70381648064, 59670.0, 59920.10119848206, 60403.0, 60474.0, 15193.62015949588, 15374.231288435534, 15567.610809729847, 15571.7542596592, 15586.0, 11370.94314528422, 11648.53405863773, 11687.0, 11833.112516561292, 11838.940805295919, 16824.663506729798, 16832.32670693183, 16912.069836159128, 16985.660286794195, 17012.57468563271, 7358.77923662291, 7471.4396420268695, 7488.887666685004, 7609.467337286337, 7624.961875190699, 773.6247919758913, 774.6971976818667, 831.5052543736588, 869.5391442535466, 923.7459698582943, 24812.875935620206, 25701.228963131136, 26016.34959126037, 26219.0, 26272.868635657083, 876.6931573949195, 984.8325784616633, 1024.8770147582188, 1030.649579143095, 1046.8063408269495, 10709.625163119254, 12054.819177712341, 12267.202631829081, 12292.323922184365, 12452.688682783002, 245822.0, 253716.0, 409949.0, 415746.0, 415758.0, 44046.11907761891, 44272.55727442749, 44688.10623787506, 44788.3281750774, 44801.0, 1132.3375825142218, 1172.056494521918, 1268.0996492490435, 1268.9302088385227, 1282.3460035381836, 23077.19229827015, 24620.138295159584, 24891.377715557257, 25764.484710305314, 27235.455290894468, 44557.55442445664, 44889.77555112204, 44935.0, 44985.77507112444, 45191.54808452005, 234378.0, 235139.0, 235215.0, 235485.0, 235829.0, 27908.720912790614, 28161.577576336782, 28437.573436398885, 28593.857030714713, 28644.427111457237, 36245.63754362528, 36618.45072323864, 37037.0, 37235.441468378536, 37273.0, 30418.39163216679, 31362.843185784837, 31389.0, 31592.210194745316, 31651.36697266088, 29805.403891922473, 30108.24729381783, 30244.546331804602, 30841.537376939814, 31057.689423106385, 27832.8608356965, 28355.0, 30837.229069273446, 31022.0, 31075.223119422197, 25853.741462585134, 27261.182164535097, 27571.448571028868, 27884.0, 27890.163295101178, 20218.94070894646, 20976.47558811042, 20981.685274720585, 21013.684794727786, 21112.68330975006], "prototype.html": [284.4339763869899, 286.1030668853145, 295.9600453938718, 296.4145812021258, 300.83303766409637, 5265.289185959894, 5312.203169524573, 5315.309009828722, 5318.095923692972, 5325.7869685212645, 5270.868228294285, 5274.81538146165, 5278.762455689493, 5289.444608316119, 5313.601479889005, 4122.340425531916, 4149.896252593687, 4153.190127925056, 4153.979230103845, 4159.625633692967, 3956.703247256453, 4016.2569924563904, 4030.435738996543, 4080.449139366192, 4091.4067460218253, 4026.7382620129597, 4028.194361127786, 4036.031352475414, 4048.9595104049026, 4087.2438598859308, 3949.4273330367223, 4024.074462873526, 4038.0308725905866, 4044.7168698191285, 4063.390491426295, 3456.7580269381156, 3525.11872031992, 3550.55618047744, 3554.8578056877695, 3570.1967057412135, 5082.237664350377, 5101.081805275049, 5101.897962040738, 5117.027764724728, 5137.61467889906, 4572.679912406133, 4586.334981427708, 4593.954060459386, 4597.747123908183, 4611.723296602181, 5330.0, 5511.063119269734, 5515.503604675599, 5532.114861622121, 5545.223668686387, 3890.0858298299877, 3893.0267433141717, 3896.883093507199, 3898.2788184186015, 3907.1208977980014, 5849.736761845685, 5861.325947516005, 5870.442307980735, 5871.207387002785, 5876.941230587639, 3937.1928754605237, 3952.0, 3959.5842436544326, 3962.900927476836, 3965.0285680008005, 3993.101552150801, 3999.1002024544828, 4010.7192496524963, 4016.3774614934146, 4020.597940205956, 4428.601425871687, 4600.5169457207185, 4618.330342100444, 4624.398828152319, 4637.86086417408, 5562.332520097614, 5596.384397716248, 5596.440355964371, 5601.243832082698, 5624.3250809903075, 1429.171080773149, 1453.25157543865, 1463.4073200353873, 1466.6186791434304, 1467.9926600367144, 958.7603099225194, 970.6942313171328, 970.8301047316692, 982.9017098290257, 988.0021178609657, 5306.708131052752, 5367.194920761839, 5378.542823859937, 5379.058664733656, 5397.811076612378, 5835.824925252249, 5856.326522449887, 5860.062390017662, 5870.559708021916, 5903.793367232126, 5356.0626890294825, 5370.812021579304, 5371.543418809367, 5383.865403364869, 5383.892322153535, 3121.141686036313, 3156.889508867225, 3197.1207917822785, 3225.306559089807, 3256.4301247281633, 5830.854228644318, 5848.619839710405, 5909.23179986599, 5963.075723262901, 5972.522198224132, 5938.61399009063, 6009.819705408845, 6020.759169633253, 6030.427109424598, 6041.18444010053, 5911.852203694856, 5925.940740592711, 5937.079752638348, 5939.732712027969, 5965.492933100735, 5643.040683083967, 5864.208331875313, 5878.882422351615, 5879.265091863517, 5974.850628734316, 5793.681347525927, 5801.332846722512, 5827.970860145672, 5834.854128646818, 5853.707314634166, 5998.130271110752, 6008.789692360921, 6033.879322413615, 6035.818925432244, 6055.212822333068, 3693.464447655021, 3758.285925674113, 3760.247950409984, 3795.487609172837, 3810.142717888453, 5925.911111333419, 5926.407359264039, 5930.34766175729, 5934.584579079596, 5941.494972927177, 5746.367899530965, 5748.137779333133, 5763.913541296968, 5768.221290125779, 5772.365039845529, 5568.916466252928, 5733.483986441241, 5743.081107023024, 5743.655380677173, 5762.164486149569, 5627.0, 5632.5493960482245, 5641.435856414326, 5646.887062258814, 5647.068233741551, 5774.8845023098465, 5775.624584402, 5779.422057794355, 5791.449812267828, 5794.449527294901, 5639.295088113986, 5647.29408823897, 5653.293338332708, 5670.121131224667, 5681.289838770153], "yui.html": [666.9254735668567, 680.6664734280198, 681.5093132944278, 693.1681981622054, 701.3722718167239, 11413.372264525447, 12182.634520964375, 12182.634520964386, 12187.817182742243, 12193.51225950963, 11141.331520108799, 11453.026492748126, 11462.828057579143, 11553.711157221052, 11554.364509951949, 629.7858728032468, 644.1207751419325, 793.7539362797537, 822.0341099208406, 825.3191117328198, 759.3204082346297, 793.8848866914294, 809.6720828064614, 818.5048045932215, 819.7704642700054, 829.5976451421056, 831.9833603327929, 838.5010918503511, 840.8318336332727, 841.5329492131864, 646.83182372583, 654.5679851298167, 821.2239433735062, 823.5141266652704, 838.8490071787076, 612.3876123876124, 616.3713012727038, 620.184457438467, 620.4354037825557, 626.1640709652619, 11666.0, 11823.527058917633, 11842.28946263227, 11979.940100299442, 12064.276143431422, 10011.19910407173, 10316.381017138996, 10480.318779279323, 10862.728431789268, 10933.234673572853, 7799.181085985946, 7981.561014144219, 8135.511869287861, 8160.510369377797, 8182.959085204596, 2848.5015122353507, 2991.5637901118853, 3008.2629755709772, 3018.170003249102, 3097.0863595239457, 41465.475434588094, 41682.37476437856, 42209.788951055045, 42257.154856903, 42933.35599966003, 7558.281963213486, 7927.079979194039, 7968.12350641429, 8042.839143217103, 8219.095899451055, 17139.48581542531, 17143.485695429157, 17150.228239728993, 17191.226394812264, 17223.65552688964, 6100.0849872519475, 6184.752609895554, 6236.0, 6286.0, 6448.871022579522, 3340.3820293245826, 3383.4417321142228, 3482.1294676330917, 3492.5634295713035, 3510.0347404463464, 2687.8252913560555, 2712.986435067812, 2717.171262764876, 2721.115637417847, 2733.139061195717, 369.57868030445314, 387.13282247764806, 388.4774977655106, 388.52987884659876, 407.5720493481832, 397.715633322176, 425.2536797919631, 427.38883396742335, 487.60747598183804, 512.7308163214342, 6559.278479367265, 6605.339466053356, 6712.664366781642, 6794.9660251699415, 6873.20958089816, 370.44803243167485, 416.3317874810945, 525.5427777833233, 532.7203218310418, 535.8044313825503, 3021.1389753920025, 3135.846798324384, 3231.5475833383343, 3268.0522648432166, 3270.444024515838, 54672.17991730127, 54703.0, 54848.45151548513, 54940.17589736157, 55099.0, 46269.305960410624, 46488.0, 46884.06231875344, 47159.29261061087, 47197.0, 42145.78927105345, 42147.367789483185, 42173.15653686909, 42184.0, 42374.152516950104, 6318.905216421849, 6487.22153341602, 6706.39642432164, 6790.626515541495, 6885.724571017103, 28860.42279154363, 29517.524123793293, 29787.55318670265, 30252.0, 31001.689983100783, 39877.401838971855, 41528.58471415247, 41856.79071604623, 42235.577644224395, 42911.35632965445, 6414.10202571631, 6644.136262285871, 6691.665416729047, 6706.865862682622, 6707.0, 9663.903360966582, 9676.22590192797, 9890.554925028247, 9941.353812002197, 10089.19286457067, 9204.631814727336, 9362.391444556082, 9375.906240937504, 9604.85592716096, 9617.807643847224, 9068.773280668036, 9264.212541934012, 9480.95259523698, 9650.179734722346, 9654.806903862023, 6849.383555480031, 8306.293965013041, 8527.403081784463, 8715.128487151487, 8748.25639820597, 7681.577513236825, 7811.765647030598, 7926.088499822364, 7974.641141148546, 8214.301784348398, 7426.591537465275, 7884.881726774218, 8148.266656000988, 8211.917880821115, 8402.537860417491]}, "summary": {"suite": 5757.118941629676, "subtests": {"jquery.html": {"filtered": 5521.029974491184, "value": 5521.029974491184}, "dojo.html": {"filtered": 4785.713628451694, "value": 4785.713628451694}, "mootools.html": {"filtered": 3733.791686858673, "value": 3733.791686858673}, "ext.html": {"filtered": 16417.29839015457, "value": 16417.29839015457}, "prototype.html": {"filtered": 4251.742964191697, "value": 4251.742964191697}, "yui.html": {"filtered": 5286.908371038819, "value": 5286.908371038819}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1447348205, "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": "20151112075246", "branch": "Mozilla-Aurora", "revision": "056d07ff03c89ebe77ca4771fc0b02365a6a7b41"}}, {"talos_counters": {}, "results": {"audio-dft": [184.0, 188.0, 189.0, 188.0, 187.0, 178.0, 187.0, 188.0, 189.0, 189.0], "ai-astar": [121.0, 129.0, 121.0, 126.0, 128.0, 127.0, 114.0, 125.0, 126.0, 110.0], "imaging-gaussian-blur": [142.0, 136.0, 142.0, 136.0, 135.0, 142.0, 139.0, 130.0, 135.0, 135.0], "audio-beat-detection": [176.0, 151.0, 185.0, 181.0, 152.0, 169.0, 147.0, 183.0, 176.0, 146.0], "json-stringify-tinderbox": [71.0, 73.0, 75.0, 76.0, 82.0, 84.0, 80.0, 77.0, 76.0, 79.0], "stanford-crypto-pbkdf2": [166.0, 168.0, 172.0, 168.0, 154.0, 169.0, 169.0, 170.0, 170.0, 169.0], "json-parse-financial": [59.0, 68.0, 70.0, 73.0, 72.0, 72.0, 73.0, 81.0, 66.0, 66.0], "stanford-crypto-sha256-iterative": [78.0, 81.0, 80.0, 80.0, 80.0, 81.0, 84.0, 80.0, 80.0, 80.0], "audio-fft": [86.0, 90.0, 95.0, 144.0, 79.0, 80.0, 82.0, 82.0, 142.0, 76.0], "imaging-darkroom": [146.0, 147.0, 147.0, 147.0, 146.0, 145.0, 143.0, 146.0, 146.0, 147.0], "stanford-crypto-ccm": [147.0, 144.0, 155.0, 142.0, 140.0, 144.0, 150.0, 157.0, 147.0, 150.0], "audio-oscillator": [112.0, 118.0, 161.0, 104.0, 106.0, 105.0, 148.0, 103.0, 102.0, 147.0], "stanford-crypto-aes": [92.0, 95.0, 95.0, 96.0, 99.0, 99.0, 99.0, 97.0, 98.0, 101.0], "imaging-desaturate": [118.0, 122.0, 118.0, 119.0, 118.0, 119.0, 118.0, 118.0, 116.0, 121.0]}, "summary": {"suite": 1734.0, "subtests": {"audio-fft": {"filtered": 95.6, "value": 95.6}, "stanford-crypto-pbkdf2": {"filtered": 167.5, "value": 167.5}, "audio-beat-detection": {"filtered": 166.6, "value": 166.6}, "stanford-crypto-ccm": {"filtered": 147.6, "value": 147.6}, "imaging-darkroom": {"filtered": 146.0, "value": 146.0}, "json-parse-financial": {"filtered": 70.0, "value": 70.0}, "audio-oscillator": {"filtered": 120.6, "value": 120.6}, "ai-astar": {"filtered": 122.7, "value": 122.7}, "audio-dft": {"filtered": 186.7, "value": 186.7}, "stanford-crypto-sha256-iterative": {"filtered": 80.4, "value": 80.4}, "json-stringify-tinderbox": {"filtered": 77.3, "value": 77.3}, "imaging-gaussian-blur": {"filtered": 137.2, "value": 137.2}, "stanford-crypto-aes": {"filtered": 97.1, "value": 97.1}, "imaging-desaturate": {"filtered": 118.7, "value": 118.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1447348205, "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": "20151112075246", "branch": "Mozilla-Aurora", "revision": "056d07ff03c89ebe77ca4771fc0b02365a6a7b41"}}, {"talos_counters": {}, "results": {"DeltaBlue": [220.99447513812154], "Encrypt": [366.3003663003663], "NavierStokes": [6680.0], "Decrypt": [6724.832214765101], "Splay": [664.0106241699867], "Richards": [191.64430816404752], "RegExp": [33916.666666666664], "Earley": [789.8894154818325], "Boyer": [15196.969696969696], "RayTrace": [1179.245283018868]}, "summary": {"suite": 17593.748485663782, "subtests": {"DeltaBlue": {"filtered": 299.18395, "value": 299.18395}, "Encrypt": {"filtered": 726.6741300000002, "value": 726.6741300000002}, "NavierStokes": {"filtered": 222.1556886227545, "value": 222.1556886227545}, "Decrypt": {"filtered": 39.581805389221536, "value": 39.581805389221536}, "Splay": {"filtered": 122.72544599999998, "value": 122.72544599999998}, "RegExp": {"filtered": 26.859508599508608, "value": 26.859508599508608}, "Richards": {"filtered": 184.20583600000006, "value": 184.20583600000006}, "Earley": {"filtered": 843.7421580000001, "value": 843.7421580000001}, "Boyer": {"filtered": 43.85499302093719, "value": 43.85499302093719}, "RayTrace": {"filtered": 627.5106720000002, "value": 627.5106720000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1447348205, "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": "20151112075246", "branch": "Mozilla-Aurora", "revision": "056d07ff03c89ebe77ca4771fc0b02365a6a7b41"}}] 09:30:21 INFO - RETURN: dromaeo_css: 5757.12 09:30:21 INFO - RETURN: kraken: 1734.00 09:30:21 INFO - RETURN: v8_7: 17593.75 09:30:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17593.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1734.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5757.12"}}} 09:30:21 INFO - Return code: 0 09:30:21 INFO - # TBPL SUCCESS # 09:30:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:30:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:30:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:30:21 INFO - 2015-11-12 09:30:21.601 screenresolution[2320:22720] starting screenresolution argv=screenresolution get 09:30:21 INFO - 2015-11-12 09:30:21.605 screenresolution[2320:22720] Display 0: 1600x1200x32@60 09:30:21 INFO - 2015-11-12 09:30:21.611 screenresolution[2321:22723] starting screenresolution argv=screenresolution list 09:30:21 INFO - Available Modes on Display 0 09:30:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:30:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:30:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:30:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:30:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:30:21 INFO - Intel HD Graphics 3000: 09:30:21 INFO - Chipset Model: Intel HD Graphics 3000 09:30:21 INFO - Type: GPU 09:30:21 INFO - Bus: Built-In 09:30:21 INFO - VRAM (Total): 512 MB 09:30:21 INFO - VRAM (Dynamic, Max): 10 09:30:21 INFO - Vendor: Intel (0x8086) 09:30:21 INFO - Device ID: 0x0116 09:30:21 INFO - Revision ID: 0x0009 09:30:21 INFO - Displays: 09:30:21 INFO - Display: 09:30:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:30:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:30:21 INFO - Display Serial Number: 1600x1200 60 09:30:21 INFO - Main Display: Yes 09:30:21 INFO - Mirror: Off 09:30:21 INFO - Online: Yes 09:30:21 INFO - Rotation: Supported 09:30:21 INFO - Return code: 0 09:30:21 INFO - Running post-action listener: _resource_record_post_action 09:30:21 INFO - Running post-run listener: _resource_record_post_run 09:30:22 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 466944; Write bytes: 681973760; Read time: 151; Write time: 53926 09:30:22 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 337558016; Write bytes: 333844480; Read time: 35854; Write time: 4842 09:30:23 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 466944; Write bytes: 337029120; Read time: 151; Write time: 47903 09:30:23 INFO - Running post-run listener: _upload_blobber_files 09:30:23 INFO - Blob upload gear active. 09:30:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:30:23 INFO - Copying logs to upload dir... 09:30:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1315.747852 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-11-12 09:30:23.051174) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:30:23.056054) ========= 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.rjjiBjX6yE/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.kYQLXhOCle/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010497 build_url: 'https://queue.taskcluster.net/v1/task/Qbq-vqhHSiC6OUIZG7E4lw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:30:23.082793) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:30:23.083125) ========= 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.rjjiBjX6yE/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.kYQLXhOCle/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.005409 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:30:23.132781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 09:30:23.133106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 09:30:23.133552) ========= ========= Total master_lag: 4.11 =========