builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0035 starttime: 1449209327.03 results: success (0) buildid: 20151203200703 builduid: e10b456502284880814434de3fd7511b revision: 858b1b930b16a5c46634e3dad2650c517e150cb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.029698) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.030212) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.030498) ========= 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.aWZHcYO11K/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.8JFkAt1G6s/Listeners TMPDIR=/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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.005294 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.049311) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.049850) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.062195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.062734) ========= 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.aWZHcYO11K/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.8JFkAt1G6s/Listeners TMPDIR=/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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.005288 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.115832) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.116142) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.116517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.116895) ========= 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.aWZHcYO11K/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.8JFkAt1G6s/Listeners TMPDIR=/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-12-03 22:08:47-- 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% 1.26G=0s 2015-12-03 22:08:47 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.321910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.322280) ========= 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.aWZHcYO11K/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.8JFkAt1G6s/Listeners TMPDIR=/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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.019585 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.371891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.372273) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 858b1b930b16a5c46634e3dad2650c517e150cb0 --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 858b1b930b16a5c46634e3dad2650c517e150cb0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aWZHcYO11K/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.8JFkAt1G6s/Listeners TMPDIR=/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-12-03 22:08:47,440 truncating revision to first 12 chars 2015-12-03 22:08:47,441 Setting DEBUG logging. 2015-12-03 22:08:47,441 attempt 1/10 2015-12-03 22:08:47,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/858b1b930b16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 22:08:47,726 unpacking tar archive at: mozilla-aurora-858b1b930b16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.918355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.918675) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.927432) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.927792) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 22:08:47.928258) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2015-12-03 22:08:47.928544) ========= /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.aWZHcYO11K/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.8JFkAt1G6s/Listeners TMPDIR=/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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 22:08:48 INFO - MultiFileLogger online at 20151203 22:08:48 in /builds/slave/test 22:08:48 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 22:08:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:08:48 INFO - {'append_to_log': False, 22:08:48 INFO - 'base_work_dir': '/builds/slave/test', 22:08:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:08:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:08:48 INFO - 'branch': 'Mozilla-Aurora', 22:08:48 INFO - 'buildbot_json_path': 'buildprops.json', 22:08:48 INFO - 'config_files': ('talos/mac_config.py',), 22:08:48 INFO - 'default_actions': ('clobber', 22:08:48 INFO - 'read-buildbot-config', 22:08:48 INFO - 'download-and-extract', 22:08:48 INFO - 'populate-webroot', 22:08:48 INFO - 'create-virtualenv', 22:08:48 INFO - 'install', 22:08:48 INFO - 'run-tests'), 22:08:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:08:48 INFO - 'download_minidump_stackwalk': True, 22:08:48 INFO - 'download_symbols': 'ondemand', 22:08:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:08:48 INFO - 'tooltool.py': '/tools/tooltool.py', 22:08:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:08:48 INFO - '/tools/misc-python/virtualenv.py')}, 22:08:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:08:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:08:48 INFO - 'installer_path': 'installer.exe', 22:08:48 INFO - 'log_level': 'info', 22:08:48 INFO - 'log_name': 'talos', 22:08:48 INFO - 'log_to_console': True, 22:08:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:08:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:08:48 INFO - 'opt_config_files': (), 22:08:48 INFO - 'pip_index': False, 22:08:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:08:48 INFO - 'cmd': ('bash', 22:08:48 INFO - '-c', 22:08:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:08:48 INFO - 'enabled': True, 22:08:48 INFO - 'halt_on_failure': False, 22:08:48 INFO - 'name': 'check_screen_resolution'},), 22:08:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:08:48 INFO - 'cmd': ('bash', 22:08:48 INFO - '-c', 22:08:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:08:48 INFO - 'enabled': True, 22:08:48 INFO - 'halt_on_failure': False, 22:08:48 INFO - 'name': 'check_screen_resolution'},), 22:08:48 INFO - 'run_cmd_checks_enabled': True, 22:08:48 INFO - 'sps_profile': False, 22:08:48 INFO - 'sps_profile_interval': 0, 22:08:48 INFO - 'suite': 'dromaeojs', 22:08:48 INFO - 'system_bits': '64', 22:08:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:08:48 INFO - 'title': 't-yosemite-r5-0035', 22:08:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:08:48 INFO - 'use_talos_json': True, 22:08:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:08:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:08:48 INFO - 'work_dir': 'build'} 22:08:48 INFO - ##### 22:08:48 INFO - ##### Running clobber step. 22:08:48 INFO - ##### 22:08:48 INFO - Running pre-action listener: _resource_record_pre_action 22:08:48 INFO - Running main action method: clobber 22:08:48 INFO - rmtree: /builds/slave/test/build 22:08:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:08:48 INFO - Running post-action listener: _resource_record_post_action 22:08:48 INFO - ##### 22:08:48 INFO - ##### Running read-buildbot-config step. 22:08:48 INFO - ##### 22:08:48 INFO - Running pre-action listener: _resource_record_pre_action 22:08:48 INFO - Running main action method: read_buildbot_config 22:08:48 INFO - Using buildbot properties: 22:08:48 INFO - { 22:08:48 INFO - "properties": { 22:08:48 INFO - "buildnumber": 295, 22:08:48 INFO - "product": "firefox", 22:08:48 INFO - "script_repo_revision": "production", 22:08:48 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 22:08:48 INFO - "repository": "", 22:08:48 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 22:08:48 INFO - "buildid": "20151203200703", 22:08:48 INFO - "slavename": "t-yosemite-r5-0035", 22:08:48 INFO - "pgo_build": "False", 22:08:48 INFO - "basedir": "/builds/slave/test", 22:08:48 INFO - "project": "", 22:08:48 INFO - "platform": "yosemite", 22:08:48 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:08:48 INFO - "slavebuilddir": "test", 22:08:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 22:08:48 INFO - "branch": "mozilla-aurora", 22:08:48 INFO - "repo_path": "releases/mozilla-aurora", 22:08:48 INFO - "stage_platform": "macosx64", 22:08:48 INFO - "builduid": "e10b456502284880814434de3fd7511b", 22:08:48 INFO - "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0" 22:08:48 INFO - }, 22:08:48 INFO - "sourcestamp": { 22:08:48 INFO - "repository": "", 22:08:48 INFO - "hasPatch": false, 22:08:48 INFO - "project": "", 22:08:48 INFO - "branch": "mozilla-aurora-macosx64-talos", 22:08:48 INFO - "changes": [ 22:08:48 INFO - { 22:08:48 INFO - "category": null, 22:08:48 INFO - "files": [ 22:08:48 INFO - { 22:08:48 INFO - "url": null, 22:08:48 INFO - "name": "https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 22:08:48 INFO - } 22:08:48 INFO - ], 22:08:48 INFO - "repository": "", 22:08:48 INFO - "rev": "858b1b930b16a5c46634e3dad2650c517e150cb0", 22:08:48 INFO - "who": "maglione.k@gmail.com", 22:08:48 INFO - "when": 1449208311, 22:08:48 INFO - "number": 6743158, 22:08:48 INFO - "comments": "Bug 1218443: [webext] Fix some instances of window listeners not being added correctly. r=billm a=ritu", 22:08:48 INFO - "project": "", 22:08:48 INFO - "at": "Thu 03 Dec 2015 21:51:51", 22:08:48 INFO - "branch": "mozilla-aurora-macosx64-talos", 22:08:48 INFO - "revlink": "", 22:08:48 INFO - "properties": [ 22:08:48 INFO - [ 22:08:48 INFO - "buildid", 22:08:48 INFO - "20151203200703", 22:08:48 INFO - "Change" 22:08:48 INFO - ], 22:08:48 INFO - [ 22:08:48 INFO - "builduid", 22:08:48 INFO - "e10b456502284880814434de3fd7511b", 22:08:48 INFO - "Change" 22:08:48 INFO - ], 22:08:48 INFO - [ 22:08:48 INFO - "pgo_build", 22:08:48 INFO - "False", 22:08:48 INFO - "Change" 22:08:48 INFO - ] 22:08:48 INFO - ], 22:08:48 INFO - "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0" 22:08:48 INFO - } 22:08:48 INFO - ], 22:08:48 INFO - "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0" 22:08:48 INFO - } 22:08:48 INFO - } 22:08:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 22:08:48 INFO - Running post-action listener: _resource_record_post_action 22:08:48 INFO - ##### 22:08:48 INFO - ##### Running download-and-extract step. 22:08:48 INFO - ##### 22:08:48 INFO - Running pre-action listener: _resource_record_pre_action 22:08:48 INFO - Running main action method: download_and_extract 22:08:48 INFO - mkdir: /builds/slave/test/build/tests 22:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:48 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json 22:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json 22:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:08:49 INFO - Downloaded 1149 bytes. 22:08:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:08:49 INFO - Using the following test package requirements: 22:08:49 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:08:49 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:08:49 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 22:08:49 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:08:49 INFO - u'jsshell-mac.zip'], 22:08:49 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:08:49 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 22:08:49 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:08:49 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:08:49 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 22:08:49 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:08:49 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 22:08:49 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:08:49 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 22:08:49 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:08:49 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:08:49 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 22:08:49 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 22:08:49 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')]} 22:08:49 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/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 22:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/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 22:08:50 INFO - Downloaded 17490132 bytes. 22:08:50 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 22:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:08:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 22:08:54 INFO - Return code: 0 22:08:54 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 22:08:54 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')]} 22:08:54 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/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 22:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/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 22:08:55 INFO - Downloaded 17490132 bytes. 22:08:55 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 22:08:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:08:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 22:09:00 INFO - Return code: 0 22:09:00 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')]} 22:09:00 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/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 22:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/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 22:09:01 INFO - Downloaded 11131307 bytes. 22:09:01 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 22:09:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:09:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:09:01 INFO - Return code: 0 22:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:01 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 22:09:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:09:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:09:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 22:09:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/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 22:09:04 INFO - Downloaded 108689100 bytes. 22:09:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:09:04 INFO - mkdir: /builds/slave/test/properties 22:09:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:09:04 INFO - Writing to file /builds/slave/test/properties/build_url 22:09:04 INFO - Contents: 22:09:04 INFO - build_url:https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:09:04 INFO - Running post-action listener: _resource_record_post_action 22:09:04 INFO - Running post-action listener: set_extra_try_arguments 22:09:04 INFO - ##### 22:09:04 INFO - ##### Running populate-webroot step. 22:09:04 INFO - ##### 22:09:04 INFO - Running pre-action listener: _resource_record_pre_action 22:09:04 INFO - Running main action method: populate_webroot 22:09:04 INFO - Guessing talos json url... 22:09:04 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')]} 22:09:04 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 22:09:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 22:09:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 22:09:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 22:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/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 22:09:05 INFO - Downloaded 107 bytes. 22:09:05 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 22:09:05 INFO - Contents: 22:09:05 INFO - 20151203200703 22:09:05 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/858b1b930b16a5c46634e3dad2650c517e150cb0 22: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')]} 22:09:05 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/858b1b930b/testing/talos/talos.json 22:09:05 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/858b1b930b/testing/talos/talos.json to /builds/slave/test/build/talos.json 22:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/858b1b930b/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 22:09:06 INFO - Downloaded 4264 bytes. 22:09:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:09:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:09:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:09:06 INFO - '../fennec_ids.txt'], 22:09:06 INFO - 'tests': ['tcheck2']}, 22:09:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:09:06 INFO - '--tppagecycles', 22:09:06 INFO - '7'], 22:09:06 INFO - 'tests': ['tsvgm']}}, 22:09:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:09:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:09:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:09:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:09:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:09:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:06 INFO - 'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:09:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:06 INFO - 'tests': ['damp', 'tps']}, 22:09:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:06 INFO - 'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['damp', 'tps']}, 22:09:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:09:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:09:06 INFO - 'other': {'tests': ['a11yr', 22:09:06 INFO - 'ts_paint', 22:09:06 INFO - 'tpaint', 22:09:06 INFO - 'sessionrestore', 22:09:06 INFO - 'sessionrestore_no_auto_restore']}, 22:09:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['a11yr', 22:09:06 INFO - 'ts_paint', 22:09:06 INFO - 'tpaint', 22:09:06 INFO - 'sessionrestore', 22:09:06 INFO - 'sessionrestore_no_auto_restore']}, 22:09:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['a11yr', 22:09:06 INFO - 'ts_paint', 22:09:06 INFO - 'tpaint', 22:09:06 INFO - 'sessionrestore', 22:09:06 INFO - 'sessionrestore_no_auto_restore']}, 22:09:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['a11yr', 22:09:06 INFO - 'ts_paint', 22:09:06 INFO - 'tpaint', 22:09:06 INFO - 'sessionrestore', 22:09:06 INFO - 'sessionrestore_no_auto_restore']}, 22:09:06 INFO - 'other_l64': {'tests': ['a11yr', 22:09:06 INFO - 'ts_paint', 22:09:06 INFO - 'tpaint', 22:09:06 INFO - 'sessionrestore', 22:09:06 INFO - 'sessionrestore_no_auto_restore']}, 22:09:06 INFO - 'other_nol64': {'tests': ['a11yr', 22:09:06 INFO - 'ts_paint', 22:09:06 INFO - 'tpaint', 22:09:06 INFO - 'sessionrestore', 22:09:06 INFO - 'sessionrestore_no_auto_restore']}, 22:09:06 INFO - 'svgr': {'tests': ['tsvgx', 22:09:06 INFO - 'tsvgr_opacity', 22:09:06 INFO - 'tart', 22:09:06 INFO - 'tscrollx', 22:09:06 INFO - 'cart']}, 22:09:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['tsvgx', 22:09:06 INFO - 'tsvgr_opacity', 22:09:06 INFO - 'tart', 22:09:06 INFO - 'tscrollx', 22:09:06 INFO - 'cart']}, 22:09:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:06 INFO - 'tests': ['tp5o']}, 22:09:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:06 INFO - 'talos_options': ['--e10s'], 22:09:06 INFO - 'tests': ['tp5o']}, 22:09:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:06 INFO - 'talos_options': ['--xperf_path', 22:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:09:06 INFO - 'tests': ['tp5n']}, 22:09:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:06 INFO - 'talos_options': ['--e10s', 22:09:06 INFO - '--xperf_path', 22:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 22:09:06 INFO - 'C:/slave/talos-data/talos/xperf.config'], 22:09:06 INFO - 'tests': ['tp5n']}}, 22:09:06 INFO - 'talos.zip': {'path': '', 22:09:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:09:06 INFO - Running post-action listener: _resource_record_post_action 22:09:06 INFO - ##### 22:09:06 INFO - ##### Running create-virtualenv step. 22:09:06 INFO - ##### 22:09:06 INFO - Running pre-action listener: _resource_record_pre_action 22:09:06 INFO - Running main action method: create_virtualenv 22:09:06 INFO - Creating virtualenv /builds/slave/test/build/venv 22:09:06 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 22:09:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:09:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:09:06 INFO - Using real prefix '/tools/python27' 22:09:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:09:07 INFO - Installing distribute.............................................................................................................................................................................................done. 22:09:11 INFO - Installing pip.................done. 22:09:11 INFO - Return code: 0 22:09:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22: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')]} 22:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1062e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106352228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd158dada50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10629a9f0>, '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 0x105ff9cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106264990>, '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.aWZHcYO11K/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.8JFkAt1G6s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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 22:09:11 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 22:09:11 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 22:09:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aWZHcYO11K/Render', 22:09:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:11 INFO - 'HOME': '/Users/cltbld', 22:09:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:11 INFO - 'LOGNAME': 'cltbld', 22:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:11 INFO - 'MOZ_NO_REMOTE': '1', 22:09:11 INFO - 'NO_EM_RESTART': '1', 22:09:11 INFO - 'PAGER': '/bin/cat', 22:09:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:11 INFO - 'PWD': '/builds/slave/test', 22:09:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:11 INFO - 'SHELL': '/bin/bash', 22:09:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8JFkAt1G6s/Listeners', 22:09:11 INFO - 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/', 22:09:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:11 INFO - 'USER': 'cltbld', 22:09:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:11 INFO - 'XPC_FLAGS': '0x0', 22:09:11 INFO - 'XPC_SERVICE_NAME': '0', 22:09:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:11 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 22:09:11 INFO - Cleaning up... 22:09:11 INFO - Return code: 0 22:09:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22: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')]} 22:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1062e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106352228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd158dada50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10629a9f0>, '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 0x105ff9cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106264990>, '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.aWZHcYO11K/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.8JFkAt1G6s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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 22:09:11 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 22:09:11 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 22:09:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aWZHcYO11K/Render', 22:09:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:11 INFO - 'HOME': '/Users/cltbld', 22:09:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:11 INFO - 'LOGNAME': 'cltbld', 22:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:11 INFO - 'MOZ_NO_REMOTE': '1', 22:09:11 INFO - 'NO_EM_RESTART': '1', 22:09:11 INFO - 'PAGER': '/bin/cat', 22:09:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:11 INFO - 'PWD': '/builds/slave/test', 22:09:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:11 INFO - 'SHELL': '/bin/bash', 22:09:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8JFkAt1G6s/Listeners', 22:09:11 INFO - 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/', 22:09:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:11 INFO - 'USER': 'cltbld', 22:09:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:11 INFO - 'XPC_FLAGS': '0x0', 22:09:11 INFO - 'XPC_SERVICE_NAME': '0', 22:09:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:11 INFO - Downloading/unpacking psutil>=0.7.1 22:09:11 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 22:09:11 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 22:09:11 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 22:09:11 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 22:09:11 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 22:09:11 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 22:09:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:09:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:09:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:14 INFO - Installing collected packages: psutil 22:09:14 INFO - Running setup.py install for psutil 22:09:14 INFO - building 'psutil._psutil_osx' extension 22:09:14 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 22:09:14 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 22:09:14 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 22:09:14 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 22:09:14 INFO - building 'psutil._psutil_posix' extension 22:09:14 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 22:09:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:09:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:09:14 INFO - ^ 22:09:15 INFO - 1 warning generated. 22:09:15 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 22:09:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:15 INFO - Successfully installed psutil 22:09:15 INFO - Cleaning up... 22:09:15 INFO - Return code: 0 22:09:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1062e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106352228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd158dada50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10629a9f0>, '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 0x105ff9cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106264990>, '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.aWZHcYO11K/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.8JFkAt1G6s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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 22:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aWZHcYO11K/Render', 22:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:15 INFO - 'HOME': '/Users/cltbld', 22:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:15 INFO - 'LOGNAME': 'cltbld', 22:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:15 INFO - 'MOZ_NO_REMOTE': '1', 22:09:15 INFO - 'NO_EM_RESTART': '1', 22:09:15 INFO - 'PAGER': '/bin/cat', 22:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:15 INFO - 'PWD': '/builds/slave/test', 22:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:15 INFO - 'SHELL': '/bin/bash', 22:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8JFkAt1G6s/Listeners', 22:09:15 INFO - 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/', 22:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:15 INFO - 'USER': 'cltbld', 22:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:15 INFO - 'XPC_FLAGS': '0x0', 22:09:15 INFO - 'XPC_SERVICE_NAME': '0', 22:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:09:15 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 22:09:15 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 22:09:15 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 22:09:15 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 22:09:15 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 22:09:15 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 22:09:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:09:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:09:17 INFO - Installing collected packages: mozsystemmonitor 22:09:17 INFO - Running setup.py install for mozsystemmonitor 22:09:18 INFO - Successfully installed mozsystemmonitor 22:09:18 INFO - Cleaning up... 22:09:18 INFO - Return code: 0 22:09:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:18 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 0x1062e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106352228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd158dada50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10629a9f0>, '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 0x105ff9cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106264990>, '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.aWZHcYO11K/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.8JFkAt1G6s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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 22:09:18 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 22:09:18 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 22:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aWZHcYO11K/Render', 22:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:18 INFO - 'HOME': '/Users/cltbld', 22:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:18 INFO - 'LOGNAME': 'cltbld', 22:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:18 INFO - 'MOZ_NO_REMOTE': '1', 22:09:18 INFO - 'NO_EM_RESTART': '1', 22:09:18 INFO - 'PAGER': '/bin/cat', 22:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:18 INFO - 'PWD': '/builds/slave/test', 22:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:18 INFO - 'SHELL': '/bin/bash', 22:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8JFkAt1G6s/Listeners', 22:09:18 INFO - 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/', 22:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:18 INFO - 'USER': 'cltbld', 22:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:18 INFO - 'XPC_FLAGS': '0x0', 22:09:18 INFO - 'XPC_SERVICE_NAME': '0', 22:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:18 INFO - Downloading/unpacking blobuploader==1.2.4 22:09:18 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 22:09:18 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 22:09:18 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 22:09:18 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 22:09:18 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 22:09:18 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 22:09:20 INFO - Downloading blobuploader-1.2.4.tar.gz 22:09:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:09:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:09:20 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 22:09:20 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 22:09:20 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 22:09:20 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 22:09:20 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 22:09:20 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 22:09:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:09:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:09:21 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 22:09:21 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 22:09:21 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 22:09:21 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 22:09:21 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 22:09:21 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 22:09:21 INFO - Downloading docopt-0.6.1.tar.gz 22:09:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:09:22 INFO - Installing collected packages: blobuploader, requests, docopt 22:09:22 INFO - Running setup.py install for blobuploader 22:09:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:09:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:09:22 INFO - Running setup.py install for requests 22:09:22 INFO - Running setup.py install for docopt 22:09:22 INFO - Successfully installed blobuploader requests docopt 22:09:22 INFO - Cleaning up... 22:09:22 INFO - Return code: 0 22:09:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22: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')]} 22:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:23 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 0x1062e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106352228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd158dada50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10629a9f0>, '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 0x105ff9cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106264990>, '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.aWZHcYO11K/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.8JFkAt1G6s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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 22:09:23 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 22:09:23 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 22:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aWZHcYO11K/Render', 22:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:23 INFO - 'HOME': '/Users/cltbld', 22:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:23 INFO - 'LOGNAME': 'cltbld', 22:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:23 INFO - 'MOZ_NO_REMOTE': '1', 22:09:23 INFO - 'NO_EM_RESTART': '1', 22:09:23 INFO - 'PAGER': '/bin/cat', 22:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:23 INFO - 'PWD': '/builds/slave/test', 22:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:23 INFO - 'SHELL': '/bin/bash', 22:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8JFkAt1G6s/Listeners', 22:09:23 INFO - 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/', 22:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:23 INFO - 'USER': 'cltbld', 22:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:23 INFO - 'XPC_FLAGS': '0x0', 22:09:23 INFO - 'XPC_SERVICE_NAME': '0', 22:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:09:23 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-4FV4OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:09:23 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-Sx8jyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:09:23 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-ykT4Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:09:23 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-QbMrTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:09:23 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-yIfeK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:09:23 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-WEmp86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-UkuMHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-L9qJw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-VIp_g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-wrJglr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-F4TMJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-AyyHqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-616tMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-2PQeM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:24 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-d9ZcjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:09:25 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-o2e9Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:09:25 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-ygoL8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:09:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:09:25 INFO - Running setup.py install for manifestparser 22:09:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:09:25 INFO - Running setup.py install for mozcrash 22:09:25 INFO - Running setup.py install for mozdebug 22:09:25 INFO - Running setup.py install for mozdevice 22:09:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:09:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:09:25 INFO - Running setup.py install for mozfile 22:09:26 INFO - Running setup.py install for mozhttpd 22:09:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:09:26 INFO - Running setup.py install for mozinfo 22:09:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:09:26 INFO - Running setup.py install for mozInstall 22:09:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:09:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:09:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:09:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:09:26 INFO - Running setup.py install for mozleak 22:09:26 INFO - Running setup.py install for mozlog 22:09:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:09:26 INFO - Running setup.py install for moznetwork 22:09:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:09:27 INFO - Running setup.py install for mozprocess 22:09:27 INFO - Running setup.py install for mozprofile 22:09:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:09:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:09:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:09:27 INFO - Running setup.py install for mozrunner 22:09:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:09:27 INFO - Running setup.py install for mozscreenshot 22:09:27 INFO - Running setup.py install for moztest 22:09:27 INFO - Running setup.py install for mozversion 22:09:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:09:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:09:28 INFO - Cleaning up... 22:09:28 INFO - Return code: 0 22:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:28 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 0x1062e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106352228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd158dada50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10629a9f0>, '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 0x105ff9cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106264990>, '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.aWZHcYO11K/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.8JFkAt1G6s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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 22:09:28 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 22:09:28 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 22:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aWZHcYO11K/Render', 22:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:28 INFO - 'HOME': '/Users/cltbld', 22:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:28 INFO - 'LOGNAME': 'cltbld', 22:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:28 INFO - 'MOZ_NO_REMOTE': '1', 22:09:28 INFO - 'NO_EM_RESTART': '1', 22:09:28 INFO - 'PAGER': '/bin/cat', 22:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:28 INFO - 'PWD': '/builds/slave/test', 22:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:28 INFO - 'SHELL': '/bin/bash', 22:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8JFkAt1G6s/Listeners', 22:09:28 INFO - 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/', 22:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:28 INFO - 'USER': 'cltbld', 22:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:28 INFO - 'XPC_FLAGS': '0x0', 22:09:28 INFO - 'XPC_SERVICE_NAME': '0', 22:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:09:28 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-hj0O6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:09:28 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)) 22:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:09:28 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-7amCf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:09:28 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)) 22:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:09:28 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-U5i_JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:09:28 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)) 22:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:09:28 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-vnStUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:09:28 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)) 22:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:09:28 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-k1BqvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:09:29 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)) 22:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:09:29 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-5ND5E2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:09:29 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)) 22:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:09:29 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-cQtHH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:09:29 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)) 22:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:09:29 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-lHEc5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:09:29 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)) 22:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:09:29 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-YEutC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:09:29 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)) 22:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:09:29 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-L7wZY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:09:29 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)) 22:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:09:29 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-BKCpwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:09:29 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)) 22:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:09:29 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-ZD_seI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:09:29 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)) 22:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:09:29 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-dTDBpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:09:30 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)) 22:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:09:30 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-uHfw1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:09:30 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)) 22:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:30 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-GD9kka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:30 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)) 22:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:09:30 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-tHQV_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:09:30 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)) 22:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:09:30 INFO - Running setup.py (path:/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/pip-VFK8tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:32 INFO - Downloading blessings-1.5.1.tar.gz 22:09:32 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 22:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:09:32 INFO - Installing collected packages: blessings 22:09:32 INFO - Running setup.py install for blessings 22:09:33 INFO - Successfully installed blessings 22:09:33 INFO - Cleaning up... 22:09:33 INFO - Return code: 0 22:09:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:09:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:09:33 INFO - Reading from file tmpfile_stdout 22:09:33 INFO - Current package versions: 22:09:33 INFO - blessings == 1.5.1 22:09:33 INFO - blobuploader == 1.2.4 22:09:33 INFO - docopt == 0.6.1 22:09:33 INFO - manifestparser == 1.1 22:09:33 INFO - mozInstall == 1.12 22:09:33 INFO - mozcrash == 0.16 22:09:33 INFO - mozdebug == 0.1 22:09:33 INFO - mozdevice == 0.46 22:09:33 INFO - mozfile == 1.2 22:09:33 INFO - mozhttpd == 0.7 22:09:33 INFO - mozinfo == 0.8 22:09:33 INFO - mozleak == 0.1 22:09:33 INFO - mozlog == 3.0 22:09:33 INFO - moznetwork == 0.27 22:09:33 INFO - mozprocess == 0.22 22:09:33 INFO - mozprofile == 0.27 22:09:33 INFO - mozrunner == 6.11 22:09:33 INFO - mozscreenshot == 0.1 22:09:33 INFO - mozsystemmonitor == 0.0 22:09:33 INFO - moztest == 0.7 22:09:33 INFO - mozversion == 1.4 22:09:33 INFO - psutil == 3.1.1 22:09:33 INFO - requests == 1.2.3 22:09:33 INFO - wsgiref == 0.1.2 22:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:33 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 0x1062e5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106352228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd158dada50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10629a9f0>, '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 0x105ff9cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106264990>, '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.aWZHcYO11K/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.8JFkAt1G6s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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 22:09:33 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 22:09:33 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 22:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aWZHcYO11K/Render', 22:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:33 INFO - 'HOME': '/Users/cltbld', 22:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:33 INFO - 'LOGNAME': 'cltbld', 22:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:33 INFO - 'MOZ_NO_REMOTE': '1', 22:09:33 INFO - 'NO_EM_RESTART': '1', 22:09:33 INFO - 'PAGER': '/bin/cat', 22:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:33 INFO - 'PWD': '/builds/slave/test', 22:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:33 INFO - 'SHELL': '/bin/bash', 22:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8JFkAt1G6s/Listeners', 22:09:33 INFO - 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/', 22:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:33 INFO - 'USER': 'cltbld', 22:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:33 INFO - 'XPC_FLAGS': '0x0', 22:09:33 INFO - 'XPC_SERVICE_NAME': '0', 22:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 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)) 22:09:33 INFO - Cleaning up... 22:09:33 INFO - Return code: 0 22:09:33 INFO - Running post-action listener: _resource_record_post_action 22:09:33 INFO - Running post-action listener: _start_resource_monitoring 22:09:33 INFO - Starting resource monitoring. 22:09:33 INFO - ##### 22:09:33 INFO - ##### Running install step. 22:09:33 INFO - ##### 22:09:33 INFO - Running pre-action listener: _resource_record_pre_action 22:09:33 INFO - Running main action method: install 22:09:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:09:34 INFO - Reading from file tmpfile_stdout 22:09:34 INFO - Detecting whether we're running mozinstall >=1.0... 22:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:09:34 INFO - Reading from file tmpfile_stdout 22:09:34 INFO - Output received: 22:09:34 INFO - Usage: mozinstall [options] installer 22:09:34 INFO - Options: 22:09:34 INFO - -h, --help show this help message and exit 22:09:34 INFO - -d DEST, --destination=DEST 22:09:34 INFO - Directory to install application into. [default: 22:09:34 INFO - "/builds/slave/test"] 22:09:34 INFO - --app=APP Application being installed. [default: firefox] 22:09:34 INFO - mkdir: /builds/slave/test/build/application 22:09:34 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'] 22:09:34 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 22:10:10 INFO - Reading from file tmpfile_stdout 22:10:10 INFO - Output received: 22:10:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 22:10:10 INFO - Running post-action listener: _resource_record_post_action 22:10:10 INFO - ##### 22:10:10 INFO - ##### Running run-tests step. 22:10:10 INFO - ##### 22:10:10 INFO - Running pre-action listener: _resource_record_pre_action 22:10:10 INFO - Running main action method: run_tests 22:10:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:10:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:10:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:10:10 INFO - 2015-12-03 22:10:10.513 screenresolution[5983:114134] starting screenresolution argv=screenresolution get 22:10:10 INFO - 2015-12-03 22:10:10.516 screenresolution[5983:114134] Display 0: 1600x1200x32@60 22:10:10 INFO - 2015-12-03 22:10:10.523 screenresolution[5984:114136] starting screenresolution argv=screenresolution list 22:10:10 INFO - Available Modes on Display 0 22:10:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:10:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:10:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:10:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:10:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:10:10 INFO - Intel HD Graphics 3000: 22:10:10 INFO - Chipset Model: Intel HD Graphics 3000 22:10:10 INFO - Type: GPU 22:10:10 INFO - Bus: Built-In 22:10:10 INFO - VRAM (Total): 512 MB 22:10:10 INFO - VRAM (Dynamic, Max): 10 22:10:10 INFO - Vendor: Intel (0x8086) 22:10:10 INFO - Device ID: 0x0116 22:10:10 INFO - Revision ID: 0x0009 22:10:10 INFO - Displays: 22:10:10 INFO - Display: 22:10:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:10:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:10:10 INFO - Display Serial Number: 1600x1200 60 22:10:10 INFO - Main Display: Yes 22:10:10 INFO - Mirror: Off 22:10:10 INFO - Online: Yes 22:10:10 INFO - Rotation: Supported 22:10:10 INFO - Return code: 0 22:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:10:10 INFO - Python 2.7.3 22:10:10 INFO - Return code: 0 22:10:10 INFO - grabbing minidump binary from tooltool 22:10:10 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')]} 22:10:10 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 0x10629a9f0>, '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 0x105ff9cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106264990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:10:10 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 22:10:10 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 22:10:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:10:10 INFO - Return code: 0 22:10:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:10:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:10:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:10:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:10:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:10:10 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/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0035', '--webServer', 'localhost'] in /builds/slave/test/build 22:10:10 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/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0035 --webServer localhost 22:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aWZHcYO11K/Render', 22:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:10 INFO - 'HOME': '/Users/cltbld', 22:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:10 INFO - 'LOGNAME': 'cltbld', 22:10:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:10:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:10 INFO - 'MOZ_NO_REMOTE': '1', 22:10:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:10:10 INFO - 'NO_EM_RESTART': '1', 22:10:10 INFO - 'PAGER': '/bin/cat', 22:10:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:10 INFO - 'PWD': '/builds/slave/test', 22:10:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:10 INFO - 'SHELL': '/bin/bash', 22:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8JFkAt1G6s/Listeners', 22:10:10 INFO - 'TMPDIR': '/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/', 22:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:10 INFO - 'USER': 'cltbld', 22:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:10 INFO - 'XPC_FLAGS': '0x0', 22:10:10 INFO - 'XPC_SERVICE_NAME': '0', 22:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:10 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/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0035', '--webServer', 'localhost'] with output_timeout 3600 22:10:11 INFO - mozversion INFO | application_buildid: 20151203200703 22:10:11 INFO - mozversion INFO | application_changeset: 858b1b930b16a5c46634e3dad2650c517e150cb0 22:10:11 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 22:10:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:10:11 INFO - mozversion INFO | application_name: Firefox 22:10:11 INFO - mozversion INFO | application_remotingname: firefox-dev 22:10:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:10:11 INFO - mozversion INFO | application_vendor: Mozilla 22:10:11 INFO - mozversion INFO | application_version: 44.0a2 22:10:11 INFO - mozversion INFO | platform_buildid: 20151203200703 22:10:11 INFO - mozversion INFO | platform_changeset: 858b1b930b16a5c46634e3dad2650c517e150cb0 22:10:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:10:11 INFO - mozversion INFO | platform_version: 44.0a2 22:10:11 INFO - 2015-12-03 22:10:11,131 DEBUG : using testdate: 1449209411 22:10:11 INFO - 2015-12-03 22:10:11,131 DEBUG : actual date: 1449209411 22:10:11 INFO - 2015-12-03 22:10:11,208 INFO : starting webserver on 'localhost:56312' 22:10:11 INFO - 2015-12-03 22:10:11,209 INFO : Starting test suite t-yosemite-r5-0035 22:10:11 INFO - 2015-12-03 22:10:11,209 INFO : Starting test dromaeo_css 22:10:11 INFO - 2015-12-03 22:10:11,209 DEBUG : operating with platform_type : mac_ 22:10:11 INFO - 2015-12-03 22:10:11,210 INFO : Initialising browser for dromaeo_css test... 22:10:11 INFO - 2015-12-03 22:10:11,236 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/tmpPZiR12/profile http://localhost:56312/getInfo.html 22:10:13 INFO - 2015-12-03 22:10:13,610 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:10:13 INFO - 2015-12-03 22:10:13,610 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:10:13 INFO - 2015-12-03 22:10:13,610 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:10:13 INFO - 2015-12-03 22:10:13,610 DEBUG : BROWSER_OUTPUT: __metrics 22:10:13 INFO - 2015-12-03 22:10:13,626 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:10:14 INFO - 2015-12-03 22:10:14,239 INFO : Browser initialized. 22:10:14 INFO - 2015-12-03 22:10:14,240 INFO : Running cycle 1/1 for dromaeo_css test... 22:10:14 INFO - 2015-12-03 22:10:14,240 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/tmpPZiR12/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:10:26 INFO - 2015-12-03 22:10:26,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 197898240 22:10:26 INFO - 2015-12-03 22:10:26,091 DEBUG : BROWSER_OUTPUT: 22:11:17 INFO - 2015-12-03 22:11:17,807 DEBUG : BROWSER_OUTPUT: 1449209477804 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] 22:13:28 INFO - 2015-12-03 22:13:28,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56312/tests/dromaeo/cssquery-ext.html) 22:13:29 INFO - 2015-12-03 22:13:29,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 304476160 22:13:29 INFO - 2015-12-03 22:13:29,302 DEBUG : BROWSER_OUTPUT: 22:16:31 INFO - 2015-12-03 22:16:31,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/dromaeo/cssquery-ext.html (next: http://localhost:56312/tests/dromaeo/cssquery-jquery.html) 22:16:32 INFO - 2015-12-03 22:16:32,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 342388736 22:16:32 INFO - 2015-12-03 22:16:32,550 DEBUG : BROWSER_OUTPUT: 22:19:34 INFO - 2015-12-03 22:19:34,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56312/tests/dromaeo/cssquery-mootools.html) 22:19:35 INFO - 2015-12-03 22:19:35,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 319315968 22:19:35 INFO - 2015-12-03 22:19:35,206 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-12-03 22:22:37,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56312/tests/dromaeo/cssquery-prototype.html) 22:22:37 INFO - 2015-12-03 22:22:37,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 301416448 22:22:37 INFO - 2015-12-03 22:22:37,735 DEBUG : BROWSER_OUTPUT: 22:25:40 INFO - 2015-12-03 22:25:40,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56312/tests/dromaeo/cssquery-yui.html) 22:25:41 INFO - 2015-12-03 22:25:41,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 303853568 22:25:41 INFO - 2015-12-03 22:25:41,446 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/dromaeo/cssquery-yui.html (next: http://localhost:56312/tests/dromaeo/cssquery-dojo.html) 22:28:44 INFO - 2015-12-03 22:28:44,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 357019648 22:28:44 INFO - 2015-12-03 22:28:44,291 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,291 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:28:44 INFO - 2015-12-03 22:28:44,291 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:28:44 INFO - 2015-12-03 22:28:44,291 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:28:44 INFO - 2015-12-03 22:28:44,292 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:28:44 INFO - 2015-12-03 22:28:44,292 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3118.0489950565075;3178.07835727639;3179.952300715488;3180.729637980772;3212.742980561555;5162.5611822995;5172.09488339541;5181.041507321148;5235.6596821206695;5288.418273989862;5193.350831146106;5197.220416937461;5216.8695782605455;5274.367075950891;5308.416074231832;4765.166095933215;4780.1873681474235;4817.542333478314;4835.999999999991;4945.851624451254;4779.115863565235;4866.756662166895;4880.072786170634;4888.266759986012;4893.8531844044555;4848.054629347279;4870.415550133989;4885.780139893714;4940;4941.925871111936;4871.683340582851;4882.584980276681;4904.43598986114;4906.215005599087;4914.459409464956;4693.9530604693855;4719.9292010619865;4769.308450274691;4818.445878723956;4827.58965487934;5146.6911985281;5150.742462876879;5164.793408263665;5227.843164705065;5232.058229518685;5565.5825813063775;5593.74828132735;5595.468430499137;5616.66300022;5621.016322143609;5380.78476860929;5611.523020543259;5641.294838145232;5744.626599271034;5782.624129431573;5309.787608495617;5311.707856067954;5317.069512835238;5336.573074154058;5346.091164502044;5588.3573389060775;5800.1589769484035;5821.18503409523;5849.005669036189;5881.617694849907;5425.186222066722;5467.753951072212;5474.91787623186;5516.806911758069;5539.944600554023;5733.598648094593;5764.048931926269;5764.510016648548;5771.278590176228;5854.677992710442;5366.382865970385;5641.351244606841;5646.463585959327;5662.122371032497;5664.6034777566;5414.160805075219;5448.482394172547;5502.5597952163735;5539;5558.916616250759;4302.9569704303185;4339.1972485090355;4343.869683909487;4348.717333373321;4397.824087036547;3883.5339759229073;3965.8810235692977;3983.621555952238;4022.6580740637373;4024.537178224483;5183.377994640668;5235.764390602432;5247.816326428557;5263.973680131575;5290.074237008585;5710.914336284959;5722.198892155018;5736.741846616912;5751.683657398799;5842.941570584325;5064.164412871834;5142.254373115878;5276.973615131899;5282.630215884851;5323.653962492503;4886.60907127429;4949.876253093701;4970.925436118461;4972.627052970969;4990.351254336913;5738.426157384228;5809;5818.854528636818;5829.5336373090895;5833.241678581927;5504.201890725903;5557.555395568425;5769.8557536061935;5788.53691704671;5813.186153938367;5455.399906010256;5678.14827775837;5771.134329850556;5775.566832487496;5814.970925145516;5610.719464026701;5615.522680572197;5619.381867994435;5643.943560564342;5679.5172410345585;5361.705106219196;5449.972750136224;5692.914606280992;5729.739457319383;5764.279465066867;5394.487523685244;5399.109146990702;5445.074337362578;5445.992491389105;5456.345238571397;5561.082421400423;5576.10782274834;5584;5585.441455854382;5613.971930140323;5298.894022119459;5410;5521.641093328921;5537.1140617501005;5588.524975377139;5377.623566350474;5584.944150558443;5610.372015878729;5623.971880140573;5694.601377903507;5474.945250547444;5477.068898287381;5481.123020316731;5532.197831314517;5556.888862222814 22:28:44 INFO - 2015-12-03 22:28:44,292 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.2115995286692;565.6153815405526;565.8698499345151;578.8552861784557;593.8723174517478;32245.51631725523;38300.61699383005;38772.80613596928;39035.21929561411;39289.410658840105;41947;42139.789301053526;42170.57829421705;42179;42356;8355.248027677508;8403.285720713746;9071.909280907188;9165.495897725623;9201.217896478807;10696.090832279227;10913.072388846958;10953.616623418182;10967.451627418637;11048.226624136314;10670.30643008202;10775.299605525615;10784.676459706183;10806.837897431546;10816;8497;8654.048054713976;10690.518926648241;10713.196510261723;10721.410322432263;10587.523561439753;10648.57405703771;10697.572097116106;10734.838977415346;10756.515956781963;38831.22337553233;39215.803920980215;39287.41068883969;39399.80300098481;39405;2811.9578206326923;2902.3034471726846;2937.5446805745146;3389.305192435545;3518.4194607889667;27104.45791084187;27189.86405067982;27606.861965690245;28377.858110709316;28488;2307.6423154410927;2353.646952957053;2377.6314671225987;2388.6297623868327;2486.875656217182;271754;272524;274126;274340;274554;57497.42502574921;58074.12888806671;60422.69788651117;60687.69656151691;60744.69627651922;58884.7055764727;59375.10937335943;59539.70230148908;59650.403495964485;60199.39800602025;15653.217339133225;15823.604409889846;15869.920650396674;15989.840101598835;16007.359705611645;12327.445264963098;12347.876521234673;12358.938205308916;12410.379481025913;12443.315617640936;19952;20328.390148295573;20559.794402055788;20576.691349629768;20614.793852061586;8468.661253549912;8670.47977121362;8723.432976856484;8775.341849361323;8804.031556528776;1027.799579082072;1027.917766578672;1029.5006921642996;1047.6490375724218;1084.0731174845394;27350.589741153897;27549.31126721808;27694.307642309104;27787.861060694566;27862.5820612691;934.5700977550267;968.4237878462303;1048.1719441641171;1153.3022521374448;1161.8838116188483;10812.390704494752;13732.725345493034;14200.360983755756;14361.890864022376;14503.057301275383;385348;390930;391692;392303;393537;51737.22394164091;52652;52717.209241861405;53297.2005419919;58695;1415.9929200353931;1430.885529157665;1445.515752222996;1456.6139972906976;1457.9635509111934;27674.44651107007;27934.580981285704;28902.710972890003;29134.27164320909;29322.413551729274;44759.55240447684;45655.08689826251;50237.74881125571;51006.48993510166;51105.488945110075;289819;293732;295223;300280;300413;39045;39069;39249;40283.59716402798;40434.595654043085;42444.36333454939;42450.78774606107;43231.567684324014;43521;43538.782306088266;34498.82750586231;35729.46405803863;36126.27747444984;36872.07819804419;37471.81264093662;34609.13477163091;35143;35243.647563524035;35452.29095418129;35465;35952;36531.81734091313;36871.26257474889;37842.43236351512;38179.61820381872;29278.853605731834;31158.844205778827;31247;31483.370332593677;31603;23910.52178956446;24173.2525508939;24182.153624623053;24202.75797242005;24318.75681243165 22:28:44 INFO - 2015-12-03 22:28:44,292 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.5683638615344;348.5834427858709;348.78201124297317;356;359.062845972013;14491.927540362283;14625.414983400651;17239.913800430997;17980.910095449522;19083.045847707628;15858.682826343465;16896.746548801748;18583.90708046461;18917.62164756704;19135.138918748657;5291.153415453528;5321.707306098163;5402.91895621566;5437.619366644337;5442.700651464168;4042.555318914917;4152.439420678215;5395.190721391803;5440.836774896739;5498.780048798043;5581.553475721932;5771;5819.9418005819825;5882.794102206423;5887.941120588804;5515.283013208297;5815.709214539277;5960.135780311853;5972.25346831646;6007.3992600739575;5154.226865970097;5157.303763991888;5160.638755287131;5168.715720635363;5232.476752324776;21660.133594656196;21831.45421364463;21951.451213719785;22126.668099978513;22179.44551386212;1979.9406017819488;2044.4173410577914;2096.1824888293427;2179.8038176564187;2201.9449513762124;13079.084464087518;13576.59270221895;13670.316484175752;13875.098118622258;13889.166650001032;1649.818519962803;1672.5985763416813;1690.6027083635336;1741.9983509481972;1747.6067884725962;60568.69715651393;62896;63550;65076.3492365075;65100.3489965099;9540.759701238794;9990.600375985025;10014.39913605186;10015.499225038719;10048.045435683598;12176.756464870654;12237.69405764863;12362.3818809061;12372.07209459294;12405.62783116508;7998.600069996477;8043.075046369625;8109.026916770025;8226.547539885363;8258.091609922903;8144.592770361458;8193.672253109928;8200.958995204986;8209.671613135528;8219.753407397788;5859.2090067841145;5923.4076592340425;5929.495992840571;5933.554983376178;5956.315023772235;1583.7307657698218;1648.2170968789728;1663.6340005198838;1682.6129990102345;1688.7044767165696;933.6300069873615;958.4872093429982;972.601233494264;1023.5036007536339;1030.5980667539666;17842.553936151442;18534.53663658392;19569.315073972626;19647.705284420746;19918.800811991983;876.9429987050821;910.3036177324352;1018.556927736437;1031.9535620897077;1047.4605578127118;9918.80162396748;10235.181185505142;10241.897581024243;10264.486775661187;10420.06219440254;537035;545898;549119;558783;563674;76733.61633191798;77092;77252;77391.22608773953;77772.61113694395;1090.6782499162607;1092.448313601642;1093.6554985179484;1093.9726506837392;1098.906592939609;15977.680446390774;16544.50366489007;16608.501744947673;16629.83370166283;16665.3333866644;35884.10289742673;36065;36206.27587448289;36247.81876090708;36804.631953680124;50515.49484505255;50725.23912141395;50730.74634626803;51141.48858511367;51508.227376588635;9205.125513076247;9442.197413219954;9500.572474238537;9540;9612.18296444782;18573.628527429646;18731.625367492845;19033.524161896064;19134.23463061462;19167.04164791727;14697.485588004369;14772.261386930395;15106.54680359591;15433.84566154324;15467;9993;10285.382877027403;14409.351579179172;14588.562343129299;14689;9075.500847453453;9208.171264586219;9556;10282.126019288444;10664.84002739975;5765.423457654201;6297.52768542352;6304.5586808922935;6383.776567820104;6385.393387628168;10558.366498010144;10645.8935410648;10650.094741946712;10699.89300106989;10824 22:28:44 INFO - 2015-12-03 22:28:44,295 DEBUG : BROWSER_OUTPUT: |3;mootools.html;917.6421195733661;1748.9125543722814;1776.4226626346438;1784.2862854858056;1794.6051868588906;6749.426298764604;7418.22108678589;7551.811204719885;7557.546547207165;7577.734779282726;7194.316539928712;7409.777706668809;7488.812779680497;7489;7494.362979146766;2163.2320526213166;2166.6100101981638;2168.29530402619;2186.6173419651577;2192.7478339990867;2179.3679832848456;2207.9668804967937;2240.1375470443913;2259.401258666455;2259.830512711545;2196.143504033428;2201.218567408571;2203.493196564791;2208.845380823343;2244.5959727249087;2191.1345018717516;2198.8240940724704;2201.5927053495075;2204.9889750551224;2227.4765430123825;2191.9232826851144;2208.3595757230382;2216.5012872103807;2223.2996606069037;2223.5108276179217;6734.865302693918;6911.205211400653;7329.120505539316;7393.70425182992;7433.070866141732;4472.843450479218;4579.29021001742;4617.3304870793545;4618.399608050965;4633.096546173498;2884.0915111739737;2976.04766474726;2987.4025194960877;3022.6221722284713;3025.1529571719952;867.189178118455;871.538084815049;874.060385086035;918.8437965545806;1490.8434614365444;9525.857112143323;9544.188743956773;9632;9637;9640.807183856283;3983;4051.918961620751;4058.5332686740812;4101.589841015934;4107.67138628909;8184.918150818535;8185.836283274421;8186.754397368089;8199.508029518249;8200.5489698066;4622.399088118523;4666.859994200179;4668.883277918011;4671.11248862715;4672.415948006499;4329.415528903558;4334.913301733947;4335.588119128678;4336.739795612273;4338.826446942087;3293.3084052348795;3294.5058241263523;3305.86776528941;3308.553345298402;3340.298537307193;972.5623469438781;977.3158788847835;978.2125389061873;992.3153024413132;996.5814357969671;1264.797632378815;1264.9810252846214;1291.8966482681362;1292.877176668215;1311.4098655604826;6983.6857341418745;7073.964630176816;7092.078029856189;7300.342969132804;7350.96324518374;1100.7523307255963;1113.1984970820995;1124.3921192694525;1130.3331034689572;1152.521703493041;5369.838904832861;5716.42835716425;5723.627964182315;5736.741846616912;5776.133579962955;7921.920780792234;8567.485950842969;8707.259882910024;8779.253763430052;8798.912010879938;8629.741107766651;8666.999999999874;8667.219950204511;8724.476531408136;8732.738017859474;6785.185777706707;6950.200726916368;6962.303769622998;6971.163460384685;7043.471739619549;6766.492513061442;6873.415759660485;6895.34494223048;6925.065116209449;6946.131733533309;7688.192739762245;7842.647080881488;7846.921530784847;7871.252231038042;7875.763727088197;7963.721269755531;7986.680532778624;7990.240927112148;7991.440599158003;8059.355251579742;6388.329225431263;6742.69657865407;6757.493188010821;6768.0863083485065;6775.322467753185;7291.526050806893;7301.780946571611;7306.488545801955;7323.963380183065;7340.449466289942;6622.768203112868;6756.054152418567;6767.154105736783;6856.451483881177;6954.3393377629045;6631.867362652816;6654.900176497454;6719.4624430044505;6737.090492783412;6777.559458635173;6816.147981502312;6819.352161544645;6853.588784672936;6873.5875847449315;6907.758228461979;6166.167567378347;6169.84575385619;6176.4441200292185;6190.2571691397325;6216.316205217513;6300.684965751602;6336.556441049082;6374.968125159345;6378.936210637834;6437.613743175424 22:28:44 INFO - 2015-12-03 22:28:44,297 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.39575181665737;330.9420851351014;331.09445666103204;333.25517468457997;338.0197427460366;5820.330661973874;5958.433948774859;5974.79088231912;5983.6409815411;6110.816675499736;5781.219535362725;5896.557758168144;5955.136505206753;5965.761369545213;5998.190244317016;4558.9544104558945;4580.679352445331;4588.059447813191;4592.5177856324935;4601.539846015406;4404.757738324391;4505.954940450602;4549.090181963604;4585.3122031695175;4609.44686637604;4540.091981603692;4556.088782243548;4557.908841823161;4569.93145102822;4577.382053422795;4559.589636932692;4561.954380456186;4564.406627138467;4574.5882870541645;4595.264757638795;3963.920721585581;3976.304146774303;3977.025628720953;3980.263651224504;3986.5415477219913;5652.9152062719095;5760.164776107441;5789.681567513785;5791.0734282514595;5848.736806843703;5098.719570423626;5103.770330335144;5117.974410127926;5118.59051275897;5177.223416487519;6074.696265186723;6172.722227499728;6201.0388389799655;6257.186565746424;6296.1500197473215;4058.208649313385;4175.707700460969;4216.64158546524;4245.21463529245;4255.5744425557505;6367.61794292344;6480.416762491398;6480.643564603898;6512.088307636935;6513.381228783258;4285;4295.699301048897;4300;4307.483102027777;4347.0871117065135;4164.06308580573;4293.463317085364;4362.8036738346855;4366.847160349373;4403.207422663887;4996.150654388763;5021.59827213822;5026.497350265017;5048.8232911848645;5053.267276244997;6194.81415557534;6217.316095229521;6233.594816336924;6275.435210831047;6281.748730050838;1576.6688995310883;1592.800899887514;1597.9280932358072;1599.1604407685825;1599.9760003599956;1013.022433351819;1030.4744580264119;1044.6604853422668;1046.9528871200662;1051.952662130206;5964.224650795456;5985.431384018511;6012.158297838306;6032.065029920369;6092.360302168208;6579.4736421087155;6580.736770529221;6630.602163870183;6647.567908085959;6675.0988616537115;5979.641221526722;6017.247844019497;6035.637861728311;6066.3630318815885;6081.209442772411;3553.0406790167026;3615.783053016775;3622.5109610202285;3635.4910312556262;3661.0664280608275;6606.075149479077;6608.107905432801;6642.767503137464;6680.498962577826;6692.3976842083475;6694.196696396463;6709.228438729511;6743;6766.052752614638;6772.93227067723;6365.490760739222;6590.670466476561;6627.834304142339;6668.166479190101;6774.627395493295;6353.809385718436;6482.578632389068;6596.868062638624;6648.335166483313;6657.833554161185;6391.616503009835;6402.231732192166;6412.935870641234;6468.062130991074;6496.220453545605;6620.966895165493;6648.235452922782;6671.066050752996;6680.9331906682255;6688.197416310074;4216.599423054805;4301.5483374246505;4352.717073390219;4375.124975004948;4402.3176407656865;6488.708008139551;6532.5753826001155;6533.738650453929;6540.672966351568;6541.967290163519;6215.875682486235;6307.810765677037;6324.525660575383;6354.3963323484195;6363.61818290904;6169;6314.179156709598;6321.778737744157;6330.968345158245;6397.200349956255;6141.263048434216;6190.597611155261;6208.0998255253635;6239.251289845248;6285.654289013965;6383.106365108982;6410.647414392253;6446.871062578816;6455.483561315177;6493.285738568659;6161.353057929032;6230.470410015199;6263.968680156752;6284.402981716729;6324.494040476843 22:28:44 INFO - 2015-12-03 22:28:44,300 DEBUG : BROWSER_OUTPUT: |5;yui.html;729.4273994913992;758.9506682065665;764.7132325377987;771.6488997506135;774.7056118674902;13752.449902003907;14045;14209.218492982882;16218.594535136628;16445.91777041116;14448.277586120677;14887.851121488782;14895.7020859583;14913.32890019949;15078.924605376986;709.0427922304899;710.3393843725333;878.3149143667933;881.9294456443469;892.0410558649445;854.1543871567135;860.5396113079504;864.1358641358642;866.7139843851545;876.8158686675806;892.1034360467721;896.1083721696888;896.668232753882;898.2095755734977;907.3784457646533;721.7113154738121;727.8216836874999;900.0864122915247;903.3134817538652;910.899801021887;666.0641798273433;667.4893706314673;668.3283300283233;672.865426914619;675.1998881325645;14003.299835008209;14044.92977535116;14059.718805623932;14101.85898141026;14192.716145677132;9494.145526902543;9699.951500242454;9735.610575576968;9920.35517691355;10134.847977280348;9035.819283614357;9128.908710912872;9394.06059394062;9673.951630241874;9993.050660187271;2876.4822331980236;2936.2365784896083;2960.9407811843857;3029.909102726922;3112.95715935162;47915.76042119767;48144.518554814706;48532;48713.99999999964;48914.51085489135;6816.147981502312;6886.173659160832;6903.482238832108;6996.965015174993;7126;12326.445309960895;12337.136400452062;12351.814722779165;12377.133600647869;12429.689257768447;5886.793962211302;6019.157317975487;6323.841903952438;6355;6567.4417674497245;3642.2715456908195;3712.6287371262656;3725.112395632629;3752.6622603965775;3824.8278827452273;2801.173653772142;2855.4146399987953;2860.699626539225;2873.3391319996517;2884.3510210202535;401.1115379434508;405.49920847753003;406.9694772892045;414.64754958285215;421.2396624093541;454.72034698660747;540.3084052412839;551.9944800552023;560.8502569732033;610.795383546508;7554.508956917783;7823.765287041398;7838;8021.759347219593;8114.148014458515;453.31323045585964;485.75226634416;537.0092179928026;574.4112284907919;594.3848117198766;3699.1491956850077;3798.2783271178387;3838.2323535293053;3905.5703872573995;4008.378701301303;58150;61097.08354374688;61537.69231153816;61936;62036.379636203965;49460;51247.48752512427;51380.48619513832;51476.48523514792;51649.48350516522;50408.74795626072;50580;50610.49389506058;50649.240261395375;51679.74160129175;7619.657115429708;7730.652120654471;7997.720079797412;8065.233802788725;8189.590520474072;33845.153871153416;35008.29983400369;36266.27467450689;37151.81424092862;37584.43623345707;46250.53749462597;50330.748346258035;50635.74682126566;50679.74660126676;50905.490945090074;7725.227477252454;7855.84288314242;7888.684452621831;7928.682852686059;7939.364850811806;11147.832782508107;11251.324920504796;11321.830172547583;11390.088792896715;11653.30080195191;10268.07587317145;10405.58377664885;10548.736281593021;10680.83978740335;10696.358218506915;9717.12545870875;9778.65774697882;10315.742106447398;10337.638182663572;10554.841677374692;10080.445575493419;10267.127294180078;10342;10440.53017614194;10519.94740026295;9036.819263614823;9174.495402752913;9210.723678289662;9290.442573445614;9533.142017218484;8883.777905552413;8884.422512536665;9018.503982281038;9078.409903356262;9124.589393477178 22:28:44 INFO - 2015-12-03 22:28:44,300 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:28:44 INFO - 2015-12-03 22:28:44,300 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:28:44 INFO - 2015-12-03 22:28:44,301 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,888 22:28:44 INFO - 2015-12-03 22:28:44,301 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:28:44 INFO - 2015-12-03 22:28:44,301 DEBUG : BROWSER_OUTPUT: __startTimestamp1449210524285__endTimestamp 22:28:44 INFO - 2015-12-03 22:28:44,301 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,301 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:28:44 INFO - 2015-12-03 22:28:44,302 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:28:44 INFO - 2015-12-03 22:28:44,302 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,302 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5249.43 Median:5410.00 stddev:565.57 (10.5%) stddev-sans-first:542.02 22:28:44 INFO - 2015-12-03 22:28:44,302 DEBUG : BROWSER_OUTPUT: Values: 3118.0 3178.1 3180.0 3180.7 3212.7 5162.6 5172.1 5181.0 5235.7 5288.4 5193.4 5197.2 5216.9 5274.4 5308.4 4765.2 4780.2 4817.5 4836.0 4945.9 4779.1 4866.8 4880.1 4888.3 4893.9 4848.1 4870.4 4885.8 4940.0 4941.9 4871.7 4882.6 4904.4 4906.2 4914.5 4694.0 4719.9 4769.3 4818.4 4827.6 5146.7 5150.7 5164.8 5227.8 5232.1 5565.6 5593.7 5595.5 5616.7 5621.0 5380.8 5611.5 5641.3 5744.6 5782.6 5309.8 5311.7 5317.1 5336.6 5346.1 5588.4 5800.2 5821.2 5849.0 5881.6 5425.2 5467.8 5474.9 5516.8 5539.9 5733.6 5764.0 5764.5 5771.3 5854.7 5366.4 5641.4 5646.5 5662.1 5664.6 5414.2 5448.5 5502.6 5539.0 5558.9 4303.0 4339.2 4343.9 4348.7 4397.8 3883.5 3965.9 3983.6 4022.7 4024.5 5183.4 5235.8 5247.8 5264.0 5290.1 5710.9 5722.2 5736.7 5751.7 5842.9 5064.2 5142.3 5277.0 5282.6 5323.7 4886.6 4949.9 4970.9 4972.6 4990.4 5738.4 5809.0 5818.9 5829.5 5833.2 5504.2 5557.6 5769.9 5788.5 5813.2 5455.4 5678.1 5771.1 5775.6 5815.0 5610.7 5615.5 5619.4 5643.9 5679.5 5361.7 5450.0 5692.9 5729.7 5764.3 5394.5 5399.1 5445.1 5446.0 5456.3 5561.1 5576.1 5584.0 5585.4 5614.0 5298.9 5410.0 5521.6 5537.1 5588.5 5377.6 5584.9 5610.4 5624.0 5694.6 5474.9 5477.1 5481.1 5532.2 5556.9 22:28:44 INFO - 2015-12-03 22:28:44,302 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,302 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48947.52 Median:31202.92 stddev:85016.02 (272.5%) stddev-sans-first:85176.87 22:28:44 INFO - 2015-12-03 22:28:44,304 DEBUG : BROWSER_OUTPUT: Values: 555.2 565.6 565.9 578.9 593.9 32245.5 38300.6 38772.8 39035.2 39289.4 41947.0 42139.8 42170.6 42179.0 42356.0 8355.2 8403.3 9071.9 9165.5 9201.2 10696.1 10913.1 10953.6 10967.5 11048.2 10670.3 10775.3 10784.7 10806.8 10816.0 8497.0 8654.0 10690.5 10713.2 10721.4 10587.5 10648.6 10697.6 10734.8 10756.5 38831.2 39215.8 39287.4 39399.8 39405.0 2812.0 2902.3 2937.5 3389.3 3518.4 27104.5 27189.9 27606.9 28377.9 28488.0 2307.6 2353.6 2377.6 2388.6 2486.9 271754.0 272524.0 274126.0 274340.0 274554.0 57497.4 58074.1 60422.7 60687.7 60744.7 58884.7 59375.1 59539.7 59650.4 60199.4 15653.2 15823.6 15869.9 15989.8 16007.4 12327.4 12347.9 12358.9 12410.4 12443.3 19952.0 20328.4 20559.8 20576.7 20614.8 8468.7 8670.5 8723.4 8775.3 8804.0 1027.8 1027.9 1029.5 1047.6 1084.1 27350.6 27549.3 27694.3 27787.9 27862.6 934.6 968.4 1048.2 1153.3 1161.9 10812.4 13732.7 14200.4 14361.9 14503.1 385348.0 390930.0 391692.0 392303.0 393537.0 51737.2 52652.0 52717.2 53297.2 58695.0 1416.0 1430.9 1445.5 1456.6 1458.0 27674.4 27934.6 28902.7 29134.3 29322.4 44759.6 45655.1 50237.7 51006.5 51105.5 289819.0 293732.0 295223.0 300280.0 300413.0 39045.0 39069.0 39249.0 40283.6 40434.6 42444.4 42450.8 43231.6 43521.0 43538.8 34498.8 35729.5 36126.3 36872.1 37471.8 34609.1 35143.0 35243.6 35452.3 35465.0 35952.0 36531.8 36871.3 37842.4 38179.6 29278.9 31158.8 31247.0 31483.4 31603.0 23910.5 24173.3 24182.2 24202.8 24318.8 22:28:44 INFO - 2015-12-03 22:28:44,304 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,304 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29390.61 Median:352.39 stddev:90014.08 (25543.8%) stddev-sans-first:90240.17 22:28:44 INFO - 2015-12-03 22:28:44,304 DEBUG : BROWSER_OUTPUT: Values: 342.6 348.6 348.8 356.0 359.1 14491.9 14625.4 17239.9 17980.9 19083.0 15858.7 16896.7 18583.9 18917.6 19135.1 5291.2 5321.7 5402.9 5437.6 5442.7 4042.6 4152.4 5395.2 5440.8 5498.8 5581.6 5771.0 5819.9 5882.8 5887.9 5515.3 5815.7 5960.1 5972.3 6007.4 5154.2 5157.3 5160.6 5168.7 5232.5 21660.1 21831.5 21951.5 22126.7 22179.4 1979.9 2044.4 2096.2 2179.8 2201.9 13079.1 13576.6 13670.3 13875.1 13889.2 1649.8 1672.6 1690.6 1742.0 1747.6 60568.7 62896.0 63550.0 65076.3 65100.3 9540.8 9990.6 10014.4 10015.5 10048.0 12176.8 12237.7 12362.4 12372.1 12405.6 7998.6 8043.1 8109.0 8226.5 8258.1 8144.6 8193.7 8201.0 8209.7 8219.8 5859.2 5923.4 5929.5 5933.6 5956.3 1583.7 1648.2 1663.6 1682.6 1688.7 933.6 958.5 972.6 1023.5 1030.6 17842.6 18534.5 19569.3 19647.7 19918.8 876.9 910.3 1018.6 1032.0 1047.5 9918.8 10235.2 10241.9 10264.5 10420.1 537035.0 545898.0 549119.0 558783.0 563674.0 76733.6 77092.0 77252.0 77391.2 77772.6 1090.7 1092.4 1093.7 1094.0 1098.9 15977.7 16544.5 16608.5 16629.8 16665.3 35884.1 36065.0 36206.3 36247.8 36804.6 50515.5 50725.2 50730.7 51141.5 51508.2 9205.1 9442.2 9500.6 9540.0 9612.2 18573.6 18731.6 19033.5 19134.2 19167.0 14697.5 14772.3 15106.5 15433.8 15467.0 9993.0 10285.4 14409.4 14588.6 14689.0 9075.5 9208.2 9556.0 10282.1 10664.8 5765.4 6297.5 6304.6 6383.8 6385.4 10558.4 10645.9 10650.1 10699.9 10824.0 22:28:44 INFO - 2015-12-03 22:28:44,304 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,305 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5202.95 Median:6735.98 stddev:2606.27 (38.7%) stddev-sans-first:2593.66 22:28:44 INFO - 2015-12-03 22:28:44,306 DEBUG : BROWSER_OUTPUT: Values: 917.6 1748.9 1776.4 1784.3 1794.6 6749.4 7418.2 7551.8 7557.5 7577.7 7194.3 7409.8 7488.8 7489.0 7494.4 2163.2 2166.6 2168.3 2186.6 2192.7 2179.4 2208.0 2240.1 2259.4 2259.8 2196.1 2201.2 2203.5 2208.8 2244.6 2191.1 2198.8 2201.6 2205.0 2227.5 2191.9 2208.4 2216.5 2223.3 2223.5 6734.9 6911.2 7329.1 7393.7 7433.1 4472.8 4579.3 4617.3 4618.4 4633.1 2884.1 2976.0 2987.4 3022.6 3025.2 867.2 871.5 874.1 918.8 1490.8 9525.9 9544.2 9632.0 9637.0 9640.8 3983.0 4051.9 4058.5 4101.6 4107.7 8184.9 8185.8 8186.8 8199.5 8200.5 4622.4 4666.9 4668.9 4671.1 4672.4 4329.4 4334.9 4335.6 4336.7 4338.8 3293.3 3294.5 3305.9 3308.6 3340.3 972.6 977.3 978.2 992.3 996.6 1264.8 1265.0 1291.9 1292.9 1311.4 6983.7 7074.0 7092.1 7300.3 7351.0 1100.8 1113.2 1124.4 1130.3 1152.5 5369.8 5716.4 5723.6 5736.7 5776.1 7921.9 8567.5 8707.3 8779.3 8798.9 8629.7 8667.0 8667.2 8724.5 8732.7 6785.2 6950.2 6962.3 6971.2 7043.5 6766.5 6873.4 6895.3 6925.1 6946.1 7688.2 7842.6 7846.9 7871.3 7875.8 7963.7 7986.7 7990.2 7991.4 8059.4 6388.3 6742.7 6757.5 6768.1 6775.3 7291.5 7301.8 7306.5 7324.0 7340.4 6622.8 6756.1 6767.2 6856.5 6954.3 6631.9 6654.9 6719.5 6737.1 6777.6 6816.1 6819.4 6853.6 6873.6 6907.8 6166.2 6169.8 6176.4 6190.3 6216.3 6300.7 6336.6 6375.0 6378.9 6437.6 22:28:44 INFO - 2015-12-03 22:28:44,306 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,306 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5250.85 Median:5991.81 stddev:1597.72 (26.7%) stddev-sans-first:1558.90 22:28:44 INFO - 2015-12-03 22:28:44,307 DEBUG : BROWSER_OUTPUT: Values: 328.4 330.9 331.1 333.3 338.0 5820.3 5958.4 5974.8 5983.6 6110.8 5781.2 5896.6 5955.1 5965.8 5998.2 4559.0 4580.7 4588.1 4592.5 4601.5 4404.8 4506.0 4549.1 4585.3 4609.4 4540.1 4556.1 4557.9 4569.9 4577.4 4559.6 4562.0 4564.4 4574.6 4595.3 3963.9 3976.3 3977.0 3980.3 3986.5 5652.9 5760.2 5789.7 5791.1 5848.7 5098.7 5103.8 5118.0 5118.6 5177.2 6074.7 6172.7 6201.0 6257.2 6296.2 4058.2 4175.7 4216.6 4245.2 4255.6 6367.6 6480.4 6480.6 6512.1 6513.4 4285.0 4295.7 4300.0 4307.5 4347.1 4164.1 4293.5 4362.8 4366.8 4403.2 4996.2 5021.6 5026.5 5048.8 5053.3 6194.8 6217.3 6233.6 6275.4 6281.7 1576.7 1592.8 1597.9 1599.2 1600.0 1013.0 1030.5 1044.7 1047.0 1052.0 5964.2 5985.4 6012.2 6032.1 6092.4 6579.5 6580.7 6630.6 6647.6 6675.1 5979.6 6017.2 6035.6 6066.4 6081.2 3553.0 3615.8 3622.5 3635.5 3661.1 6606.1 6608.1 6642.8 6680.5 6692.4 6694.2 6709.2 6743.0 6766.1 6772.9 6365.5 6590.7 6627.8 6668.2 6774.6 6353.8 6482.6 6596.9 6648.3 6657.8 6391.6 6402.2 6412.9 6468.1 6496.2 6621.0 6648.2 6671.1 6680.9 6688.2 4216.6 4301.5 4352.7 4375.1 4402.3 6488.7 6532.6 6533.7 6540.7 6542.0 6215.9 6307.8 6324.5 6354.4 6363.6 6169.0 6314.2 6321.8 6331.0 6397.2 6141.3 6190.6 6208.1 6239.3 6285.7 6383.1 6410.6 6446.9 6455.5 6493.3 6161.4 6230.5 6264.0 6284.4 6324.5 22:28:44 INFO - 2015-12-03 22:28:44,307 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,308 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13599.70 Median:51664.61 stddev:16951.90 (32.8%) stddev-sans-first:16971.91 22:28:44 INFO - 2015-12-03 22:28:44,309 DEBUG : BROWSER_OUTPUT: Values: 729.4 759.0 764.7 771.6 774.7 13752.4 14045.0 14209.2 16218.6 16445.9 14448.3 14887.9 14895.7 14913.3 15078.9 709.0 710.3 878.3 881.9 892.0 854.2 860.5 864.1 866.7 876.8 892.1 896.1 896.7 898.2 907.4 721.7 727.8 900.1 903.3 910.9 666.1 667.5 668.3 672.9 675.2 14003.3 14044.9 14059.7 14101.9 14192.7 9494.1 9700.0 9735.6 9920.4 10134.8 9035.8 9128.9 9394.1 9674.0 9993.1 2876.5 2936.2 2960.9 3029.9 3113.0 47915.8 48144.5 48532.0 48714.0 48914.5 6816.1 6886.2 6903.5 6997.0 7126.0 12326.4 12337.1 12351.8 12377.1 12429.7 5886.8 6019.2 6323.8 6355.0 6567.4 3642.3 3712.6 3725.1 3752.7 3824.8 2801.2 2855.4 2860.7 2873.3 2884.4 401.1 405.5 407.0 414.6 421.2 454.7 540.3 552.0 560.9 610.8 7554.5 7823.8 7838.0 8021.8 8114.1 453.3 485.8 537.0 574.4 594.4 3699.1 3798.3 3838.2 3905.6 4008.4 58150.0 61097.1 61537.7 61936.0 62036.4 49460.0 51247.5 51380.5 51476.5 51649.5 50408.7 50580.0 50610.5 50649.2 51679.7 7619.7 7730.7 7997.7 8065.2 8189.6 33845.2 35008.3 36266.3 37151.8 37584.4 46250.5 50330.7 50635.7 50679.7 50905.5 7725.2 7855.8 7888.7 7928.7 7939.4 11147.8 11251.3 11321.8 11390.1 11653.3 10268.1 10405.6 10548.7 10680.8 10696.4 9717.1 9778.7 10315.7 10337.6 10554.8 10080.4 10267.1 10342.0 10440.5 10519.9 9036.8 9174.5 9210.7 9290.4 9533.1 8883.8 8884.4 9018.5 9078.4 9124.6 22:28:44 INFO - 2015-12-03 22:28:44,309 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:28:44 INFO - 2015-12-03 22:28:44,309 DEBUG : BROWSER_OUTPUT: 22:28:44 INFO - 2015-12-03 22:28:44,951 INFO : Browser exited with error code: 0 22:28:44 INFO - 2015-12-03 22:28:44,979 INFO : Completed test dromaeo_css (00:18:33) 22:28:44 INFO - 2015-12-03 22:28:44,979 INFO : Starting test kraken 22:28:44 INFO - 2015-12-03 22:28:44,979 DEBUG : operating with platform_type : mac_ 22:28:44 INFO - 2015-12-03 22:28:44,979 INFO : Initialising browser for kraken test... 22:28:44 INFO - 2015-12-03 22:28:44,992 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/tmpzfpXIr/profile http://localhost:56312/getInfo.html 22:28:47 INFO - 2015-12-03 22:28:47,105 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:28:47 INFO - 2015-12-03 22:28:47,105 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:28:47 INFO - 2015-12-03 22:28:47,106 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:28:47 INFO - 2015-12-03 22:28:47,106 DEBUG : BROWSER_OUTPUT: __metrics 22:28:47 INFO - 2015-12-03 22:28:47,109 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:28:47 INFO - 2015-12-03 22:28:47,734 INFO : Browser initialized. 22:28:47 INFO - 2015-12-03 22:28:47,735 INFO : Running cycle 1/1 for kraken test... 22:28:47 INFO - 2015-12-03 22:28:47,735 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/tmpzfpXIr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:28:59 INFO - 2015-12-03 22:28:59,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 198098944 22:28:59 INFO - 2015-12-03 22:28:59,559 DEBUG : BROWSER_OUTPUT: 22:29:02 INFO - 2015-12-03 22:29:02,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56312/tests/kraken/driver.html?testName=audio-beat-detection) 22:29:02 INFO - 2015-12-03 22:29:02,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 265162752 22:29:02 INFO - 2015-12-03 22:29:02,711 DEBUG : BROWSER_OUTPUT: 22:29:05 INFO - 2015-12-03 22:29:05,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56312/tests/kraken/driver.html?testName=audio-dft) 22:29:05 INFO - 2015-12-03 22:29:05,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 279560192 22:29:05 INFO - 2015-12-03 22:29:05,931 DEBUG : BROWSER_OUTPUT: 22:29:08 INFO - 2015-12-03 22:29:08,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56312/tests/kraken/driver.html?testName=audio-fft) 22:29:09 INFO - 2015-12-03 22:29:09,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 266817536 22:29:09 INFO - 2015-12-03 22:29:09,367 DEBUG : BROWSER_OUTPUT: 22:29:11 INFO - 2015-12-03 22:29:11,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56312/tests/kraken/driver.html?testName=audio-oscillator) 22:29:12 INFO - 2015-12-03 22:29:12,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 268664832 22:29:12 INFO - 2015-12-03 22:29:12,054 DEBUG : BROWSER_OUTPUT: 22:29:14 INFO - 2015-12-03 22:29:14,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56312/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:29:14 INFO - 2015-12-03 22:29:14,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 269549568 22:29:14 INFO - 2015-12-03 22:29:14,818 DEBUG : BROWSER_OUTPUT: 22:29:17 INFO - 2015-12-03 22:29:17,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56312/tests/kraken/driver.html?testName=imaging-darkroom) 22:29:18 INFO - 2015-12-03 22:29:18,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 269402112 22:29:18 INFO - 2015-12-03 22:29:18,454 DEBUG : BROWSER_OUTPUT: 22:29:21 INFO - 2015-12-03 22:29:21,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56312/tests/kraken/driver.html?testName=imaging-desaturate) 22:29:22 INFO - 2015-12-03 22:29:22,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 269946880 22:29:22 INFO - 2015-12-03 22:29:22,211 DEBUG : BROWSER_OUTPUT: 22:29:25 INFO - 2015-12-03 22:29:25,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56312/tests/kraken/driver.html?testName=json-parse-financial) 22:29:25 INFO - 2015-12-03 22:29:25,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 269762560 22:29:25 INFO - 2015-12-03 22:29:25,671 DEBUG : BROWSER_OUTPUT: 22:29:27 INFO - 2015-12-03 22:29:27,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56312/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:29:27 INFO - 2015-12-03 22:29:27,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 302125056 22:29:27 INFO - 2015-12-03 22:29:27,846 DEBUG : BROWSER_OUTPUT: 22:29:29 INFO - 2015-12-03 22:29:29,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56312/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:29:30 INFO - 2015-12-03 22:29:30,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 302665728 22:29:30 INFO - 2015-12-03 22:29:30,286 DEBUG : BROWSER_OUTPUT: 22:29:32 INFO - 2015-12-03 22:29:32,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56312/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:29:32 INFO - 2015-12-03 22:29:32,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 306896896 22:29:32 INFO - 2015-12-03 22:29:32,912 DEBUG : BROWSER_OUTPUT: 22:29:35 INFO - 2015-12-03 22:29:35,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56312/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:29:36 INFO - 2015-12-03 22:29:36,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 310865920 22:29:36 INFO - 2015-12-03 22:29:36,009 DEBUG : BROWSER_OUTPUT: 22:29:38 INFO - 2015-12-03 22:29:38,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56312/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:29:39 INFO - 2015-12-03 22:29:39,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 309362688 22:29:39 INFO - 2015-12-03 22:29:39,131 DEBUG : BROWSER_OUTPUT: 22:29:40 INFO - 2015-12-03 22:29:40,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56312/tests/kraken/driver.html?testName=ai-astar) 22:29:41 INFO - 2015-12-03 22:29:41,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 368238592 22:29:41 INFO - 2015-12-03 22:29:41,107 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,107 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:29:41 INFO - 2015-12-03 22:29:41,107 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:29:41 INFO - 2015-12-03 22:29:41,108 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:29:41 INFO - 2015-12-03 22:29:41,108 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:29:41 INFO - 2015-12-03 22:29:41,108 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;108;108;108;109;111;114;109;108;108 22:29:41 INFO - 2015-12-03 22:29:41,108 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;163;154;126;151;126;160;146;124 22:29:41 INFO - 2015-12-03 22:29:41,108 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;163;160;162;162;162;162;162;162 22:29:41 INFO - 2015-12-03 22:29:41,108 DEBUG : BROWSER_OUTPUT: |3;audio-fft;83;76;81;121;65;69;69;71;117;64 22:29:41 INFO - 2015-12-03 22:29:41,109 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;98;136;88;89;88;128;88;88;131 22:29:41 INFO - 2015-12-03 22:29:41,110 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;123;115;120;121;124;113;116;119;114;124 22:29:41 INFO - 2015-12-03 22:29:41,110 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;124;125;124;125;126;123;124;124;123 22:29:41 INFO - 2015-12-03 22:29:41,110 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;102;101;100;99;101;104;101;99;102 22:29:41 INFO - 2015-12-03 22:29:41,110 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;61;62;61;62;63;63;72;58;56 22:29:41 INFO - 2015-12-03 22:29:41,110 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;66;67;66;67;68;69;67;67 22:29:41 INFO - 2015-12-03 22:29:41,110 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;81;82;81;81;82;82;82;86 22:29:41 INFO - 2015-12-03 22:29:41,110 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;121;116;115;117;128;119;118;119;123 22:29:41 INFO - 2015-12-03 22:29:41,111 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;143;133;146;142;144;146;144;142;149 22:29:41 INFO - 2015-12-03 22:29:41,111 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;67;67;69;67;68;70;69;67 22:29:41 INFO - 2015-12-03 22:29:41,111 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:29:41 INFO - 2015-12-03 22:29:41,111 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:29:41 INFO - 2015-12-03 22:29:41,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 22:29:41 INFO - 2015-12-03 22:29:41,111 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:29:41 INFO - 2015-12-03 22:29:41,111 DEBUG : BROWSER_OUTPUT: __startTimestamp1449210581106__endTimestamp 22:29:41 INFO - 2015-12-03 22:29:41,112 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,112 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:29:41 INFO - 2015-12-03 22:29:41,112 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:29:41 INFO - 2015-12-03 22:29:41,114 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,114 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:108.50 stddev:1.97 (1.8%) stddev-sans-first:2.05 22:29:41 INFO - 2015-12-03 22:29:41,114 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 108.0 108.0 109.0 111.0 114.0 109.0 108.0 108.0 22:29:41 INFO - 2015-12-03 22:29:41,114 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,114 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:152.50 stddev:15.48 (10.2%) stddev-sans-first:15.75 22:29:41 INFO - 2015-12-03 22:29:41,114 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 163.0 154.0 126.0 151.0 126.0 160.0 146.0 124.0 22:29:41 INFO - 2015-12-03 22:29:41,115 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,115 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 22:29:41 INFO - 2015-12-03 22:29:41,115 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 163.0 160.0 162.0 162.0 162.0 162.0 162.0 162.0 22:29:41 INFO - 2015-12-03 22:29:41,115 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,115 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:70.00 stddev:20.69 (29.6%) stddev-sans-first:21.94 22:29:41 INFO - 2015-12-03 22:29:41,115 DEBUG : BROWSER_OUTPUT: Values: 83.0 76.0 81.0 121.0 65.0 69.0 69.0 71.0 117.0 64.0 22:29:41 INFO - 2015-12-03 22:29:41,116 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,116 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:88.00 stddev:20.09 (22.8%) stddev-sans-first:21.25 22:29:41 INFO - 2015-12-03 22:29:41,116 DEBUG : BROWSER_OUTPUT: Values: 99.0 98.0 136.0 88.0 89.0 88.0 128.0 88.0 88.0 131.0 22:29:41 INFO - 2015-12-03 22:29:41,116 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,116 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:120.50 stddev:4.18 (3.5%) stddev-sans-first:4.16 22:29:41 INFO - 2015-12-03 22:29:41,116 DEBUG : BROWSER_OUTPUT: Values: 123.0 115.0 120.0 121.0 124.0 113.0 116.0 119.0 114.0 124.0 22:29:41 INFO - 2015-12-03 22:29:41,117 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,117 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.20 Median:124.00 stddev:0.92 (0.7%) stddev-sans-first:0.97 22:29:41 INFO - 2015-12-03 22:29:41,117 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 125.0 124.0 125.0 126.0 123.0 124.0 124.0 123.0 22:29:41 INFO - 2015-12-03 22:29:41,117 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,117 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:101.00 Median:102.00 stddev:1.49 (1.5%) stddev-sans-first:1.58 22:29:41 INFO - 2015-12-03 22:29:41,117 DEBUG : BROWSER_OUTPUT: Values: 101.0 102.0 101.0 100.0 99.0 101.0 104.0 101.0 99.0 102.0 22:29:41 INFO - 2015-12-03 22:29:41,117 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,117 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.40 Median:62.00 stddev:4.58 (7.4%) stddev-sans-first:4.42 22:29:41 INFO - 2015-12-03 22:29:41,118 DEBUG : BROWSER_OUTPUT: Values: 56.0 61.0 62.0 61.0 62.0 63.0 63.0 72.0 58.0 56.0 22:29:41 INFO - 2015-12-03 22:29:41,118 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,118 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 22:29:41 INFO - 2015-12-03 22:29:41,118 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 67.0 66.0 67.0 68.0 69.0 67.0 67.0 22:29:41 INFO - 2015-12-03 22:29:41,118 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,118 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.62 (2.0%) stddev-sans-first:1.66 22:29:41 INFO - 2015-12-03 22:29:41,118 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 81.0 82.0 81.0 81.0 82.0 82.0 82.0 86.0 22:29:41 INFO - 2015-12-03 22:29:41,118 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.50 stddev:3.78 (3.2%) stddev-sans-first:4.00 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: Values: 120.0 121.0 116.0 115.0 117.0 128.0 119.0 118.0 119.0 123.0 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:144.00 stddev:4.18 (2.9%) stddev-sans-first:4.44 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: Values: 143.0 143.0 133.0 146.0 142.0 144.0 146.0 144.0 142.0 149.0 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 67.0 69.0 67.0 68.0 70.0 69.0 67.0 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:29:41 INFO - 2015-12-03 22:29:41,119 DEBUG : BROWSER_OUTPUT: 22:29:41 INFO - 2015-12-03 22:29:41,690 INFO : Browser exited with error code: 0 22:29:41 INFO - 2015-12-03 22:29:41,739 INFO : Completed test kraken (00:00:56) 22:29:41 INFO - 2015-12-03 22:29:41,739 INFO : Starting test v8_7 22:29:41 INFO - 2015-12-03 22:29:41,739 DEBUG : operating with platform_type : mac_ 22:29:41 INFO - 2015-12-03 22:29:41,740 INFO : Initialising browser for v8_7 test... 22:29:41 INFO - 2015-12-03 22:29:41,752 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/tmpjhsWg1/profile http://localhost:56312/getInfo.html 22:29:43 INFO - 2015-12-03 22:29:43,812 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:29:43 INFO - 2015-12-03 22:29:43,812 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:29:43 INFO - 2015-12-03 22:29:43,812 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:29:43 INFO - 2015-12-03 22:29:43,812 DEBUG : BROWSER_OUTPUT: __metrics 22:29:43 INFO - 2015-12-03 22:29:43,827 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:29:44 INFO - 2015-12-03 22:29:44,421 INFO : Browser initialized. 22:29:44 INFO - 2015-12-03 22:29:44,421 INFO : Running cycle 1/1 for v8_7 test... 22:29:44 INFO - 2015-12-03 22:29:44,421 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/T/tmpjhsWg1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:29:56 INFO - 2015-12-03 22:29:56,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 198643712 22:29:56 INFO - 2015-12-03 22:29:56,226 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56312/tests/v8_7/run.html (next: http://localhost:56312/tests/v8_7/run.html) 22:30:17 INFO - 2015-12-03 22:30:17,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 524468224 22:30:17 INFO - 2015-12-03 22:30:17,874 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,874 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:30:17 INFO - 2015-12-03 22:30:17,874 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:30:17 INFO - 2015-12-03 22:30:17,874 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:30:17 INFO - 2015-12-03 22:30:17,875 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:30:17 INFO - 2015-12-03 22:30:17,875 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 22:30:17 INFO - 2015-12-03 22:30:17,875 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.79133103183736 22:30:17 INFO - 2015-12-03 22:30:17,875 DEBUG : BROWSER_OUTPUT: |2;Encrypt;326.47730982696703 22:30:17 INFO - 2015-12-03 22:30:17,875 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5731.428571428572 22:30:17 INFO - 2015-12-03 22:30:17,875 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1003.0090270812437 22:30:17 INFO - 2015-12-03 22:30:17,875 DEBUG : BROWSER_OUTPUT: |5;Earley;675.219446320054 22:30:17 INFO - 2015-12-03 22:30:17,876 DEBUG : BROWSER_OUTPUT: |6;Boyer;12500 22:30:17 INFO - 2015-12-03 22:30:17,876 DEBUG : BROWSER_OUTPUT: |7;RegExp;29676.470588235294 22:30:17 INFO - 2015-12-03 22:30:17,876 DEBUG : BROWSER_OUTPUT: |8;Splay;604.2296072507553 22:30:17 INFO - 2015-12-03 22:30:17,876 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 22:30:17 INFO - 2015-12-03 22:30:17,876 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:30:17 INFO - 2015-12-03 22:30:17,876 DEBUG : BROWSER_OUTPUT: __startTimestamp1449210617873__endTimestamp 22:30:17 INFO - 2015-12-03 22:30:17,876 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,877 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:30:17 INFO - 2015-12-03 22:30:17,877 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:30:17 INFO - 2015-12-03 22:30:17,877 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,877 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,877 DEBUG : BROWSER_OUTPUT: Values: 166.0 22:30:17 INFO - 2015-12-03 22:30:17,878 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,878 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.79 Median:191.79 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,878 DEBUG : BROWSER_OUTPUT: Values: 191.8 22:30:17 INFO - 2015-12-03 22:30:17,878 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,878 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:326.48 Median:326.48 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: Values: 326.5 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5731.43 Median:5731.43 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: Values: 5731.4 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1003.01 Median:1003.01 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: Values: 1003.0 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:675.22 Median:675.22 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: Values: 675.2 22:30:17 INFO - 2015-12-03 22:30:17,880 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: Values: 12500.0 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29676.47 Median:29676.47 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: Values: 29676.5 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.23 Median:604.23 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: Values: 604.2 22:30:17 INFO - 2015-12-03 22:30:17,881 DEBUG : BROWSER_OUTPUT: 22:30:17 INFO - 2015-12-03 22:30:17,882 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 22:30:17 INFO - 2015-12-03 22:30:17,882 DEBUG : BROWSER_OUTPUT: Values: 5803.5 22:30:17 INFO - 2015-12-03 22:30:17,882 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:30:17 INFO - 2015-12-03 22:30:17,882 DEBUG : BROWSER_OUTPUT: 22:30:18 INFO - 2015-12-03 22:30:18,470 INFO : Browser exited with error code: 0 22:30:18 INFO - 2015-12-03 22:30:18,490 INFO : Completed test v8_7 (00:00:36) 22:30:18 INFO - 2015-12-03 22:30:18,575 INFO : Completed test suite (00:20:07) 22:30:18 INFO - 2015-12-03 22:30:18,575 DEBUG : Working with test: dromaeo_css 22:30:18 INFO - 2015-12-03 22:30:18,575 DEBUG : Generating results file: dromaeo_css 22:30:18 INFO - 2015-12-03 22:30:18,576 DEBUG : Working with test: kraken 22:30:18 INFO - 2015-12-03 22:30:18,576 DEBUG : Generating results file: kraken 22:30:18 INFO - 2015-12-03 22:30:18,576 INFO : javascript benchmark 22:30:18 INFO - 2015-12-03 22:30:18,577 DEBUG : Working with test: v8_7 22:30:18 INFO - 2015-12-03 22:30:18,577 DEBUG : Generating results file: v8_7 22:30:18 INFO - 2015-12-03 22:30:18,577 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:30:18 INFO - 2015-12-03 22:30:18,781 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 22:30:18 INFO - 2015-12-03 22:30:18,781 DEBUG : process_Request line: dromaeo_css 6865.93 graph.html#tests=[[72,52,55]] 22:30:18 INFO - 2015-12-03 22:30:18,781 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:30:18 INFO - 2015-12-03 22:30:18,898 DEBUG : process_Request line: kraken 1484.80 graph.html#tests=[[232,52,55]] 22:30:18 INFO - 2015-12-03 22:30:18,898 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:30:19 INFO - 2015-12-03 22:30:19,014 DEBUG : process_Request line: v8_7 20309.66 graph.html#tests=[[230,52,55]] 22:30:19 INFO - 2015-12-03 22:30:19,015 INFO : javascript benchmark 22:30:19 INFO - 2015-12-03 22:30:19,017 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [342.5683638615344, 348.5834427858709, 348.78201124297317, 356.0, 359.062845972013, 14491.927540362283, 14625.414983400651, 17239.913800430997, 17980.910095449522, 19083.045847707628, 15858.682826343465, 16896.746548801748, 18583.90708046461, 18917.62164756704, 19135.138918748657, 5291.153415453528, 5321.707306098163, 5402.91895621566, 5437.619366644337, 5442.700651464168, 4042.555318914917, 4152.439420678215, 5395.190721391803, 5440.836774896739, 5498.780048798043, 5581.553475721932, 5771.0, 5819.9418005819825, 5882.794102206423, 5887.941120588804, 5515.283013208297, 5815.709214539277, 5960.135780311853, 5972.25346831646, 6007.3992600739575, 5154.226865970097, 5157.303763991888, 5160.638755287131, 5168.715720635363, 5232.476752324776, 21660.133594656196, 21831.45421364463, 21951.451213719785, 22126.668099978513, 22179.44551386212, 1979.9406017819488, 2044.4173410577914, 2096.1824888293427, 2179.8038176564187, 2201.9449513762124, 13079.084464087518, 13576.59270221895, 13670.316484175752, 13875.098118622258, 13889.166650001032, 1649.818519962803, 1672.5985763416813, 1690.6027083635336, 1741.9983509481972, 1747.6067884725962, 60568.69715651393, 62896.0, 63550.0, 65076.3492365075, 65100.3489965099, 9540.759701238794, 9990.600375985025, 10014.39913605186, 10015.499225038719, 10048.045435683598, 12176.756464870654, 12237.69405764863, 12362.3818809061, 12372.07209459294, 12405.62783116508, 7998.600069996477, 8043.075046369625, 8109.026916770025, 8226.547539885363, 8258.091609922903, 8144.592770361458, 8193.672253109928, 8200.958995204986, 8209.671613135528, 8219.753407397788, 5859.2090067841145, 5923.4076592340425, 5929.495992840571, 5933.554983376178, 5956.315023772235, 1583.7307657698218, 1648.2170968789728, 1663.6340005198838, 1682.6129990102345, 1688.7044767165696, 933.6300069873615, 958.4872093429982, 972.601233494264, 1023.5036007536339, 1030.5980667539666, 17842.553936151442, 18534.53663658392, 19569.315073972626, 19647.705284420746, 19918.800811991983, 876.9429987050821, 910.3036177324352, 1018.556927736437, 1031.9535620897077, 1047.4605578127118, 9918.80162396748, 10235.181185505142, 10241.897581024243, 10264.486775661187, 10420.06219440254, 537035.0, 545898.0, 549119.0, 558783.0, 563674.0, 76733.61633191798, 77092.0, 77252.0, 77391.22608773953, 77772.61113694395, 1090.6782499162607, 1092.448313601642, 1093.6554985179484, 1093.9726506837392, 1098.906592939609, 15977.680446390774, 16544.50366489007, 16608.501744947673, 16629.83370166283, 16665.3333866644, 35884.10289742673, 36065.0, 36206.27587448289, 36247.81876090708, 36804.631953680124, 50515.49484505255, 50725.23912141395, 50730.74634626803, 51141.48858511367, 51508.227376588635, 9205.125513076247, 9442.197413219954, 9500.572474238537, 9540.0, 9612.18296444782, 18573.628527429646, 18731.625367492845, 19033.524161896064, 19134.23463061462, 19167.04164791727, 14697.485588004369, 14772.261386930395, 15106.54680359591, 15433.84566154324, 15467.0, 9993.0, 10285.382877027403, 14409.351579179172, 14588.562343129299, 14689.0, 9075.500847453453, 9208.171264586219, 9556.0, 10282.126019288444, 10664.84002739975, 5765.423457654201, 6297.52768542352, 6304.5586808922935, 6383.776567820104, 6385.393387628168, 10558.366498010144, 10645.8935410648, 10650.094741946712, 10699.89300106989, 10824.0], "dojo.html": [3118.0489950565075, 3178.07835727639, 3179.952300715488, 3180.729637980772, 3212.742980561555, 5162.5611822995, 5172.09488339541, 5181.041507321148, 5235.6596821206695, 5288.418273989862, 5193.350831146106, 5197.220416937461, 5216.8695782605455, 5274.367075950891, 5308.416074231832, 4765.166095933215, 4780.1873681474235, 4817.542333478314, 4835.999999999991, 4945.851624451254, 4779.115863565235, 4866.756662166895, 4880.072786170634, 4888.266759986012, 4893.8531844044555, 4848.054629347279, 4870.415550133989, 4885.780139893714, 4940.0, 4941.925871111936, 4871.683340582851, 4882.584980276681, 4904.43598986114, 4906.215005599087, 4914.459409464956, 4693.9530604693855, 4719.9292010619865, 4769.308450274691, 4818.445878723956, 4827.58965487934, 5146.6911985281, 5150.742462876879, 5164.793408263665, 5227.843164705065, 5232.058229518685, 5565.5825813063775, 5593.74828132735, 5595.468430499137, 5616.66300022, 5621.016322143609, 5380.78476860929, 5611.523020543259, 5641.294838145232, 5744.626599271034, 5782.624129431573, 5309.787608495617, 5311.707856067954, 5317.069512835238, 5336.573074154058, 5346.091164502044, 5588.3573389060775, 5800.1589769484035, 5821.18503409523, 5849.005669036189, 5881.617694849907, 5425.186222066722, 5467.753951072212, 5474.91787623186, 5516.806911758069, 5539.944600554023, 5733.598648094593, 5764.048931926269, 5764.510016648548, 5771.278590176228, 5854.677992710442, 5366.382865970385, 5641.351244606841, 5646.463585959327, 5662.122371032497, 5664.6034777566, 5414.160805075219, 5448.482394172547, 5502.5597952163735, 5539.0, 5558.916616250759, 4302.9569704303185, 4339.1972485090355, 4343.869683909487, 4348.717333373321, 4397.824087036547, 3883.5339759229073, 3965.8810235692977, 3983.621555952238, 4022.6580740637373, 4024.537178224483, 5183.377994640668, 5235.764390602432, 5247.816326428557, 5263.973680131575, 5290.074237008585, 5710.914336284959, 5722.198892155018, 5736.741846616912, 5751.683657398799, 5842.941570584325, 5064.164412871834, 5142.254373115878, 5276.973615131899, 5282.630215884851, 5323.653962492503, 4886.60907127429, 4949.876253093701, 4970.925436118461, 4972.627052970969, 4990.351254336913, 5738.426157384228, 5809.0, 5818.854528636818, 5829.5336373090895, 5833.241678581927, 5504.201890725903, 5557.555395568425, 5769.8557536061935, 5788.53691704671, 5813.186153938367, 5455.399906010256, 5678.14827775837, 5771.134329850556, 5775.566832487496, 5814.970925145516, 5610.719464026701, 5615.522680572197, 5619.381867994435, 5643.943560564342, 5679.5172410345585, 5361.705106219196, 5449.972750136224, 5692.914606280992, 5729.739457319383, 5764.279465066867, 5394.487523685244, 5399.109146990702, 5445.074337362578, 5445.992491389105, 5456.345238571397, 5561.082421400423, 5576.10782274834, 5584.0, 5585.441455854382, 5613.971930140323, 5298.894022119459, 5410.0, 5521.641093328921, 5537.1140617501005, 5588.524975377139, 5377.623566350474, 5584.944150558443, 5610.372015878729, 5623.971880140573, 5694.601377903507, 5474.945250547444, 5477.068898287381, 5481.123020316731, 5532.197831314517, 5556.888862222814], "mootools.html": [917.6421195733661, 1748.9125543722814, 1776.4226626346438, 1784.2862854858056, 1794.6051868588906, 6749.426298764604, 7418.22108678589, 7551.811204719885, 7557.546547207165, 7577.734779282726, 7194.316539928712, 7409.777706668809, 7488.812779680497, 7489.0, 7494.362979146766, 2163.2320526213166, 2166.6100101981638, 2168.29530402619, 2186.6173419651577, 2192.7478339990867, 2179.3679832848456, 2207.9668804967937, 2240.1375470443913, 2259.401258666455, 2259.830512711545, 2196.143504033428, 2201.218567408571, 2203.493196564791, 2208.845380823343, 2244.5959727249087, 2191.1345018717516, 2198.8240940724704, 2201.5927053495075, 2204.9889750551224, 2227.4765430123825, 2191.9232826851144, 2208.3595757230382, 2216.5012872103807, 2223.2996606069037, 2223.5108276179217, 6734.865302693918, 6911.205211400653, 7329.120505539316, 7393.70425182992, 7433.070866141732, 4472.843450479218, 4579.29021001742, 4617.3304870793545, 4618.399608050965, 4633.096546173498, 2884.0915111739737, 2976.04766474726, 2987.4025194960877, 3022.6221722284713, 3025.1529571719952, 867.189178118455, 871.538084815049, 874.060385086035, 918.8437965545806, 1490.8434614365444, 9525.857112143323, 9544.188743956773, 9632.0, 9637.0, 9640.807183856283, 3983.0, 4051.918961620751, 4058.5332686740812, 4101.589841015934, 4107.67138628909, 8184.918150818535, 8185.836283274421, 8186.754397368089, 8199.508029518249, 8200.5489698066, 4622.399088118523, 4666.859994200179, 4668.883277918011, 4671.11248862715, 4672.415948006499, 4329.415528903558, 4334.913301733947, 4335.588119128678, 4336.739795612273, 4338.826446942087, 3293.3084052348795, 3294.5058241263523, 3305.86776528941, 3308.553345298402, 3340.298537307193, 972.5623469438781, 977.3158788847835, 978.2125389061873, 992.3153024413132, 996.5814357969671, 1264.797632378815, 1264.9810252846214, 1291.8966482681362, 1292.877176668215, 1311.4098655604826, 6983.6857341418745, 7073.964630176816, 7092.078029856189, 7300.342969132804, 7350.96324518374, 1100.7523307255963, 1113.1984970820995, 1124.3921192694525, 1130.3331034689572, 1152.521703493041, 5369.838904832861, 5716.42835716425, 5723.627964182315, 5736.741846616912, 5776.133579962955, 7921.920780792234, 8567.485950842969, 8707.259882910024, 8779.253763430052, 8798.912010879938, 8629.741107766651, 8666.999999999874, 8667.219950204511, 8724.476531408136, 8732.738017859474, 6785.185777706707, 6950.200726916368, 6962.303769622998, 6971.163460384685, 7043.471739619549, 6766.492513061442, 6873.415759660485, 6895.34494223048, 6925.065116209449, 6946.131733533309, 7688.192739762245, 7842.647080881488, 7846.921530784847, 7871.252231038042, 7875.763727088197, 7963.721269755531, 7986.680532778624, 7990.240927112148, 7991.440599158003, 8059.355251579742, 6388.329225431263, 6742.69657865407, 6757.493188010821, 6768.0863083485065, 6775.322467753185, 7291.526050806893, 7301.780946571611, 7306.488545801955, 7323.963380183065, 7340.449466289942, 6622.768203112868, 6756.054152418567, 6767.154105736783, 6856.451483881177, 6954.3393377629045, 6631.867362652816, 6654.900176497454, 6719.4624430044505, 6737.090492783412, 6777.559458635173, 6816.147981502312, 6819.352161544645, 6853.588784672936, 6873.5875847449315, 6907.758228461979, 6166.167567378347, 6169.84575385619, 6176.4441200292185, 6190.2571691397325, 6216.316205217513, 6300.684965751602, 6336.556441049082, 6374.968125159345, 6378.936210637834, 6437.613743175424], "ext.html": [555.2115995286692, 565.6153815405526, 565.8698499345151, 578.8552861784557, 593.8723174517478, 32245.51631725523, 38300.61699383005, 38772.80613596928, 39035.21929561411, 39289.410658840105, 41947.0, 42139.789301053526, 42170.57829421705, 42179.0, 42356.0, 8355.248027677508, 8403.285720713746, 9071.909280907188, 9165.495897725623, 9201.217896478807, 10696.090832279227, 10913.072388846958, 10953.616623418182, 10967.451627418637, 11048.226624136314, 10670.30643008202, 10775.299605525615, 10784.676459706183, 10806.837897431546, 10816.0, 8497.0, 8654.048054713976, 10690.518926648241, 10713.196510261723, 10721.410322432263, 10587.523561439753, 10648.57405703771, 10697.572097116106, 10734.838977415346, 10756.515956781963, 38831.22337553233, 39215.803920980215, 39287.41068883969, 39399.80300098481, 39405.0, 2811.9578206326923, 2902.3034471726846, 2937.5446805745146, 3389.305192435545, 3518.4194607889667, 27104.45791084187, 27189.86405067982, 27606.861965690245, 28377.858110709316, 28488.0, 2307.6423154410927, 2353.646952957053, 2377.6314671225987, 2388.6297623868327, 2486.875656217182, 271754.0, 272524.0, 274126.0, 274340.0, 274554.0, 57497.42502574921, 58074.12888806671, 60422.69788651117, 60687.69656151691, 60744.69627651922, 58884.7055764727, 59375.10937335943, 59539.70230148908, 59650.403495964485, 60199.39800602025, 15653.217339133225, 15823.604409889846, 15869.920650396674, 15989.840101598835, 16007.359705611645, 12327.445264963098, 12347.876521234673, 12358.938205308916, 12410.379481025913, 12443.315617640936, 19952.0, 20328.390148295573, 20559.794402055788, 20576.691349629768, 20614.793852061586, 8468.661253549912, 8670.47977121362, 8723.432976856484, 8775.341849361323, 8804.031556528776, 1027.799579082072, 1027.917766578672, 1029.5006921642996, 1047.6490375724218, 1084.0731174845394, 27350.589741153897, 27549.31126721808, 27694.307642309104, 27787.861060694566, 27862.5820612691, 934.5700977550267, 968.4237878462303, 1048.1719441641171, 1153.3022521374448, 1161.8838116188483, 10812.390704494752, 13732.725345493034, 14200.360983755756, 14361.890864022376, 14503.057301275383, 385348.0, 390930.0, 391692.0, 392303.0, 393537.0, 51737.22394164091, 52652.0, 52717.209241861405, 53297.2005419919, 58695.0, 1415.9929200353931, 1430.885529157665, 1445.515752222996, 1456.6139972906976, 1457.9635509111934, 27674.44651107007, 27934.580981285704, 28902.710972890003, 29134.27164320909, 29322.413551729274, 44759.55240447684, 45655.08689826251, 50237.74881125571, 51006.48993510166, 51105.488945110075, 289819.0, 293732.0, 295223.0, 300280.0, 300413.0, 39045.0, 39069.0, 39249.0, 40283.59716402798, 40434.595654043085, 42444.36333454939, 42450.78774606107, 43231.567684324014, 43521.0, 43538.782306088266, 34498.82750586231, 35729.46405803863, 36126.27747444984, 36872.07819804419, 37471.81264093662, 34609.13477163091, 35143.0, 35243.647563524035, 35452.29095418129, 35465.0, 35952.0, 36531.81734091313, 36871.26257474889, 37842.43236351512, 38179.61820381872, 29278.853605731834, 31158.844205778827, 31247.0, 31483.370332593677, 31603.0, 23910.52178956446, 24173.2525508939, 24182.153624623053, 24202.75797242005, 24318.75681243165], "prototype.html": [328.39575181665737, 330.9420851351014, 331.09445666103204, 333.25517468457997, 338.0197427460366, 5820.330661973874, 5958.433948774859, 5974.79088231912, 5983.6409815411, 6110.816675499736, 5781.219535362725, 5896.557758168144, 5955.136505206753, 5965.761369545213, 5998.190244317016, 4558.9544104558945, 4580.679352445331, 4588.059447813191, 4592.5177856324935, 4601.539846015406, 4404.757738324391, 4505.954940450602, 4549.090181963604, 4585.3122031695175, 4609.44686637604, 4540.091981603692, 4556.088782243548, 4557.908841823161, 4569.93145102822, 4577.382053422795, 4559.589636932692, 4561.954380456186, 4564.406627138467, 4574.5882870541645, 4595.264757638795, 3963.920721585581, 3976.304146774303, 3977.025628720953, 3980.263651224504, 3986.5415477219913, 5652.9152062719095, 5760.164776107441, 5789.681567513785, 5791.0734282514595, 5848.736806843703, 5098.719570423626, 5103.770330335144, 5117.974410127926, 5118.59051275897, 5177.223416487519, 6074.696265186723, 6172.722227499728, 6201.0388389799655, 6257.186565746424, 6296.1500197473215, 4058.208649313385, 4175.707700460969, 4216.64158546524, 4245.21463529245, 4255.5744425557505, 6367.61794292344, 6480.416762491398, 6480.643564603898, 6512.088307636935, 6513.381228783258, 4285.0, 4295.699301048897, 4300.0, 4307.483102027777, 4347.0871117065135, 4164.06308580573, 4293.463317085364, 4362.8036738346855, 4366.847160349373, 4403.207422663887, 4996.150654388763, 5021.59827213822, 5026.497350265017, 5048.8232911848645, 5053.267276244997, 6194.81415557534, 6217.316095229521, 6233.594816336924, 6275.435210831047, 6281.748730050838, 1576.6688995310883, 1592.800899887514, 1597.9280932358072, 1599.1604407685825, 1599.9760003599956, 1013.022433351819, 1030.4744580264119, 1044.6604853422668, 1046.9528871200662, 1051.952662130206, 5964.224650795456, 5985.431384018511, 6012.158297838306, 6032.065029920369, 6092.360302168208, 6579.4736421087155, 6580.736770529221, 6630.602163870183, 6647.567908085959, 6675.0988616537115, 5979.641221526722, 6017.247844019497, 6035.637861728311, 6066.3630318815885, 6081.209442772411, 3553.0406790167026, 3615.783053016775, 3622.5109610202285, 3635.4910312556262, 3661.0664280608275, 6606.075149479077, 6608.107905432801, 6642.767503137464, 6680.498962577826, 6692.3976842083475, 6694.196696396463, 6709.228438729511, 6743.0, 6766.052752614638, 6772.93227067723, 6365.490760739222, 6590.670466476561, 6627.834304142339, 6668.166479190101, 6774.627395493295, 6353.809385718436, 6482.578632389068, 6596.868062638624, 6648.335166483313, 6657.833554161185, 6391.616503009835, 6402.231732192166, 6412.935870641234, 6468.062130991074, 6496.220453545605, 6620.966895165493, 6648.235452922782, 6671.066050752996, 6680.9331906682255, 6688.197416310074, 4216.599423054805, 4301.5483374246505, 4352.717073390219, 4375.124975004948, 4402.3176407656865, 6488.708008139551, 6532.5753826001155, 6533.738650453929, 6540.672966351568, 6541.967290163519, 6215.875682486235, 6307.810765677037, 6324.525660575383, 6354.3963323484195, 6363.61818290904, 6169.0, 6314.179156709598, 6321.778737744157, 6330.968345158245, 6397.200349956255, 6141.263048434216, 6190.597611155261, 6208.0998255253635, 6239.251289845248, 6285.654289013965, 6383.106365108982, 6410.647414392253, 6446.871062578816, 6455.483561315177, 6493.285738568659, 6161.353057929032, 6230.470410015199, 6263.968680156752, 6284.402981716729, 6324.494040476843], "yui.html": [729.4273994913992, 758.9506682065665, 764.7132325377987, 771.6488997506135, 774.7056118674902, 13752.449902003907, 14045.0, 14209.218492982882, 16218.594535136628, 16445.91777041116, 14448.277586120677, 14887.851121488782, 14895.7020859583, 14913.32890019949, 15078.924605376986, 709.0427922304899, 710.3393843725333, 878.3149143667933, 881.9294456443469, 892.0410558649445, 854.1543871567135, 860.5396113079504, 864.1358641358642, 866.7139843851545, 876.8158686675806, 892.1034360467721, 896.1083721696888, 896.668232753882, 898.2095755734977, 907.3784457646533, 721.7113154738121, 727.8216836874999, 900.0864122915247, 903.3134817538652, 910.899801021887, 666.0641798273433, 667.4893706314673, 668.3283300283233, 672.865426914619, 675.1998881325645, 14003.299835008209, 14044.92977535116, 14059.718805623932, 14101.85898141026, 14192.716145677132, 9494.145526902543, 9699.951500242454, 9735.610575576968, 9920.35517691355, 10134.847977280348, 9035.819283614357, 9128.908710912872, 9394.06059394062, 9673.951630241874, 9993.050660187271, 2876.4822331980236, 2936.2365784896083, 2960.9407811843857, 3029.909102726922, 3112.95715935162, 47915.76042119767, 48144.518554814706, 48532.0, 48713.99999999964, 48914.51085489135, 6816.147981502312, 6886.173659160832, 6903.482238832108, 6996.965015174993, 7126.0, 12326.445309960895, 12337.136400452062, 12351.814722779165, 12377.133600647869, 12429.689257768447, 5886.793962211302, 6019.157317975487, 6323.841903952438, 6355.0, 6567.4417674497245, 3642.2715456908195, 3712.6287371262656, 3725.112395632629, 3752.6622603965775, 3824.8278827452273, 2801.173653772142, 2855.4146399987953, 2860.699626539225, 2873.3391319996517, 2884.3510210202535, 401.1115379434508, 405.49920847753003, 406.9694772892045, 414.64754958285215, 421.2396624093541, 454.72034698660747, 540.3084052412839, 551.9944800552023, 560.8502569732033, 610.795383546508, 7554.508956917783, 7823.765287041398, 7838.0, 8021.759347219593, 8114.148014458515, 453.31323045585964, 485.75226634416, 537.0092179928026, 574.4112284907919, 594.3848117198766, 3699.1491956850077, 3798.2783271178387, 3838.2323535293053, 3905.5703872573995, 4008.378701301303, 58150.0, 61097.08354374688, 61537.69231153816, 61936.0, 62036.379636203965, 49460.0, 51247.48752512427, 51380.48619513832, 51476.48523514792, 51649.48350516522, 50408.74795626072, 50580.0, 50610.49389506058, 50649.240261395375, 51679.74160129175, 7619.657115429708, 7730.652120654471, 7997.720079797412, 8065.233802788725, 8189.590520474072, 33845.153871153416, 35008.29983400369, 36266.27467450689, 37151.81424092862, 37584.43623345707, 46250.53749462597, 50330.748346258035, 50635.74682126566, 50679.74660126676, 50905.490945090074, 7725.227477252454, 7855.84288314242, 7888.684452621831, 7928.682852686059, 7939.364850811806, 11147.832782508107, 11251.324920504796, 11321.830172547583, 11390.088792896715, 11653.30080195191, 10268.07587317145, 10405.58377664885, 10548.736281593021, 10680.83978740335, 10696.358218506915, 9717.12545870875, 9778.65774697882, 10315.742106447398, 10337.638182663572, 10554.841677374692, 10080.445575493419, 10267.127294180078, 10342.0, 10440.53017614194, 10519.94740026295, 9036.819263614823, 9174.495402752913, 9210.723678289662, 9290.442573445614, 9533.142017218484, 8883.777905552413, 8884.422512536665, 9018.503982281038, 9078.409903356262, 9124.589393477178]}, "summary": {"suite": 6865.933404385999, "subtests": {"jquery.html": {"filtered": 8909.655594304735, "value": 8909.655594304735}, "dojo.html": {"filtered": 5214.079502904245, "value": 5214.079502904245}, "mootools.html": {"filtered": 4317.9137342038375, "value": 4317.9137342038375}, "ext.html": {"filtered": 18861.20081764994, "value": 18861.20081764994}, "prototype.html": {"filtered": 4730.2789569473725, "value": 4730.2789569473725}, "yui.html": {"filtered": 5853.111276753215, "value": 5853.111276753215}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0035"}, "testrun": {"date": 1449209411, "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": "20151203200703", "branch": "Mozilla-Aurora", "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 163.0, 160.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0], "ai-astar": [108.0, 108.0, 108.0, 108.0, 109.0, 111.0, 114.0, 109.0, 108.0, 108.0], "imaging-gaussian-blur": [123.0, 115.0, 120.0, 121.0, 124.0, 113.0, 116.0, 119.0, 114.0, 124.0], "audio-beat-detection": [156.0, 130.0, 163.0, 154.0, 126.0, 151.0, 126.0, 160.0, 146.0, 124.0], "json-stringify-tinderbox": [66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 68.0, 69.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [143.0, 143.0, 133.0, 146.0, 142.0, 144.0, 146.0, 144.0, 142.0, 149.0], "json-parse-financial": [56.0, 61.0, 62.0, 61.0, 62.0, 63.0, 63.0, 72.0, 58.0, 56.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 67.0, 67.0, 69.0, 67.0, 68.0, 70.0, 69.0, 67.0], "audio-fft": [83.0, 76.0, 81.0, 121.0, 65.0, 69.0, 69.0, 71.0, 117.0, 64.0], "imaging-darkroom": [124.0, 124.0, 125.0, 124.0, 125.0, 126.0, 123.0, 124.0, 124.0, 123.0], "stanford-crypto-ccm": [120.0, 121.0, 116.0, 115.0, 117.0, 128.0, 119.0, 118.0, 119.0, 123.0], "audio-oscillator": [99.0, 98.0, 136.0, 88.0, 89.0, 88.0, 128.0, 88.0, 88.0, 131.0], "stanford-crypto-aes": [81.0, 84.0, 81.0, 82.0, 81.0, 81.0, 82.0, 82.0, 82.0, 86.0], "imaging-desaturate": [101.0, 102.0, 101.0, 100.0, 99.0, 101.0, 104.0, 101.0, 99.0, 102.0]}, "summary": {"suite": 1484.8000000000002, "subtests": {"audio-fft": {"filtered": 81.6, "value": 81.6}, "stanford-crypto-pbkdf2": {"filtered": 143.2, "value": 143.2}, "audio-beat-detection": {"filtered": 143.6, "value": 143.6}, "stanford-crypto-ccm": {"filtered": 119.6, "value": 119.6}, "imaging-darkroom": {"filtered": 124.2, "value": 124.2}, "json-parse-financial": {"filtered": 61.4, "value": 61.4}, "audio-oscillator": {"filtered": 103.3, "value": 103.3}, "ai-astar": {"filtered": 109.1, "value": 109.1}, "audio-dft": {"filtered": 161.8, "value": 161.8}, "stanford-crypto-sha256-iterative": {"filtered": 67.9, "value": 67.9}, "json-stringify-tinderbox": {"filtered": 67.0, "value": 67.0}, "imaging-gaussian-blur": {"filtered": 118.9, "value": 118.9}, "stanford-crypto-aes": {"filtered": 82.2, "value": 82.2}, "imaging-desaturate": {"filtered": 101.0, "value": 101.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0035"}, "testrun": {"date": 1449209411, "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": "20151203200703", "branch": "Mozilla-Aurora", "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.79133103183736], "Encrypt": [326.47730982696703], "NavierStokes": [5803.468208092486], "Decrypt": [5731.428571428572], "Splay": [604.2296072507553], "Richards": [165.97510373443984], "RegExp": [29676.470588235294], "Earley": [675.219446320054], "Boyer": [12500.0], "RayTrace": [1003.0090270812437]}, "summary": {"suite": 20309.66498149454, "subtests": {"DeltaBlue": {"filtered": 344.73925199999996, "value": 344.73925199999996}, "Encrypt": {"filtered": 815.3124030000001, "value": 815.3124030000001}, "NavierStokes": {"filtered": 255.70916334661337, "value": 255.70916334661337}, "Decrypt": {"filtered": 46.44234795613162, "value": 46.44234795613162}, "Splay": {"filtered": 134.86760500000003, "value": 134.86760500000003}, "RegExp": {"filtered": 30.697215064420206, "value": 30.697215064420206}, "Richards": {"filtered": 212.69455, "value": 212.69455}, "Earley": {"filtered": 987.0317029999998, "value": 987.0317029999998}, "Boyer": {"filtered": 53.31704, "value": 53.31704}, "RayTrace": {"filtered": 737.7690329999998, "value": 737.7690329999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0035"}, "testrun": {"date": 1449209411, "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": "20151203200703", "branch": "Mozilla-Aurora", "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0"}}] 22:30:19 INFO - RETURN: dromaeo_css: 6865.93 22:30:19 INFO - RETURN: kraken: 1484.80 22:30:19 INFO - RETURN: v8_7: 20309.66 22:30:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20309.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1484.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6865.93"}}} 22:30:19 INFO - Return code: 0 22:30:19 INFO - # TBPL SUCCESS # 22:30:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:30:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:30:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:30:19 INFO - 2015-12-03 22:30:19.116 screenresolution[6010:116511] starting screenresolution argv=screenresolution get 22:30:19 INFO - 2015-12-03 22:30:19.119 screenresolution[6010:116511] Display 0: 1600x1200x32@60 22:30:19 INFO - 2015-12-03 22:30:19.125 screenresolution[6011:116515] starting screenresolution argv=screenresolution list 22:30:19 INFO - Available Modes on Display 0 22:30:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:30:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:30:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:30:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:30:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:30:19 INFO - Intel HD Graphics 3000: 22:30:19 INFO - Chipset Model: Intel HD Graphics 3000 22:30:19 INFO - Type: GPU 22:30:19 INFO - Bus: Built-In 22:30:19 INFO - VRAM (Total): 512 MB 22:30:19 INFO - VRAM (Dynamic, Max): 10 22:30:19 INFO - Vendor: Intel (0x8086) 22:30:19 INFO - Device ID: 0x0116 22:30:19 INFO - Revision ID: 0x0009 22:30:19 INFO - Displays: 22:30:19 INFO - Display: 22:30:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:30:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:30:19 INFO - Display Serial Number: 1600x1200 60 22:30:19 INFO - Main Display: Yes 22:30:19 INFO - Mirror: Off 22:30:19 INFO - Online: Yes 22:30:19 INFO - Rotation: Supported 22:30:19 INFO - Return code: 0 22:30:19 INFO - Running post-action listener: _resource_record_post_action 22:30:19 INFO - Running post-run listener: _resource_record_post_run 22:30:20 INFO - Total resource usage - Wall time: 1245s; CPU: 30.0%; Read bytes: 1693696; Write bytes: 684097536; Read time: 559; Write time: 51709 22:30:20 INFO - install - Wall time: 37s; CPU: 30.0%; Read bytes: 336528384; Write bytes: 336381952; Read time: 31775; Write time: 5210 22:30:20 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 1693184; Write bytes: 336607232; Read time: 538; Write time: 45067 22:30:20 INFO - Running post-run listener: _upload_blobber_files 22:30:20 INFO - Blob upload gear active. 22:30:20 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:30:20 INFO - Copying logs to upload dir... 22:30:20 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1292.575876 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2015-12-03 22:30:20.532956) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 22:30:20.536484) ========= 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.aWZHcYO11K/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.8JFkAt1G6s/Listeners TMPDIR=/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009527 build_url: 'https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 22:30:20.556936) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:30:20.557312) ========= 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.aWZHcYO11K/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.8JFkAt1G6s/Listeners TMPDIR=/var/folders/4x/y6f_jmyx3rn09h6fg_qfhnk800000w/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.005117 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:30:20.607014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 22:30:20.607351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 22:30:20.608287) ========= ========= Total master_lag: 0.20 =========