builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0064 starttime: 1446460340.82 results: success (0) buildid: 20151102014533 builduid: da401ff9534443368b63a7123bbef2bc revision: 7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.816462) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.816930) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.817277) ========= 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.mLOqz8ZiVs/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.22cSfvKsig/Listeners TMPDIR=/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/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.005793 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.841836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.842424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.858010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.858492) ========= 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.mLOqz8ZiVs/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.22cSfvKsig/Listeners TMPDIR=/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/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.005516 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.908750) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.909128) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.909586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:20.909897) ========= 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.mLOqz8ZiVs/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.22cSfvKsig/Listeners TMPDIR=/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-02 02:32:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-02 02:32:21 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.347212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:21.273055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:21.273430) ========= 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.mLOqz8ZiVs/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.22cSfvKsig/Listeners TMPDIR=/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/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.020918 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:21.323055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:21.323712) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679 --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 7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mLOqz8ZiVs/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.22cSfvKsig/Listeners TMPDIR=/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-02 02:32:21,409 truncating revision to first 12 chars 2015-11-02 02:32:21,409 Setting DEBUG logging. 2015-11-02 02:32:21,409 attempt 1/10 2015-11-02 02:32:21,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7dae432ad7a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-02 02:32:21,725 unpacking tar archive at: mozilla-aurora-7dae432ad7a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.745523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:22.091338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:22.091676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:22.231239) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:22.231518) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 02:32:22.231965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-02 02:32:22.232296) ========= /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.mLOqz8ZiVs/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.22cSfvKsig/Listeners TMPDIR=/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 02:32:22 INFO - MultiFileLogger online at 20151102 02:32:22 in /builds/slave/test 02:32:22 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 02:32:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:22 INFO - {'append_to_log': False, 02:32:22 INFO - 'base_work_dir': '/builds/slave/test', 02:32:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:32:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:22 INFO - 'branch': 'Mozilla-Aurora', 02:32:22 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:22 INFO - 'config_files': ('talos/mac_config.py',), 02:32:22 INFO - 'default_actions': ('clobber', 02:32:22 INFO - 'read-buildbot-config', 02:32:22 INFO - 'download-and-extract', 02:32:22 INFO - 'populate-webroot', 02:32:22 INFO - 'create-virtualenv', 02:32:22 INFO - 'install', 02:32:22 INFO - 'run-tests'), 02:32:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:22 INFO - 'download_minidump_stackwalk': True, 02:32:22 INFO - 'download_symbols': 'ondemand', 02:32:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:22 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:22 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:22 INFO - 'installer_path': 'installer.exe', 02:32:22 INFO - 'log_level': 'info', 02:32:22 INFO - 'log_name': 'talos', 02:32:22 INFO - 'log_to_console': True, 02:32:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:32:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:32:22 INFO - 'opt_config_files': (), 02:32:22 INFO - 'pip_index': False, 02:32:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:32:22 INFO - 'cmd': ('bash', 02:32:22 INFO - '-c', 02:32:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:32:22 INFO - 'enabled': True, 02:32:22 INFO - 'halt_on_failure': False, 02:32:22 INFO - 'name': 'check_screen_resolution'},), 02:32:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:32:22 INFO - 'cmd': ('bash', 02:32:22 INFO - '-c', 02:32:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:32:22 INFO - 'enabled': True, 02:32:22 INFO - 'halt_on_failure': False, 02:32:22 INFO - 'name': 'check_screen_resolution'},), 02:32:22 INFO - 'run_cmd_checks_enabled': True, 02:32:22 INFO - 'sps_profile': False, 02:32:22 INFO - 'sps_profile_interval': 0, 02:32:22 INFO - 'suite': 'dromaeojs', 02:32:22 INFO - 'system_bits': '64', 02:32:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:22 INFO - 'title': 't-yosemite-r5-0064', 02:32:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:22 INFO - 'use_talos_json': True, 02:32:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:22 INFO - 'work_dir': 'build'} 02:32:22 INFO - ##### 02:32:22 INFO - ##### Running clobber step. 02:32:22 INFO - ##### 02:32:22 INFO - Running pre-action listener: _resource_record_pre_action 02:32:22 INFO - Running main action method: clobber 02:32:22 INFO - rmtree: /builds/slave/test/build 02:32:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:24 INFO - Running post-action listener: _resource_record_post_action 02:32:24 INFO - ##### 02:32:24 INFO - ##### Running read-buildbot-config step. 02:32:24 INFO - ##### 02:32:24 INFO - Running pre-action listener: _resource_record_pre_action 02:32:24 INFO - Running main action method: read_buildbot_config 02:32:24 INFO - Using buildbot properties: 02:32:24 INFO - { 02:32:24 INFO - "properties": { 02:32:24 INFO - "buildnumber": 402, 02:32:24 INFO - "product": "firefox", 02:32:24 INFO - "script_repo_revision": "production", 02:32:24 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:32:24 INFO - "repository": "", 02:32:24 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:32:24 INFO - "buildid": "20151102014533", 02:32:24 INFO - "slavename": "t-yosemite-r5-0064", 02:32:24 INFO - "pgo_build": "False", 02:32:24 INFO - "basedir": "/builds/slave/test", 02:32:24 INFO - "project": "", 02:32:24 INFO - "platform": "yosemite", 02:32:24 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:32:24 INFO - "slavebuilddir": "test", 02:32:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:32:24 INFO - "branch": "mozilla-aurora", 02:32:24 INFO - "repo_path": "releases/mozilla-aurora", 02:32:24 INFO - "stage_platform": "macosx64", 02:32:24 INFO - "builduid": "da401ff9534443368b63a7123bbef2bc", 02:32:24 INFO - "revision": "7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679" 02:32:24 INFO - }, 02:32:24 INFO - "sourcestamp": { 02:32:24 INFO - "repository": "", 02:32:24 INFO - "hasPatch": false, 02:32:24 INFO - "project": "", 02:32:24 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:32:24 INFO - "changes": [ 02:32:24 INFO - { 02:32:24 INFO - "category": null, 02:32:24 INFO - "files": [ 02:32:24 INFO - { 02:32:24 INFO - "url": null, 02:32:24 INFO - "name": "https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:32:24 INFO - } 02:32:24 INFO - ], 02:32:24 INFO - "repository": "", 02:32:24 INFO - "rev": "7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679", 02:32:24 INFO - "who": "cbook@mozilla.com", 02:32:24 INFO - "when": 1446460323, 02:32:24 INFO - "number": 6608322, 02:32:24 INFO - "comments": "Backed out changeset 15acf2adefd0 (bug 1217591) for nearly perma failures on aurora in test_jsterm_autocomplete.html", 02:32:24 INFO - "project": "", 02:32:24 INFO - "at": "Mon 02 Nov 2015 02:32:03", 02:32:24 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:32:24 INFO - "revlink": "", 02:32:24 INFO - "properties": [ 02:32:24 INFO - [ 02:32:24 INFO - "buildid", 02:32:24 INFO - "20151102014533", 02:32:24 INFO - "Change" 02:32:24 INFO - ], 02:32:24 INFO - [ 02:32:24 INFO - "builduid", 02:32:24 INFO - "da401ff9534443368b63a7123bbef2bc", 02:32:24 INFO - "Change" 02:32:24 INFO - ], 02:32:24 INFO - [ 02:32:24 INFO - "pgo_build", 02:32:24 INFO - "False", 02:32:24 INFO - "Change" 02:32:24 INFO - ] 02:32:24 INFO - ], 02:32:24 INFO - "revision": "7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679" 02:32:24 INFO - } 02:32:24 INFO - ], 02:32:24 INFO - "revision": "7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679" 02:32:24 INFO - } 02:32:24 INFO - } 02:32:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:32:24 INFO - Running post-action listener: _resource_record_post_action 02:32:24 INFO - ##### 02:32:24 INFO - ##### Running download-and-extract step. 02:32:24 INFO - ##### 02:32:24 INFO - Running pre-action listener: _resource_record_pre_action 02:32:24 INFO - Running main action method: download_and_extract 02:32:24 INFO - mkdir: /builds/slave/test/build/tests 02:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:24 INFO - https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:32:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/test_packages.json 02:32:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/test_packages.json 02:32:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:32:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:32:25 INFO - Downloaded 1149 bytes. 02:32:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:32:25 INFO - Using the following test package requirements: 02:32:25 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:32:25 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:25 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:32:25 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:25 INFO - u'jsshell-mac.zip'], 02:32:25 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:25 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:32:25 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:32:25 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:25 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:32:25 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:25 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:32:25 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:25 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:32:25 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:32:25 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:32:25 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:32:25 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:25 INFO - https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:32:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/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 02:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/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 02:32:27 INFO - Downloaded 17445304 bytes. 02:32:27 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 02:32:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:32:33 INFO - Return code: 0 02:32:33 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 02:32: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')]} 02:32:33 INFO - https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:32:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/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 02:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/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 02:32:35 INFO - Downloaded 17445304 bytes. 02:32:35 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 02:32:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:32:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:32:41 INFO - Return code: 0 02:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:41 INFO - https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/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 02:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/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 02:32:43 INFO - Downloaded 11131307 bytes. 02:32:43 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 02:32:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:32:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:32:43 INFO - Return code: 0 02:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:43 INFO - https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:32:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:32:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:32:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:32:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/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 02:32:51 INFO - Downloaded 107715882 bytes. 02:32:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:32:51 INFO - mkdir: /builds/slave/test/properties 02:32:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:51 INFO - Contents: 02:32:51 INFO - build_url:https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:32:51 INFO - Running post-action listener: _resource_record_post_action 02:32:51 INFO - Running post-action listener: set_extra_try_arguments 02:32:51 INFO - ##### 02:32:51 INFO - ##### Running populate-webroot step. 02:32:51 INFO - ##### 02:32:51 INFO - Running pre-action listener: _resource_record_pre_action 02:32:51 INFO - Running main action method: populate_webroot 02:32:51 INFO - Guessing talos json url... 02:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:51 INFO - https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/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 02:32:52 INFO - Downloaded 107 bytes. 02:32:52 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:32:52 INFO - Contents: 02:32:52 INFO - 20151102014533 02:32:52 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:52 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7dae432ad7/testing/talos/talos.json 02:32:52 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7dae432ad7/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7dae432ad7/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:32:52 INFO - Downloaded 4264 bytes. 02:32:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:32:52 INFO - '../fennec_ids.txt'], 02:32:52 INFO - 'tests': ['tcheck2']}, 02:32:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:52 INFO - '--tppagecycles', 02:32:52 INFO - '7'], 02:32:52 INFO - 'tests': ['tsvgm']}}, 02:32:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:32:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:32:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:32:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:52 INFO - 'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:52 INFO - 'tests': ['damp', 'tps']}, 02:32:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:52 INFO - 'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['damp', 'tps']}, 02:32:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:32:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:52 INFO - 'other': {'tests': ['a11yr', 02:32:52 INFO - 'ts_paint', 02:32:52 INFO - 'tpaint', 02:32:52 INFO - 'sessionrestore', 02:32:52 INFO - 'sessionrestore_no_auto_restore']}, 02:32:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['a11yr', 02:32:52 INFO - 'ts_paint', 02:32:52 INFO - 'tpaint', 02:32:52 INFO - 'sessionrestore', 02:32:52 INFO - 'sessionrestore_no_auto_restore']}, 02:32:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['a11yr', 02:32:52 INFO - 'ts_paint', 02:32:52 INFO - 'tpaint', 02:32:52 INFO - 'sessionrestore', 02:32:52 INFO - 'sessionrestore_no_auto_restore']}, 02:32:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['a11yr', 02:32:52 INFO - 'ts_paint', 02:32:52 INFO - 'tpaint', 02:32:52 INFO - 'sessionrestore', 02:32:52 INFO - 'sessionrestore_no_auto_restore']}, 02:32:52 INFO - 'other_l64': {'tests': ['a11yr', 02:32:52 INFO - 'ts_paint', 02:32:52 INFO - 'tpaint', 02:32:52 INFO - 'sessionrestore', 02:32:52 INFO - 'sessionrestore_no_auto_restore']}, 02:32:52 INFO - 'other_nol64': {'tests': ['a11yr', 02:32:52 INFO - 'ts_paint', 02:32:52 INFO - 'tpaint', 02:32:52 INFO - 'sessionrestore', 02:32:52 INFO - 'sessionrestore_no_auto_restore']}, 02:32:52 INFO - 'svgr': {'tests': ['tsvgx', 02:32:52 INFO - 'tsvgr_opacity', 02:32:52 INFO - 'tart', 02:32:52 INFO - 'tscrollx', 02:32:52 INFO - 'cart']}, 02:32:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['tsvgx', 02:32:52 INFO - 'tsvgr_opacity', 02:32:52 INFO - 'tart', 02:32:52 INFO - 'tscrollx', 02:32:52 INFO - 'cart']}, 02:32:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:52 INFO - 'tests': ['tp5o']}, 02:32:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:52 INFO - 'talos_options': ['--e10s'], 02:32:52 INFO - 'tests': ['tp5o']}, 02:32:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:52 INFO - 'talos_options': ['--xperf_path', 02:32:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:52 INFO - 'tests': ['tp5n']}, 02:32:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:52 INFO - 'talos_options': ['--e10s', 02:32:52 INFO - '--xperf_path', 02:32:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:32:52 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:32:52 INFO - 'tests': ['tp5n']}}, 02:32:52 INFO - 'talos.zip': {'path': '', 02:32:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:52 INFO - Running post-action listener: _resource_record_post_action 02:32:52 INFO - ##### 02:32:52 INFO - ##### Running create-virtualenv step. 02:32:52 INFO - ##### 02:32:52 INFO - Running pre-action listener: _resource_record_pre_action 02:32:52 INFO - Running main action method: create_virtualenv 02:32:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:32:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:52 INFO - Using real prefix '/tools/python27' 02:32:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:57 INFO - Installing pip.................done. 02:32:57 INFO - Return code: 0 02:32:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f6b765f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab259f0>, '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 0x10a884cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaef990>, '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.mLOqz8ZiVs/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.22cSfvKsig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mLOqz8ZiVs/Render', 02:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:57 INFO - 'HOME': '/Users/cltbld', 02:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:57 INFO - 'LOGNAME': 'cltbld', 02:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:57 INFO - 'MOZ_NO_REMOTE': '1', 02:32:57 INFO - 'NO_EM_RESTART': '1', 02:32:57 INFO - 'PAGER': '/bin/cat', 02:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:57 INFO - 'PWD': '/builds/slave/test', 02:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:57 INFO - 'SHELL': '/bin/bash', 02:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.22cSfvKsig/Listeners', 02:32:57 INFO - 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', 02:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:57 INFO - 'USER': 'cltbld', 02:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:57 INFO - 'XPC_FLAGS': '0x0', 02:32:57 INFO - 'XPC_SERVICE_NAME': '0', 02:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:32:57 INFO - Cleaning up... 02:32:57 INFO - Return code: 0 02:32:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10ab70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f6b765f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab259f0>, '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 0x10a884cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaef990>, '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.mLOqz8ZiVs/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.22cSfvKsig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mLOqz8ZiVs/Render', 02:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:58 INFO - 'HOME': '/Users/cltbld', 02:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:58 INFO - 'LOGNAME': 'cltbld', 02:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:58 INFO - 'MOZ_NO_REMOTE': '1', 02:32:58 INFO - 'NO_EM_RESTART': '1', 02:32:58 INFO - 'PAGER': '/bin/cat', 02:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:58 INFO - 'PWD': '/builds/slave/test', 02:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:58 INFO - 'SHELL': '/bin/bash', 02:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.22cSfvKsig/Listeners', 02:32:58 INFO - 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', 02:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:58 INFO - 'USER': 'cltbld', 02:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:58 INFO - 'XPC_FLAGS': '0x0', 02:32:58 INFO - 'XPC_SERVICE_NAME': '0', 02:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:58 INFO - Downloading/unpacking psutil>=0.7.1 02:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:33:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:01 INFO - Installing collected packages: psutil 02:33:01 INFO - Running setup.py install for psutil 02:33:01 INFO - building 'psutil._psutil_osx' extension 02:33:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:33:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:33:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:33:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:33:01 INFO - building 'psutil._psutil_posix' extension 02:33:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:33:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:33:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:33:01 INFO - ^ 02:33:01 INFO - 1 warning generated. 02:33:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:02 INFO - Successfully installed psutil 02:33:02 INFO - Cleaning up... 02:33:02 INFO - Return code: 0 02:33:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f6b765f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab259f0>, '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 0x10a884cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaef990>, '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.mLOqz8ZiVs/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.22cSfvKsig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mLOqz8ZiVs/Render', 02:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:02 INFO - 'HOME': '/Users/cltbld', 02:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:02 INFO - 'LOGNAME': 'cltbld', 02:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:02 INFO - 'MOZ_NO_REMOTE': '1', 02:33:02 INFO - 'NO_EM_RESTART': '1', 02:33:02 INFO - 'PAGER': '/bin/cat', 02:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:02 INFO - 'PWD': '/builds/slave/test', 02:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:02 INFO - 'SHELL': '/bin/bash', 02:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.22cSfvKsig/Listeners', 02:33:02 INFO - 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', 02:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:02 INFO - 'USER': 'cltbld', 02:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:02 INFO - 'XPC_FLAGS': '0x0', 02:33:02 INFO - 'XPC_SERVICE_NAME': '0', 02:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:33:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:33:05 INFO - Installing collected packages: mozsystemmonitor 02:33:05 INFO - Running setup.py install for mozsystemmonitor 02:33:05 INFO - Successfully installed mozsystemmonitor 02:33:05 INFO - Cleaning up... 02:33:05 INFO - Return code: 0 02:33:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f6b765f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab259f0>, '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 0x10a884cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaef990>, '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.mLOqz8ZiVs/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.22cSfvKsig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mLOqz8ZiVs/Render', 02:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:05 INFO - 'HOME': '/Users/cltbld', 02:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:05 INFO - 'LOGNAME': 'cltbld', 02:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:05 INFO - 'MOZ_NO_REMOTE': '1', 02:33:05 INFO - 'NO_EM_RESTART': '1', 02:33:05 INFO - 'PAGER': '/bin/cat', 02:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:05 INFO - 'PWD': '/builds/slave/test', 02:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:05 INFO - 'SHELL': '/bin/bash', 02:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.22cSfvKsig/Listeners', 02:33:05 INFO - 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', 02:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:05 INFO - 'USER': 'cltbld', 02:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:05 INFO - 'XPC_FLAGS': '0x0', 02:33:05 INFO - 'XPC_SERVICE_NAME': '0', 02:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:08 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:09 INFO - Downloading docopt-0.6.1.tar.gz 02:33:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:09 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:09 INFO - Running setup.py install for blobuploader 02:33:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:09 INFO - Running setup.py install for requests 02:33:10 INFO - Running setup.py install for docopt 02:33:10 INFO - Successfully installed blobuploader requests docopt 02:33:10 INFO - Cleaning up... 02:33:10 INFO - Return code: 0 02:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:10 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 0x10ab70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f6b765f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab259f0>, '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 0x10a884cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaef990>, '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.mLOqz8ZiVs/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.22cSfvKsig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mLOqz8ZiVs/Render', 02:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:10 INFO - 'HOME': '/Users/cltbld', 02:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:10 INFO - 'LOGNAME': 'cltbld', 02:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:10 INFO - 'MOZ_NO_REMOTE': '1', 02:33:10 INFO - 'NO_EM_RESTART': '1', 02:33:10 INFO - 'PAGER': '/bin/cat', 02:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:10 INFO - 'PWD': '/builds/slave/test', 02:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:10 INFO - 'SHELL': '/bin/bash', 02:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.22cSfvKsig/Listeners', 02:33:10 INFO - 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', 02:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:10 INFO - 'USER': 'cltbld', 02:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:10 INFO - 'XPC_FLAGS': '0x0', 02:33:10 INFO - 'XPC_SERVICE_NAME': '0', 02:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:11 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-IVJ23o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:11 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-gDQ_XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:11 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-KlvbwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:11 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-PVHhXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:11 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-DzVm0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:11 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-ieOdHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:11 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-xwop3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:12 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-scCMrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:12 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-hqv049-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:12 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-PXFveq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:12 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-UCIBl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:12 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-rDvO9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:12 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-9b_Fvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:12 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-9yBGyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:13 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-tk82vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:13 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-ggY3l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:13 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-JjjTEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:13 INFO - Running setup.py install for manifestparser 02:33:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:13 INFO - Running setup.py install for mozcrash 02:33:13 INFO - Running setup.py install for mozdebug 02:33:13 INFO - Running setup.py install for mozdevice 02:33:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Running setup.py install for mozfile 02:33:14 INFO - Running setup.py install for mozhttpd 02:33:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Running setup.py install for mozinfo 02:33:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Running setup.py install for mozInstall 02:33:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:14 INFO - Running setup.py install for mozleak 02:33:15 INFO - Running setup.py install for mozlog 02:33:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for moznetwork 02:33:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for mozprocess 02:33:15 INFO - Running setup.py install for mozprofile 02:33:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:15 INFO - Running setup.py install for mozrunner 02:33:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Running setup.py install for mozscreenshot 02:33:16 INFO - Running setup.py install for moztest 02:33:16 INFO - Running setup.py install for mozversion 02:33:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:16 INFO - Cleaning up... 02:33:16 INFO - Return code: 0 02:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f6b765f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab259f0>, '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 0x10a884cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaef990>, '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.mLOqz8ZiVs/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.22cSfvKsig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mLOqz8ZiVs/Render', 02:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:16 INFO - 'HOME': '/Users/cltbld', 02:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:16 INFO - 'LOGNAME': 'cltbld', 02:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:16 INFO - 'MOZ_NO_REMOTE': '1', 02:33:16 INFO - 'NO_EM_RESTART': '1', 02:33:16 INFO - 'PAGER': '/bin/cat', 02:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:16 INFO - 'PWD': '/builds/slave/test', 02:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:16 INFO - 'SHELL': '/bin/bash', 02:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.22cSfvKsig/Listeners', 02:33:16 INFO - 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', 02:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:16 INFO - 'USER': 'cltbld', 02:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:16 INFO - 'XPC_FLAGS': '0x0', 02:33:16 INFO - 'XPC_SERVICE_NAME': '0', 02:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:16 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-87fYhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:17 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-JdaLvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:17 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-eoicQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:17 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-1Y1w6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:17 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-Un6t4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:17 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-qf_voL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:17 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-DbIIU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:17 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)) 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:17 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-j9ycJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:18 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-kZTTDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:18 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-01oIFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:18 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-nUvlBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:18 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-L8TggK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:18 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-I7Wb_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:18 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-Bewx34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:18 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-yBNS6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:19 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-KNpv12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:19 INFO - Running setup.py (path:/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/pip-RNkZsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:21 INFO - Downloading blessings-1.5.1.tar.gz 02:33:21 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:22 INFO - Installing collected packages: blessings 02:33:22 INFO - Running setup.py install for blessings 02:33:22 INFO - Successfully installed blessings 02:33:22 INFO - Cleaning up... 02:33:22 INFO - Return code: 0 02:33:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:22 INFO - Reading from file tmpfile_stdout 02:33:22 INFO - Current package versions: 02:33:22 INFO - blessings == 1.5.1 02:33:22 INFO - blobuploader == 1.2.4 02:33:22 INFO - docopt == 0.6.1 02:33:22 INFO - manifestparser == 1.1 02:33:22 INFO - mozInstall == 1.12 02:33:22 INFO - mozcrash == 0.16 02:33:22 INFO - mozdebug == 0.1 02:33:22 INFO - mozdevice == 0.46 02:33:22 INFO - mozfile == 1.2 02:33:22 INFO - mozhttpd == 0.7 02:33:22 INFO - mozinfo == 0.8 02:33:22 INFO - mozleak == 0.1 02:33:22 INFO - mozlog == 3.0 02:33:22 INFO - moznetwork == 0.27 02:33:22 INFO - mozprocess == 0.22 02:33:22 INFO - mozprofile == 0.27 02:33:22 INFO - mozrunner == 6.11 02:33:22 INFO - mozscreenshot == 0.1 02:33:22 INFO - mozsystemmonitor == 0.0 02:33:22 INFO - moztest == 0.7 02:33:22 INFO - mozversion == 1.4 02:33:22 INFO - psutil == 3.1.1 02:33:22 INFO - requests == 1.2.3 02:33:22 INFO - wsgiref == 0.1.2 02:33:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abdd228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f6b765f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab259f0>, '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 0x10a884cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaef990>, '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.mLOqz8ZiVs/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.22cSfvKsig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mLOqz8ZiVs/Render', 02:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:22 INFO - 'HOME': '/Users/cltbld', 02:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:22 INFO - 'LOGNAME': 'cltbld', 02:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:22 INFO - 'MOZ_NO_REMOTE': '1', 02:33:22 INFO - 'NO_EM_RESTART': '1', 02:33:22 INFO - 'PAGER': '/bin/cat', 02:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:22 INFO - 'PWD': '/builds/slave/test', 02:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:22 INFO - 'SHELL': '/bin/bash', 02:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.22cSfvKsig/Listeners', 02:33:22 INFO - 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', 02:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:22 INFO - 'USER': 'cltbld', 02:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:22 INFO - 'XPC_FLAGS': '0x0', 02:33:22 INFO - 'XPC_SERVICE_NAME': '0', 02:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:22 INFO - Cleaning up... 02:33:22 INFO - Return code: 0 02:33:22 INFO - Running post-action listener: _resource_record_post_action 02:33:22 INFO - Running post-action listener: _start_resource_monitoring 02:33:23 INFO - Starting resource monitoring. 02:33:23 INFO - ##### 02:33:23 INFO - ##### Running install step. 02:33:23 INFO - ##### 02:33:23 INFO - Running pre-action listener: _resource_record_pre_action 02:33:23 INFO - Running main action method: install 02:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:23 INFO - Reading from file tmpfile_stdout 02:33:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:23 INFO - Reading from file tmpfile_stdout 02:33:23 INFO - Output received: 02:33:23 INFO - Usage: mozinstall [options] installer 02:33:23 INFO - Options: 02:33:23 INFO - -h, --help show this help message and exit 02:33:23 INFO - -d DEST, --destination=DEST 02:33:23 INFO - Directory to install application into. [default: 02:33:23 INFO - "/builds/slave/test"] 02:33:23 INFO - --app=APP Application being installed. [default: firefox] 02:33:23 INFO - mkdir: /builds/slave/test/build/application 02:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:34:03 INFO - Reading from file tmpfile_stdout 02:34:03 INFO - Output received: 02:34:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:34:03 INFO - Running post-action listener: _resource_record_post_action 02:34:03 INFO - ##### 02:34:03 INFO - ##### Running run-tests step. 02:34:03 INFO - ##### 02:34:03 INFO - Running pre-action listener: _resource_record_pre_action 02:34:03 INFO - Running main action method: run_tests 02:34:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:03 INFO - 2015-11-02 02:34:03.500 screenresolution[3407:34095] starting screenresolution argv=screenresolution get 02:34:03 INFO - 2015-11-02 02:34:03.503 screenresolution[3407:34095] Display 0: 1600x1200x32@60 02:34:03 INFO - 2015-11-02 02:34:03.510 screenresolution[3408:34097] starting screenresolution argv=screenresolution list 02:34:03 INFO - Available Modes on Display 0 02:34:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:03 INFO - Intel HD Graphics 3000: 02:34:03 INFO - Chipset Model: Intel HD Graphics 3000 02:34:03 INFO - Type: GPU 02:34:03 INFO - Bus: Built-In 02:34:03 INFO - VRAM (Total): 512 MB 02:34:03 INFO - VRAM (Dynamic, Max): 10 02:34:03 INFO - Vendor: Intel (0x8086) 02:34:03 INFO - Device ID: 0x0116 02:34:03 INFO - Revision ID: 0x0009 02:34:03 INFO - Displays: 02:34:03 INFO - Display: 02:34:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:03 INFO - Display Serial Number: 1600x1200 60 02:34:03 INFO - Main Display: Yes 02:34:03 INFO - Mirror: Off 02:34:03 INFO - Online: Yes 02:34:03 INFO - Rotation: Supported 02:34:03 INFO - Return code: 0 02:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:03 INFO - Python 2.7.3 02:34:03 INFO - Return code: 0 02:34:03 INFO - grabbing minidump binary from tooltool 02:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:03 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 0x10ab259f0>, '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 0x10a884cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaef990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:34:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:34:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:03 INFO - Return code: 0 02:34:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:34:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:34:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:03 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/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0064', '--webServer', 'localhost'] in /builds/slave/test/build 02:34:03 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/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0064 --webServer localhost 02:34:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mLOqz8ZiVs/Render', 02:34:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:03 INFO - 'HOME': '/Users/cltbld', 02:34:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:03 INFO - 'LOGNAME': 'cltbld', 02:34:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:03 INFO - 'MOZ_NO_REMOTE': '1', 02:34:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:03 INFO - 'NO_EM_RESTART': '1', 02:34:03 INFO - 'PAGER': '/bin/cat', 02:34:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:03 INFO - 'PWD': '/builds/slave/test', 02:34:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:03 INFO - 'SHELL': '/bin/bash', 02:34:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.22cSfvKsig/Listeners', 02:34:03 INFO - 'TMPDIR': '/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/', 02:34:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:03 INFO - 'USER': 'cltbld', 02:34:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:03 INFO - 'XPC_FLAGS': '0x0', 02:34:03 INFO - 'XPC_SERVICE_NAME': '0', 02:34:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:34:03 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/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0064', '--webServer', 'localhost'] with output_timeout 3600 02:34:04 INFO - mozversion INFO | application_buildid: 20151102014533 02:34:04 INFO - mozversion INFO | application_changeset: 7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679 02:34:04 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:34:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:04 INFO - mozversion INFO | application_name: Firefox 02:34:04 INFO - mozversion INFO | application_remotingname: firefox-dev 02:34:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:04 INFO - mozversion INFO | application_vendor: Mozilla 02:34:04 INFO - mozversion INFO | application_version: 44.0a2 02:34:04 INFO - mozversion INFO | platform_buildid: 20151102014533 02:34:04 INFO - mozversion INFO | platform_changeset: 7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679 02:34:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:04 INFO - mozversion INFO | platform_version: 44.0a2 02:34:04 INFO - 2015-11-02 02:34:04,174 DEBUG : using testdate: 1446460444 02:34:04 INFO - 2015-11-02 02:34:04,174 DEBUG : actual date: 1446460444 02:34:04 INFO - 2015-11-02 02:34:04,184 INFO : starting webserver on 'localhost:58737' 02:34:04 INFO - 2015-11-02 02:34:04,185 INFO : Starting test suite t-yosemite-r5-0064 02:34:04 INFO - 2015-11-02 02:34:04,185 INFO : Starting test dromaeo_css 02:34:04 INFO - 2015-11-02 02:34:04,185 DEBUG : operating with platform_type : mac_ 02:34:04 INFO - 2015-11-02 02:34:04,186 INFO : Initialising browser for dromaeo_css test... 02:34:04 INFO - 2015-11-02 02:34:04,201 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/tmplFphyY/profile http://localhost:58737/getInfo.html 02:34:06 INFO - 2015-11-02 02:34:06,733 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:34:06 INFO - 2015-11-02 02:34:06,733 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:34:06 INFO - 2015-11-02 02:34:06,733 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:34:06 INFO - 2015-11-02 02:34:06,733 DEBUG : BROWSER_OUTPUT: __metrics 02:34:06 INFO - 2015-11-02 02:34:06,749 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:34:07 INFO - 2015-11-02 02:34:07,513 INFO : Browser initialized. 02:34:07 INFO - 2015-11-02 02:34:07,513 INFO : Running cycle 1/1 for dromaeo_css test... 02:34:07 INFO - 2015-11-02 02:34:07,513 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/tmplFphyY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:34:19 INFO - 2015-11-02 02:34:19,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 200331264 02:34:19 INFO - 2015-11-02 02:34:19,551 DEBUG : BROWSER_OUTPUT: 02:35:11 INFO - 2015-11-02 02:35:11,076 DEBUG : BROWSER_OUTPUT: 1446460511074 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:37:21 INFO - 2015-11-02 02:37:21,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58737/tests/dromaeo/cssquery-ext.html) 02:37:22 INFO - 2015-11-02 02:37:22,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 303403008 02:37:22 INFO - 2015-11-02 02:37:22,814 DEBUG : BROWSER_OUTPUT: 02:40:25 INFO - 2015-11-02 02:40:25,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/dromaeo/cssquery-ext.html (next: http://localhost:58737/tests/dromaeo/cssquery-jquery.html) 02:40:26 INFO - 2015-11-02 02:40:26,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 341172224 02:40:26 INFO - 2015-11-02 02:40:26,103 DEBUG : BROWSER_OUTPUT: 02:43:28 INFO - 2015-11-02 02:43:28,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58737/tests/dromaeo/cssquery-mootools.html) 02:43:29 INFO - 2015-11-02 02:43:29,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 308363264 02:43:29 INFO - 2015-11-02 02:43:29,015 DEBUG : BROWSER_OUTPUT: 02:46:31 INFO - 2015-11-02 02:46:31,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58737/tests/dromaeo/cssquery-prototype.html) 02:46:31 INFO - 2015-11-02 02:46:31,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 299655168 02:46:31 INFO - 2015-11-02 02:46:31,696 DEBUG : BROWSER_OUTPUT: 02:49:34 INFO - 2015-11-02 02:49:34,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58737/tests/dromaeo/cssquery-yui.html) 02:49:35 INFO - 2015-11-02 02:49:35,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 300724224 02:49:35 INFO - 2015-11-02 02:49:35,437 DEBUG : BROWSER_OUTPUT: 02:52:37 INFO - 2015-11-02 02:52:37,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/dromaeo/cssquery-yui.html (next: http://localhost:58737/tests/dromaeo/cssquery-dojo.html) 02:52:38 INFO - 2015-11-02 02:52:38,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 342953984 02:52:38 INFO - 2015-11-02 02:52:38,196 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-11-02 02:52:38,196 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:52:38 INFO - 2015-11-02 02:52:38,196 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:52:38 INFO - 2015-11-02 02:52:38,196 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:52:38 INFO - 2015-11-02 02:52:38,196 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:52:38 INFO - 2015-11-02 02:52:38,196 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2790.9720902790973;2838.332991746939;2840.3325218573646;2879.6256486656744;2885.3940672458784;4780.976095119519;4792.7603619819;4828.299896515012;4837.7339246341435;4851.68464049837;4790.880227994293;4807.783649735761;4808.975955120228;4833.202521583935;4833.347498087757;4485.842995495158;4517.209488339544;4528.298113792367;4556.3621093047;4618.515055919131;4584.7936842842155;4605.953940460603;4612.630989520847;4625.62994960404;4637.397138372007;4538.364628951949;4576.3821884045565;4593.586577208051;4600;4617.14582802181;4527.3888025116685;4624.352590637313;4630.805311981817;4634.096351211515;4682.438107427113;4613.308003799423;4619.607333376667;4637.559431853969;4641;4652.348671186037;4566.725996440225;4603.815847366135;4658.208104622188;4868.221084626478;4886.755662216875;5016.3980322361185;5142.537171654569;5144.0740666679985;5154.355705536808;5181.637285390024;5226.5818734501145;5299.8410047698635;5371.919421208685;5383.973080134613;5384.865378365533;4737.24204127338;4794.9280760788615;4797.496262892346;4993.0263598598285;5006.799728010911;5246.63273570854;5446.809361672323;5452.073147564924;5476.972615136899;5504.394516603171;5138.845834624967;5185.507376799198;5188.714620695898;5199.376074871039;5230;5026;5131.589472842164;5149.45930677281;5319.2021196820015;5369.033573956725;5055.115354812893;5084.415292241366;5137.383513978271;5150.845474635767;5153.742312884341;5150.613703972217;5155.793768249303;5162.561182299547;5171.456997015334;5183.714895680699;3924.2543916655745;3981.5620281768984;4034.798260086984;4069.1658210066867;4072.837086516506;3564.500969864221;3633.3823250047553;3641.6540428659237;3647.434647629622;3659.14010207601;4913.06651736169;4923.975380123076;4926.064047830901;4933.802647894044;4954.281629163751;4948.05986862495;5049.57078648319;5254.15933450646;5274.103402421598;5283.181106928432;4809.5430934061205;4842.7336496493035;4871.537203965689;4944.653874228769;4993.275974983607;4608.585227329557;4620.907581848344;4634.86095417138;4642.46611639659;4653.441587009581;5329.413764485904;5343.064963631271;5344.144936810092;5347.572194224453;5347.679139251657;5048.495150484922;5097.311862898609;5129.692218466904;5182.844514664566;5266.605004624592;5337.119375303187;5356.089464790917;5357.249985002025;5388.946110538845;5391.86520336979;5213.191955246943;5230.398504171917;5237.057329680694;5240.082985477602;5270.920936185884;4904.558589726942;5015.2978582997675;5036.597072234285;5143.0999575073465;5321.9467805323;4989.600831933364;5138.254953031864;5201.869953251199;5203.947960520346;5223.5559977402345;5206.0368831766245;5228.816991405282;5236.293100431545;5257.185136303879;5257.5005374489365;4851.054044461296;4973.577245934136;5105.285260063668;5125.564327032244;5129.358830146231;4901.803927842989;4993.700377977333;4997.3253610762085;5000.2499625056535;5061.063703214917;5026.798928042837;5039.118154323052;5072.492750724898;5081.5426611605135;5090.847274581768 02:52:38 INFO - 2015-11-02 02:52:38,196 DEBUG : BROWSER_OUTPUT: |1;ext.html;504.5055845271636;505.7825135191868;513.9588832893369;517.1570340345238;525.485024675818;28886.277843053907;32116.67883321166;32794.18014549634;32820.507692384635;33334;36846.447303290406;37599;37614.0596485088;37694.8115259424;38319.61680383195;7502.099748030244;7640.388768898502;8051.235132662402;8223.383246256524;8299.83400331993;9694.418334899894;9717.271204659644;9920.206383489303;9951.701448956543;9970.65102721405;9588;9657.661981830637;9699;9714.854277185848;9719;7727.922720772833;7878.72424465141;9560.713178604654;9691;9772.21822254218;9449.196818270455;9608.903910960871;9617.182539484082;9654.90345096547;9705.223582113415;34507.6549234507;34820.65179348225;34853.82573087118;34952.82523587366;35520.64479355225;2793.2458236276293;2824.237455886899;2838.233676907244;2923.6053132827224;3132.9216769580944;24516;24820;25076.874615626988;25804;25842.224733258034;2186.6610675345346;2189.0587047569697;2189.168116115866;2195.7145571075816;2199.0104452996216;235878;236089.99999999828;236415;237791;238000;52015.73992130015;52424.73787631038;52432.47567524352;52769.736151319;52884;52699.736501317246;53006.204906926425;53752.19371709428;54115.45884541104;54209.457905420444;14999.32503037344;15519;15573.454929077428;15708.528744137695;15755.212239388215;12051.276923384625;12088.75822483563;12200.816987745191;12201.694957625952;12229.816552751716;16616.6676666466;16855.157242137844;16915.57711057209;16923.492295231164;16936.745948810778;6795.864082718318;6877.759278425231;6918.377346038881;6920.30796920314;6929.861402771916;808.7129069180356;873.2271939333735;882.188386684252;886.1802832380023;900.2707806676613;25481.87259063693;25695.100671476408;25887.0939517116;25947.22158335253;25995.090171843894;849.6983570832389;938.5166639180827;1002.8144793213279;1044.4099084017657;1076.445630500293;9876;12762.17045892014;12787.680307992374;12809.935950320189;12948.223106613634;279037;283336;290665;378551;382523;40010.59989400127;40213.798931005746;40602.79698601488;40613.79693101515;41261.58738412578;1084.3981590217504;1160.7504386556761;1181.285322379965;1248.7440074784647;1282.615215435347;23583.52832943297;23703.762962370845;25137.24588262355;25201.621975670747;25285.494290114464;38501.22997540089;38705.41941870818;38722.80638596789;38724.612753873225;38895.222095557365;210009;210194;210839;213246;213590;27215;27567.862160689067;27887.860560697067;27942;28054;35210.47184292186;35841.641583584875;36170.819145904105;36486;36498.635013650586;29856.402871942006;30400.239994000327;30471;30496.847515762278;30543;30397.392052159274;30529.23676908095;30554.388912221188;30612.84693576607;30705.232369190948;29898.252543686584;30000.849995750756;30523.38953220879;30649.693503064686;31145;25372.873135634203;26768.59847102334;26922;26932.730672693022;27239.72760272372;21044;21278.680819787405;21343.78656213418;21351.67972480445;21564 02:52:38 INFO - 2015-11-02 02:52:38,200 DEBUG : BROWSER_OUTPUT: |2;jquery.html;306.86958042831805;307.7691731201599;312.97652676049296;318.271159045785;319.7761566903168;12977.416016279267;13440.462381504753;15210.619734506628;15384.000039997407;15730.370785168594;13370.465181392732;15399.846001540009;15826.683466330667;16272.918635406835;16491.91754041228;4544.772761361935;4556.20266453371;4739.454962679284;4758.072175925696;4779;3561.7684850484766;3669.2661467706566;4716.882077948062;4730.668853180278;4986.4514903360605;5040.97479512602;5086.364204474441;5101.948980510185;5111.846644600668;5165.509276618734;4996.350474438318;5097.84706458805;5176.482351764794;5204.947950520522;5257.684538927677;4531.274996000624;4555.293929440942;4555.567221113989;4556.066006468666;4558.635309175291;19124.5218869528;19218.615627687508;19550;19608;19839.30562430308;1754.8069712331633;1763.7089880169756;1768.3810666266832;1815.664102141108;1829.7529833472445;11864.169508134433;12125.93937030318;12348.197367171195;12609.873901260962;12653.30406827624;1473.9705205895823;1511.780791785196;1526.1224795742492;1557.1746974103744;1571.2772124822595;49137.26294105591;51594.742026290005;53157.73421132908;54704.72647636737;56595.15107273394;5910.497607703307;6001.969990150022;6004.3395226525045;6028.57799953999;6030.366811484819;6872.244053154149;6872.793816185523;6912.792616221522;6913.481488888253;6923.342282483156;5121.513456221727;5136.743162841843;5152.639315247971;5156.329677141947;5185.092608793446;5556.499915007668;5569.526590239875;5610.551155907518;5647.519960803378;5654.869026194778;2657.8538180400265;2685.2615530729204;2707.1066548039494;2715.321169707573;2719.877605507757;925.5511077127587;961.9374740641836;989.5448093876897;1002.5839276700234;1009.4851625670814;355.8398720575751;364.6790824074797;384.73645552796427;390.5391637867344;392.7918203352228;10278;10482.63310784119;10557.419341936115;10630.30902991303;10717.785644287227;401.5943896664332;403.38081045594873;403.39289369498715;403.8041549848321;404.2924881457449;5609.887802244014;5735.684537350486;5866.266716660418;5993.820185394445;5998.190244317048;523543;524379;546031;552648;553987;65901;66511.66744166249;66687.3331266681;67132;67154.32845671481;407.8164825828389;421.1639894808802;423.50449973531045;452.62884434763833;468.96826980642044;9485.146336829719;9736.902630973884;10071.446070466194;10123.544440500047;10148.492575371349;31488.685113148575;31780.523292151098;32061.519077213394;32095.197620059684;32898.83550582232;44780.77609611931;44796.77601611971;44933.32600010937;45998;46005.76997114993;5494.670319780826;5506.697131657797;5543.8891222174525;5548.112302031655;5609.579281553982;10507.737306567396;10704.678859634223;10835.620753273597;11025.503852326505;11040.171987100839;9389;9400.905990940004;9411.152996230372;9511.857322140311;9528.190103840974;8998.14517620825;9102.544872756469;9192;9325.300602454707;9360.438373697327;7822.178671239665;8872.378933474594;9365.812683746151;9629.374090684083;9730.95134524323;5299;5373.5432488237375;5509.944900551103;5629.8592535186945;5662.716864156858;9005.279577633642;9155.313351498797;9271.67549135777;9292.117248861347;9303.581338839633 02:52:38 INFO - 2015-11-02 02:52:38,201 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1166.2128063557097;1497.8726808221302;1584.7068292365914;1609.0667412900516;1626.6258760485089;6351.2060992375955;6735.966320168399;6861;6866.82832929177;6876.484263680219;6638.203415590124;6665.600063996151;6808.353206445379;6851.314868513146;6897.862042759142;1975.7727861295955;1990.64168449679;1991.8605697601174;2002.6595478768572;2006.839452843769;1961.9215231390726;1979.703044543323;1986.165810359645;1994.4216177308563;1996.820286174244;1886.1795119123158;1894.4316704988448;1895.7251198576198;1898.8765730227492;1899.4681489183051;1859.907004649762;1864.459306801026;1896.3078476356031;1897.8291953724163;1898.686716691744;1913.2920819296949;1917;1937.8546609004381;1939.6702560564597;1956.4032969944162;5999.520038396918;6256.655883926383;6755.39201471865;6801;6813.488988325846;4004.699647526418;4112;4112.321466957948;4143.399207114981;4150.667946564267;2451.82837201396;2490.8380955237853;2491.202815099169;2504.8371855829496;2525.5201511712717;714.9821254468628;721.9458540609476;754.110952065079;754.2080815144132;756.6065645864174;8985;9111.908880911173;9126.543672816333;9132.771680707969;9150.86273705895;3651.0689774107964;3705.4627079073384;3762.4168253920684;3777.660010599059;3781.243751249706;7486.288802563748;7501.699932002768;7501.737439189602;7505.399568034544;7544.660490277951;4165.687573432005;4222.4299719538085;4229.323308270662;4229.725067870579;4235;3924.3132451820816;3930.037140900498;3930.1353702185475;3947.0527073502153;3954.367301231847;2858.0711268837713;2873.8994135205166;2877.510823160068;2897.0729366602905;2916.2709322669334;908.4912449028565;916.3219217778795;918.6371383303558;925.0518218825757;925.8055808280202;1149.5286932357694;1166.1894982986744;1195.2888031621171;1197.3534291482501;1197.874223206568;6219.564630475914;6267.65527895961;6272.278687950853;6515.51133664977;6576.934230657728;437.2304743651197;438.4344195987141;441.34680672604725;447.5569186505401;447.75149791865175;4933.654644174945;4954.281629163751;4969.577585905166;4980.551750342486;4989.55094041538;8015.879761803461;8093.919060809434;8229.876551851727;8235.21765432283;8310.70912518071;7468.663910123949;7619.657115429708;7731.7680469586;7849.097353804272;7869.724559640385;6455.354464553507;6519.087327774116;6529.2817790043055;6563.1796025496815;6603.834904127435;6414.61512309263;6476.352364763486;6577.80266592003;6578.111954886221;6597.967010164918;7029.929700702927;7398.2231865655485;7400.370968467741;7424.517406368569;7432.405407567274;7416.8887466686965;7549.358304544176;7569.772906812805;7620.885686714593;7684.039495063117;6122.448979591858;6201.627902325875;6223.657698826608;6240.812775616739;6247.5939063960695;6685.832854178684;6699.76550820719;6731.1922569292;6738.427233685192;6742.831429214309;6256.311805701278;6289.622622642473;6332.778352757631;6343.714532845941;6348.079528468254;6197.5351848610635;6224.097505861715;6244.313125556276;6278.780242691484;6346.7143978522;6265.27949285838;6299.149614802126;6308.27454842699;6321.241451025906;6384.553081284265;5719.542436605145;5721.456461636138;5762.135679648086;5806.6806325650805;5814.94185058144;5721.57088218377;5756.251687280626;5841.620294680833;5842.7662893485485;5861.062230043343 02:52:38 INFO - 2015-11-02 02:52:38,202 DEBUG : BROWSER_OUTPUT: |4;prototype.html;258.4972229014566;268.8010871954753;268.8118516158579;273.1763732346973;276.40572768547634;5276.182191760274;5377.059014672436;5387.865303367413;5403.135498320269;5409.9459005409935;5218.634695571312;5290.92063619046;5299.125644268701;5330.760115794789;5345.278387417698;4132.999999999993;4145.481814773153;4170.145120250357;4180.937285940713;4198.601132892386;4024.154927465221;4083.612056854594;4094.8362065517344;4158.480189976253;4168.083021735229;4107.979460102695;4117.114820313632;4120.464339635843;4138.875833724993;4143.792810359485;4075.8369665213504;4100.712950093494;4117.1765646870745;4136.400221967798;4155.10665206979;3471.392506311385;3531.9117022074397;3537.2925414916863;3558.87543935961;3569.446735755962;5078.97460512695;5161.329027226437;5174.586033117342;5189.195674670432;5266.710330931797;4597.885052873671;4635.490096089427;4647.18674232008;4650.837220697294;4655.534446555317;5612.7754889804355;5619.466150715675;5633.943660563383;5649.322081350223;5650.039493286151;3687.704983601332;3751.662350388478;3769.830357633913;3793.2982398256413;3815.561210460805;5812.505936995361;5858.824235272906;5872.765089396419;5899.203607512974;5975.014122669711;3852;3852.056246219638;3852.8651497197466;3877.2245550889934;3912.2371137628456;3900.687944964396;3907.4529565860234;3915.882523524299;3920.2747491713553;3958.802059896994;4468.597826195658;4599.517050709695;4616.792244349012;4622.214223581999;4685.9765701171955;5615.298087739033;5660.745266463019;5665.5184309333345;5705.22979397776;5705.942940570624;1407.8099456573232;1417.5534706567605;1419.09887221615;1420.4673247532176;1423.679672073775;900.7252787899622;918.1323649151622;919.3610440743753;928.9349745517749;930.1628534319032;5464.28964234647;5468.699221542774;5473.452654734495;5488.313960754906;5493.176023596492;5886.852828679317;5904.1734157218025;5912.615679980788;5940.287165540163;5950.940490595125;5481.314835645544;5488.368837583649;5503.036968530491;5522.088855338824;5535.972320138373;3178.7139157475476;3235.8382080895863;3252.9674703252663;3255.137388592025;3289.7697161198485;5929.703514824241;5929.822105336847;5930.525557955353;5935.347111817697;6020.969895150496;6014.879702405928;6017.368176341509;6021.096835474714;6055.091736239599;6081.726322315418;5817.70911454434;5889.764409423575;5895.970520147372;5918.082697181943;5961.880762384815;5852.94147058524;5945.791897283574;5953.166556681981;5973.104034394875;6032.517398608188;5560.082586373203;5662.745176467151;5665.801696940587;5855.063189889597;5877.970610146922;5844.26946631671;5906.055031194988;5937.495312898452;5957.136215248678;5983.670898100472;3646.8358923849023;3688.428293614494;3691.57546882112;3692.9815350923072;3697.500837386918;5856.092305692625;5897.911531326948;5898.469137777621;5948.315943666534;5956.225690660186;5569.721513924206;5682.488576028178;5695.7436915338085;5716.942830571641;5737.512311453574;5636.379998200113;5667.773289068391;5687.033204355187;5720.885582288414;5736.397678243724;5537.861553461195;5559.8888022240135;5563.332400112013;5569.693666848362;5580.38615752275;5519.254900588369;5684.232628595252;5690.402507736628;5770.365259821332;5783.710814459344;5637.943620563742;5645.548356131418;5654.378018417889;5659.660420374791;5763.423657634203 02:52:38 INFO - 2015-11-02 02:52:38,206 DEBUG : BROWSER_OUTPUT: |5;yui.html;667.14838607501;671.4024518178821;677.8169894128586;678.2810221165565;690.9136357955259;12189.634310970663;12549.372531373429;12694.555690550833;12704.682382940407;12713.809292860615;11807;11824.349660768676;12372.752544949095;12389.442475088621;12398.690032749186;650.3756393861898;663.151166506872;791.1692722641233;810.2383759266271;822.6832669422286;795.4749865089043;796.3271035974592;804.6379129391768;812.9552874591895;815.5269943432795;828.4283844147549;845.5434065604566;846.5597889097666;848.8429640516524;850.5492089192707;665.6372277108987;676.9898451523231;822.8436597046542;840.1556435782061;849.6856163219618;615.8829822333787;620.2092332276338;624.0265186309326;624.8094331228973;626.7712285015982;12415.379231038502;12549.937250313782;12572.119951603392;12573.685657858627;12598.559050433283;10402.47987600617;10622.840657390145;10952.28810127347;11134.665960021212;11284.097272218203;8331.458455200393;8589.785255368666;8610.268127209132;8753.44770932698;8864.601092950832;2943.543750718642;2966.8813247470075;3006.4137493188837;3023.8034527755626;3051.0999255219763;44722.77638611819;44776.3283550747;44885.77557112226;44912.77543612294;46520.30219546743;8265.504069755834;8405.117462666332;8480.15198480147;8507.447015943944;8532.317414606816;17753.289868405118;17762.733558996624;17798.288068477374;17882.91058544699;17950.461486155436;6188.1027251048345;6441.3880681335195;6441.742330306735;6563.671816409161;6759.425448836806;3465.376232278214;3498.772579782306;3523.8061906595385;3551.4317709166926;3605.594170014815;2634.670666166729;2687.0460986349954;2690.2198362475056;2690.367763575558;2715.809893307489;424.4079509084809;436.3934131557138;446.4196544492147;446.7141029740968;449.4875841540646;409.33483089978785;417.9310413781692;421.2396624093541;438.10844930566145;548.5611510791351;7212.963935180291;7235.2402997684485;7306.634668266565;7354.595497247703;7455.739049133254;378.3454623501358;411.8949667834743;460.29344955493156;526.5103453788014;532.4196625678029;3349.43059679855;3362.2939182771893;3639.1811842335264;3720.3861362875364;3747.6627103560263;49938.98870050846;50359.24461133086;50594.49405505972;50692.49307506878;50871.745641271555;45155;45612.543874561496;45888.3116753249;45953;46153.07693846104;42885.999999999374;42979.140417191484;43194;43392.3491147633;43828;7286.162091359562;7335.816604584928;7377.668004939684;7390.482666213314;7648.311651951351;32772.672273277916;32781.344373111926;33763.32473350568;33807.49288760621;34016.97949061532;38507.80746096252;40475.1904961905;40699.79650101731;42684.78657606692;43202.35196471993;7182.317679820409;7311.159216689936;7342.164458885279;7357.742479013209;7430.517016393917;8147.75556733299;9048.185663290336;9916.099920547264;9953.973794356667;10130.13893819004;9466;9472.28957828152;9490;9575.138237558374;9629.181519570915;9380.718578442658;9399.671011514563;9465.905340946503;9495.38280011797;9513.571889265138;9339.626414943326;9372.250219982521;9395.671151509938;9422.340436169403;9506;8339.916600833914;8443.620037098222;8598.61306241233;8625.784355391166;9110.180083792491;8164.959175204086;8546.401751877558;8559.186877246651;8735.781605459915;8868.778280543038 02:52:38 INFO - 2015-11-02 02:52:38,206 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:52:38 INFO - 2015-11-02 02:52:38,206 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:52:38 INFO - 2015-11-02 02:52:38,207 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 02:52:38 INFO - 2015-11-02 02:52:38,207 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:52:38 INFO - 2015-11-02 02:52:38,207 DEBUG : BROWSER_OUTPUT: __startTimestamp1446461558191__endTimestamp 02:52:38 INFO - 2015-11-02 02:52:38,207 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-11-02 02:52:38,207 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:52:38 INFO - 2015-11-02 02:52:38,208 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:52:38 INFO - 2015-11-02 02:52:38,208 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-11-02 02:52:38,208 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4864.46 Median:5000.25 stddev:524.58 (10.5%) stddev-sans-first:500.33 02:52:38 INFO - 2015-11-02 02:52:38,208 DEBUG : BROWSER_OUTPUT: Values: 2791.0 2838.3 2840.3 2879.6 2885.4 4781.0 4792.8 4828.3 4837.7 4851.7 4790.9 4807.8 4809.0 4833.2 4833.3 4485.8 4517.2 4528.3 4556.4 4618.5 4584.8 4606.0 4612.6 4625.6 4637.4 4538.4 4576.4 4593.6 4600.0 4617.1 4527.4 4624.4 4630.8 4634.1 4682.4 4613.3 4619.6 4637.6 4641.0 4652.3 4566.7 4603.8 4658.2 4868.2 4886.8 5016.4 5142.5 5144.1 5154.4 5181.6 5226.6 5299.8 5371.9 5384.0 5384.9 4737.2 4794.9 4797.5 4993.0 5006.8 5246.6 5446.8 5452.1 5477.0 5504.4 5138.8 5185.5 5188.7 5199.4 5230.0 5026.0 5131.6 5149.5 5319.2 5369.0 5055.1 5084.4 5137.4 5150.8 5153.7 5150.6 5155.8 5162.6 5171.5 5183.7 3924.3 3981.6 4034.8 4069.2 4072.8 3564.5 3633.4 3641.7 3647.4 3659.1 4913.1 4924.0 4926.1 4933.8 4954.3 4948.1 5049.6 5254.2 5274.1 5283.2 4809.5 4842.7 4871.5 4944.7 4993.3 4608.6 4620.9 4634.9 4642.5 4653.4 5329.4 5343.1 5344.1 5347.6 5347.7 5048.5 5097.3 5129.7 5182.8 5266.6 5337.1 5356.1 5357.2 5388.9 5391.9 5213.2 5230.4 5237.1 5240.1 5270.9 4904.6 5015.3 5036.6 5143.1 5321.9 4989.6 5138.3 5201.9 5203.9 5223.6 5206.0 5228.8 5236.3 5257.2 5257.5 4851.1 4973.6 5105.3 5125.6 5129.4 4901.8 4993.7 4997.3 5000.2 5061.1 5026.8 5039.1 5072.5 5081.5 5090.8 02:52:38 INFO - 2015-11-02 02:52:38,208 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-11-02 02:52:38,208 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40501.87 Median:30583.62 stddev:68893.81 (225.3%) stddev-sans-first:69021.62 02:52:38 INFO - 2015-11-02 02:52:38,209 DEBUG : BROWSER_OUTPUT: Values: 504.5 505.8 514.0 517.2 525.5 28886.3 32116.7 32794.2 32820.5 33334.0 36846.4 37599.0 37614.1 37694.8 38319.6 7502.1 7640.4 8051.2 8223.4 8299.8 9694.4 9717.3 9920.2 9951.7 9970.7 9588.0 9657.7 9699.0 9714.9 9719.0 7727.9 7878.7 9560.7 9691.0 9772.2 9449.2 9608.9 9617.2 9654.9 9705.2 34507.7 34820.7 34853.8 34952.8 35520.6 2793.2 2824.2 2838.2 2923.6 3132.9 24516.0 24820.0 25076.9 25804.0 25842.2 2186.7 2189.1 2189.2 2195.7 2199.0 235878.0 236090.0 236415.0 237791.0 238000.0 52015.7 52424.7 52432.5 52769.7 52884.0 52699.7 53006.2 53752.2 54115.5 54209.5 14999.3 15519.0 15573.5 15708.5 15755.2 12051.3 12088.8 12200.8 12201.7 12229.8 16616.7 16855.2 16915.6 16923.5 16936.7 6795.9 6877.8 6918.4 6920.3 6929.9 808.7 873.2 882.2 886.2 900.3 25481.9 25695.1 25887.1 25947.2 25995.1 849.7 938.5 1002.8 1044.4 1076.4 9876.0 12762.2 12787.7 12809.9 12948.2 279037.0 283336.0 290665.0 378551.0 382523.0 40010.6 40213.8 40602.8 40613.8 41261.6 1084.4 1160.8 1181.3 1248.7 1282.6 23583.5 23703.8 25137.2 25201.6 25285.5 38501.2 38705.4 38722.8 38724.6 38895.2 210009.0 210194.0 210839.0 213246.0 213590.0 27215.0 27567.9 27887.9 27942.0 28054.0 35210.5 35841.6 36170.8 36486.0 36498.6 29856.4 30400.2 30471.0 30496.8 30543.0 30397.4 30529.2 30554.4 30612.8 30705.2 29898.3 30000.8 30523.4 30649.7 31145.0 25372.9 26768.6 26922.0 26932.7 27239.7 21044.0 21278.7 21343.8 21351.7 21564.0 02:52:38 INFO - 2015-11-02 02:52:38,209 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-11-02 02:52:38,209 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26112.99 Median:4735.06 stddev:88394.25 (1866.8%) stddev-sans-first:88620.98 02:52:38 INFO - 2015-11-02 02:52:38,210 DEBUG : BROWSER_OUTPUT: Values: 306.9 307.8 313.0 318.3 319.8 12977.4 13440.5 15210.6 15384.0 15730.4 13370.5 15399.8 15826.7 16272.9 16491.9 4544.8 4556.2 4739.5 4758.1 4779.0 3561.8 3669.3 4716.9 4730.7 4986.5 5041.0 5086.4 5101.9 5111.8 5165.5 4996.4 5097.8 5176.5 5204.9 5257.7 4531.3 4555.3 4555.6 4556.1 4558.6 19124.5 19218.6 19550.0 19608.0 19839.3 1754.8 1763.7 1768.4 1815.7 1829.8 11864.2 12125.9 12348.2 12609.9 12653.3 1474.0 1511.8 1526.1 1557.2 1571.3 49137.3 51594.7 53157.7 54704.7 56595.2 5910.5 6002.0 6004.3 6028.6 6030.4 6872.2 6872.8 6912.8 6913.5 6923.3 5121.5 5136.7 5152.6 5156.3 5185.1 5556.5 5569.5 5610.6 5647.5 5654.9 2657.9 2685.3 2707.1 2715.3 2719.9 925.6 961.9 989.5 1002.6 1009.5 355.8 364.7 384.7 390.5 392.8 10278.0 10482.6 10557.4 10630.3 10717.8 401.6 403.4 403.4 403.8 404.3 5609.9 5735.7 5866.3 5993.8 5998.2 523543.0 524379.0 546031.0 552648.0 553987.0 65901.0 66511.7 66687.3 67132.0 67154.3 407.8 421.2 423.5 452.6 469.0 9485.1 9736.9 10071.4 10123.5 10148.5 31488.7 31780.5 32061.5 32095.2 32898.8 44780.8 44796.8 44933.3 45998.0 46005.8 5494.7 5506.7 5543.9 5548.1 5609.6 10507.7 10704.7 10835.6 11025.5 11040.2 9389.0 9400.9 9411.2 9511.9 9528.2 8998.1 9102.5 9192.0 9325.3 9360.4 7822.2 8872.4 9365.8 9629.4 9731.0 5299.0 5373.5 5509.9 5629.9 5662.7 9005.3 9155.3 9271.7 9292.1 9303.6 02:52:38 INFO - 2015-11-02 02:52:38,210 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-11-02 02:52:38,211 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4751.63 Median:6223.88 stddev:2482.69 (39.9%) stddev-sans-first:2475.03 02:52:38 INFO - 2015-11-02 02:52:38,212 DEBUG : BROWSER_OUTPUT: Values: 1166.2 1497.9 1584.7 1609.1 1626.6 6351.2 6736.0 6861.0 6866.8 6876.5 6638.2 6665.6 6808.4 6851.3 6897.9 1975.8 1990.6 1991.9 2002.7 2006.8 1961.9 1979.7 1986.2 1994.4 1996.8 1886.2 1894.4 1895.7 1898.9 1899.5 1859.9 1864.5 1896.3 1897.8 1898.7 1913.3 1917.0 1937.9 1939.7 1956.4 5999.5 6256.7 6755.4 6801.0 6813.5 4004.7 4112.0 4112.3 4143.4 4150.7 2451.8 2490.8 2491.2 2504.8 2525.5 715.0 721.9 754.1 754.2 756.6 8985.0 9111.9 9126.5 9132.8 9150.9 3651.1 3705.5 3762.4 3777.7 3781.2 7486.3 7501.7 7501.7 7505.4 7544.7 4165.7 4222.4 4229.3 4229.7 4235.0 3924.3 3930.0 3930.1 3947.1 3954.4 2858.1 2873.9 2877.5 2897.1 2916.3 908.5 916.3 918.6 925.1 925.8 1149.5 1166.2 1195.3 1197.4 1197.9 6219.6 6267.7 6272.3 6515.5 6576.9 437.2 438.4 441.3 447.6 447.8 4933.7 4954.3 4969.6 4980.6 4989.6 8015.9 8093.9 8229.9 8235.2 8310.7 7468.7 7619.7 7731.8 7849.1 7869.7 6455.4 6519.1 6529.3 6563.2 6603.8 6414.6 6476.4 6577.8 6578.1 6598.0 7029.9 7398.2 7400.4 7424.5 7432.4 7416.9 7549.4 7569.8 7620.9 7684.0 6122.4 6201.6 6223.7 6240.8 6247.6 6685.8 6699.8 6731.2 6738.4 6742.8 6256.3 6289.6 6332.8 6343.7 6348.1 6197.5 6224.1 6244.3 6278.8 6346.7 6265.3 6299.1 6308.3 6321.2 6384.6 5719.5 5721.5 5762.1 5806.7 5814.9 5721.6 5756.3 5841.6 5842.8 5861.1 02:52:38 INFO - 2015-11-02 02:52:38,212 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-11-02 02:52:38,212 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4722.02 Median:5490.77 stddev:1444.79 (26.3%) stddev-sans-first:1409.46 02:52:38 INFO - 2015-11-02 02:52:38,213 DEBUG : BROWSER_OUTPUT: Values: 258.5 268.8 268.8 273.2 276.4 5276.2 5377.1 5387.9 5403.1 5409.9 5218.6 5290.9 5299.1 5330.8 5345.3 4133.0 4145.5 4170.1 4180.9 4198.6 4024.2 4083.6 4094.8 4158.5 4168.1 4108.0 4117.1 4120.5 4138.9 4143.8 4075.8 4100.7 4117.2 4136.4 4155.1 3471.4 3531.9 3537.3 3558.9 3569.4 5079.0 5161.3 5174.6 5189.2 5266.7 4597.9 4635.5 4647.2 4650.8 4655.5 5612.8 5619.5 5633.9 5649.3 5650.0 3687.7 3751.7 3769.8 3793.3 3815.6 5812.5 5858.8 5872.8 5899.2 5975.0 3852.0 3852.1 3852.9 3877.2 3912.2 3900.7 3907.5 3915.9 3920.3 3958.8 4468.6 4599.5 4616.8 4622.2 4686.0 5615.3 5660.7 5665.5 5705.2 5705.9 1407.8 1417.6 1419.1 1420.5 1423.7 900.7 918.1 919.4 928.9 930.2 5464.3 5468.7 5473.5 5488.3 5493.2 5886.9 5904.2 5912.6 5940.3 5950.9 5481.3 5488.4 5503.0 5522.1 5536.0 3178.7 3235.8 3253.0 3255.1 3289.8 5929.7 5929.8 5930.5 5935.3 6021.0 6014.9 6017.4 6021.1 6055.1 6081.7 5817.7 5889.8 5896.0 5918.1 5961.9 5852.9 5945.8 5953.2 5973.1 6032.5 5560.1 5662.7 5665.8 5855.1 5878.0 5844.3 5906.1 5937.5 5957.1 5983.7 3646.8 3688.4 3691.6 3693.0 3697.5 5856.1 5897.9 5898.5 5948.3 5956.2 5569.7 5682.5 5695.7 5716.9 5737.5 5636.4 5667.8 5687.0 5720.9 5736.4 5537.9 5559.9 5563.3 5569.7 5580.4 5519.3 5684.2 5690.4 5770.4 5783.7 5637.9 5645.5 5654.4 5659.7 5763.4 02:52:38 INFO - 2015-11-02 02:52:38,214 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-11-02 02:52:38,214 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12344.21 Median:582.22 stddev:14647.24 (2515.7%) stddev-sans-first:14662.08 02:52:38 INFO - 2015-11-02 02:52:38,215 DEBUG : BROWSER_OUTPUT: Values: 667.1 671.4 677.8 678.3 690.9 12189.6 12549.4 12694.6 12704.7 12713.8 11807.0 11824.3 12372.8 12389.4 12398.7 650.4 663.2 791.2 810.2 822.7 795.5 796.3 804.6 813.0 815.5 828.4 845.5 846.6 848.8 850.5 665.6 677.0 822.8 840.2 849.7 615.9 620.2 624.0 624.8 626.8 12415.4 12549.9 12572.1 12573.7 12598.6 10402.5 10622.8 10952.3 11134.7 11284.1 8331.5 8589.8 8610.3 8753.4 8864.6 2943.5 2966.9 3006.4 3023.8 3051.1 44722.8 44776.3 44885.8 44912.8 46520.3 8265.5 8405.1 8480.2 8507.4 8532.3 17753.3 17762.7 17798.3 17882.9 17950.5 6188.1 6441.4 6441.7 6563.7 6759.4 3465.4 3498.8 3523.8 3551.4 3605.6 2634.7 2687.0 2690.2 2690.4 2715.8 424.4 436.4 446.4 446.7 449.5 409.3 417.9 421.2 438.1 548.6 7213.0 7235.2 7306.6 7354.6 7455.7 378.3 411.9 460.3 526.5 532.4 3349.4 3362.3 3639.2 3720.4 3747.7 49939.0 50359.2 50594.5 50692.5 50871.7 45155.0 45612.5 45888.3 45953.0 46153.1 42886.0 42979.1 43194.0 43392.3 43828.0 7286.2 7335.8 7377.7 7390.5 7648.3 32772.7 32781.3 33763.3 33807.5 34017.0 38507.8 40475.2 40699.8 42684.8 43202.4 7182.3 7311.2 7342.2 7357.7 7430.5 8147.8 9048.2 9916.1 9954.0 10130.1 9466.0 9472.3 9490.0 9575.1 9629.2 9380.7 9399.7 9465.9 9495.4 9513.6 9339.6 9372.3 9395.7 9422.3 9506.0 8339.9 8443.6 8598.6 8625.8 9110.2 8165.0 8546.4 8559.2 8735.8 8868.8 02:52:38 INFO - 2015-11-02 02:52:38,215 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:52:38 INFO - 2015-11-02 02:52:38,215 DEBUG : BROWSER_OUTPUT: 02:52:39 INFO - 2015-11-02 02:52:39,114 INFO : Browser exited with error code: 0 02:52:39 INFO - 2015-11-02 02:52:39,146 INFO : Completed test dromaeo_css (00:18:34) 02:52:39 INFO - 2015-11-02 02:52:39,146 INFO : Starting test kraken 02:52:39 INFO - 2015-11-02 02:52:39,146 DEBUG : operating with platform_type : mac_ 02:52:39 INFO - 2015-11-02 02:52:39,147 INFO : Initialising browser for kraken test... 02:52:39 INFO - 2015-11-02 02:52:39,163 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/tmpXHD2UM/profile http://localhost:58737/getInfo.html 02:52:41 INFO - 2015-11-02 02:52:41,598 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:52:41 INFO - 2015-11-02 02:52:41,598 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:52:41 INFO - 2015-11-02 02:52:41,598 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:52:41 INFO - 2015-11-02 02:52:41,598 DEBUG : BROWSER_OUTPUT: __metrics 02:52:41 INFO - 2015-11-02 02:52:41,619 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:52:42 INFO - 2015-11-02 02:52:42,393 INFO : Browser initialized. 02:52:42 INFO - 2015-11-02 02:52:42,393 INFO : Running cycle 1/1 for kraken test... 02:52:42 INFO - 2015-11-02 02:52:42,394 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/tmpXHD2UM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:52:54 INFO - 2015-11-02 02:52:54,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 200839168 02:52:54 INFO - 2015-11-02 02:52:54,447 DEBUG : BROWSER_OUTPUT: 02:52:57 INFO - 2015-11-02 02:52:57,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58737/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:57 INFO - 2015-11-02 02:52:57,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 264806400 02:52:57 INFO - 2015-11-02 02:52:57,842 DEBUG : BROWSER_OUTPUT: 02:53:00 INFO - 2015-11-02 02:53:00,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58737/tests/kraken/driver.html?testName=audio-dft) 02:53:01 INFO - 2015-11-02 02:53:01,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 279248896 02:53:01 INFO - 2015-11-02 02:53:01,357 DEBUG : BROWSER_OUTPUT: 02:53:04 INFO - 2015-11-02 02:53:04,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58737/tests/kraken/driver.html?testName=audio-fft) 02:53:05 INFO - 2015-11-02 02:53:05,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 266797056 02:53:05 INFO - 2015-11-02 02:53:05,081 DEBUG : BROWSER_OUTPUT: 02:53:07 INFO - 2015-11-02 02:53:07,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58737/tests/kraken/driver.html?testName=audio-oscillator) 02:53:07 INFO - 2015-11-02 02:53:07,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 267579392 02:53:07 INFO - 2015-11-02 02:53:07,882 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-11-02 02:53:10,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:10 INFO - 2015-11-02 02:53:10,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 268206080 02:53:10 INFO - 2015-11-02 02:53:10,849 DEBUG : BROWSER_OUTPUT: 02:53:14 INFO - 2015-11-02 02:53:14,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58737/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:14 INFO - 2015-11-02 02:53:14,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 268865536 02:53:14 INFO - 2015-11-02 02:53:14,838 DEBUG : BROWSER_OUTPUT: 02:53:18 INFO - 2015-11-02 02:53:18,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58737/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:18 INFO - 2015-11-02 02:53:18,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 266395648 02:53:18 INFO - 2015-11-02 02:53:18,922 DEBUG : BROWSER_OUTPUT: 02:53:22 INFO - 2015-11-02 02:53:22,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58737/tests/kraken/driver.html?testName=json-parse-financial) 02:53:22 INFO - 2015-11-02 02:53:22,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 267489280 02:53:22 INFO - 2015-11-02 02:53:22,706 DEBUG : BROWSER_OUTPUT: 02:53:24 INFO - 2015-11-02 02:53:24,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:24 INFO - 2015-11-02 02:53:24,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 298078208 02:53:24 INFO - 2015-11-02 02:53:24,990 DEBUG : BROWSER_OUTPUT: 02:53:26 INFO - 2015-11-02 02:53:26,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58737/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:27 INFO - 2015-11-02 02:53:27,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 300625920 02:53:27 INFO - 2015-11-02 02:53:27,595 DEBUG : BROWSER_OUTPUT: 02:53:29 INFO - 2015-11-02 02:53:29,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:30 INFO - 2015-11-02 02:53:30,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 306847744 02:53:30 INFO - 2015-11-02 02:53:30,451 DEBUG : BROWSER_OUTPUT: 02:53:33 INFO - 2015-11-02 02:53:33,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:33 INFO - 2015-11-02 02:53:33,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 308498432 02:53:33 INFO - 2015-11-02 02:53:33,892 DEBUG : BROWSER_OUTPUT: 02:53:36 INFO - 2015-11-02 02:53:36,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:37 INFO - 2015-11-02 02:53:37,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 308125696 02:53:37 INFO - 2015-11-02 02:53:37,313 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58737/tests/kraken/driver.html?testName=ai-astar) 02:53:39 INFO - 2015-11-02 02:53:39,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 366473216 02:53:39 INFO - 2015-11-02 02:53:39,429 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,429 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:53:39 INFO - 2015-11-02 02:53:39,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:53:39 INFO - 2015-11-02 02:53:39,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:53:39 INFO - 2015-11-02 02:53:39,430 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:53:39 INFO - 2015-11-02 02:53:39,430 DEBUG : BROWSER_OUTPUT: |0;ai-astar;118;125;120;130;131;126;107;121;126;120 02:53:39 INFO - 2015-11-02 02:53:39,430 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;171;149;188;179;148;169;147;185;173;147 02:53:39 INFO - 2015-11-02 02:53:39,430 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;187;189;182;182;181;190;190;189;181 02:53:39 INFO - 2015-11-02 02:53:39,430 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;85;98;140;77;81;81;82;129;77 02:53:39 INFO - 2015-11-02 02:53:39,431 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;109;113;155;102;105;103;149;101;102;142 02:53:39 INFO - 2015-11-02 02:53:39,431 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;141;135;135;140;130;141;135;141;139 02:53:39 INFO - 2015-11-02 02:53:39,431 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;145;141;147;146;147;146;140 02:53:39 INFO - 2015-11-02 02:53:39,431 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;117;118;119;118;118;118;118;119;118 02:53:39 INFO - 2015-11-02 02:53:39,431 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;69;70;71;73;71;73;81;66;68 02:53:39 INFO - 2015-11-02 02:53:39,431 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;73;75;78;78;78;81;81;77;76;76 02:53:39 INFO - 2015-11-02 02:53:39,432 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;96;101;97;96;97;97;97;98;98 02:53:39 INFO - 2015-11-02 02:53:39,432 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;147;140;145;146;149;140;144;141;149;143 02:53:39 INFO - 2015-11-02 02:53:39,432 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;168;168;168;167;169;166;162;165;168 02:53:39 INFO - 2015-11-02 02:53:39,432 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;76;80;79;81;81;80;80;81;80 02:53:39 INFO - 2015-11-02 02:53:39,432 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:53:39 INFO - 2015-11-02 02:53:39,432 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:53:39 INFO - 2015-11-02 02:53:39,433 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,934 02:53:39 INFO - 2015-11-02 02:53:39,433 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:53:39 INFO - 2015-11-02 02:53:39,433 DEBUG : BROWSER_OUTPUT: __startTimestamp1446461619424__endTimestamp 02:53:39 INFO - 2015-11-02 02:53:39,433 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,433 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:53:39 INFO - 2015-11-02 02:53:39,433 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:53:39 INFO - 2015-11-02 02:53:39,434 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,434 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.40 Median:125.50 stddev:6.95 (5.5%) stddev-sans-first:7.18 02:53:39 INFO - 2015-11-02 02:53:39,434 DEBUG : BROWSER_OUTPUT: Values: 118.0 125.0 120.0 130.0 131.0 126.0 107.0 121.0 126.0 120.0 02:53:39 INFO - 2015-11-02 02:53:39,434 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,434 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:165.60 Median:172.00 stddev:16.43 (9.6%) stddev-sans-first:17.31 02:53:39 INFO - 2015-11-02 02:53:39,435 DEBUG : BROWSER_OUTPUT: Values: 171.0 149.0 188.0 179.0 148.0 169.0 147.0 185.0 173.0 147.0 02:53:39 INFO - 2015-11-02 02:53:39,435 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,435 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:185.40 Median:188.00 stddev:3.92 (2.1%) stddev-sans-first:4.06 02:53:39 INFO - 2015-11-02 02:53:39,435 DEBUG : BROWSER_OUTPUT: Values: 183.0 187.0 189.0 182.0 182.0 181.0 190.0 190.0 189.0 181.0 02:53:39 INFO - 2015-11-02 02:53:39,435 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,436 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.50 Median:81.50 stddev:22.55 (27.7%) stddev-sans-first:23.71 02:53:39 INFO - 2015-11-02 02:53:39,436 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 98.0 140.0 77.0 81.0 81.0 82.0 129.0 77.0 02:53:39 INFO - 2015-11-02 02:53:39,436 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,436 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:118.10 Median:111.00 stddev:21.62 (19.5%) stddev-sans-first:22.68 02:53:39 INFO - 2015-11-02 02:53:39,437 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 155.0 102.0 105.0 103.0 149.0 101.0 102.0 142.0 02:53:39 INFO - 2015-11-02 02:53:39,437 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,437 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.30 Median:139.50 stddev:3.68 (2.6%) stddev-sans-first:3.88 02:53:39 INFO - 2015-11-02 02:53:39,437 DEBUG : BROWSER_OUTPUT: Values: 136.0 141.0 135.0 135.0 140.0 130.0 141.0 135.0 141.0 139.0 02:53:39 INFO - 2015-11-02 02:53:39,437 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,437 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:147.00 stddev:2.63 (1.8%) stddev-sans-first:2.71 02:53:39 INFO - 2015-11-02 02:53:39,437 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 145.0 141.0 147.0 146.0 147.0 146.0 140.0 02:53:39 INFO - 2015-11-02 02:53:39,438 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,438 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:118.20 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 02:53:39 INFO - 2015-11-02 02:53:39,438 DEBUG : BROWSER_OUTPUT: Values: 119.0 117.0 118.0 119.0 118.0 118.0 118.0 118.0 119.0 118.0 02:53:39 INFO - 2015-11-02 02:53:39,438 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,438 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.20 Median:71.00 stddev:5.39 (7.6%) stddev-sans-first:4.27 02:53:39 INFO - 2015-11-02 02:53:39,439 DEBUG : BROWSER_OUTPUT: Values: 60.0 69.0 70.0 71.0 73.0 71.0 73.0 81.0 66.0 68.0 02:53:39 INFO - 2015-11-02 02:53:39,439 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,439 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:77.30 Median:78.00 stddev:2.50 (3.2%) stddev-sans-first:2.11 02:53:39 INFO - 2015-11-02 02:53:39,439 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 78.0 78.0 78.0 81.0 81.0 77.0 76.0 76.0 02:53:39 INFO - 2015-11-02 02:53:39,439 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,439 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:97.00 stddev:2.49 (2.6%) stddev-sans-first:1.51 02:53:39 INFO - 2015-11-02 02:53:39,439 DEBUG : BROWSER_OUTPUT: Values: 91.0 96.0 101.0 97.0 96.0 97.0 97.0 97.0 98.0 98.0 02:53:39 INFO - 2015-11-02 02:53:39,440 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,440 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:145.50 stddev:3.41 (2.3%) stddev-sans-first:3.48 02:53:39 INFO - 2015-11-02 02:53:39,440 DEBUG : BROWSER_OUTPUT: Values: 147.0 140.0 145.0 146.0 149.0 140.0 144.0 141.0 149.0 143.0 02:53:39 INFO - 2015-11-02 02:53:39,440 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,440 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:168.00 stddev:2.54 (1.5%) stddev-sans-first:2.17 02:53:39 INFO - 2015-11-02 02:53:39,440 DEBUG : BROWSER_OUTPUT: Values: 162.0 168.0 168.0 168.0 167.0 169.0 166.0 162.0 165.0 168.0 02:53:39 INFO - 2015-11-02 02:53:39,441 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-02 02:53:39,441 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.10 Median:80.00 stddev:2.60 (3.3%) stddev-sans-first:1.56 02:53:39 INFO - 2015-11-02 02:53:39,441 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 80.0 79.0 81.0 81.0 80.0 80.0 81.0 80.0 02:53:39 INFO - 2015-11-02 02:53:39,443 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:53:39 INFO - 2015-11-02 02:53:39,443 DEBUG : BROWSER_OUTPUT: 02:53:40 INFO - 2015-11-02 02:53:40,141 INFO : Browser exited with error code: 0 02:53:40 INFO - 2015-11-02 02:53:40,198 INFO : Completed test kraken (00:01:01) 02:53:40 INFO - 2015-11-02 02:53:40,198 INFO : Starting test v8_7 02:53:40 INFO - 2015-11-02 02:53:40,198 DEBUG : operating with platform_type : mac_ 02:53:40 INFO - 2015-11-02 02:53:40,198 INFO : Initialising browser for v8_7 test... 02:53:40 INFO - 2015-11-02 02:53:40,215 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/tmpd0X8fW/profile http://localhost:58737/getInfo.html 02:53:42 INFO - 2015-11-02 02:53:42,592 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:53:42 INFO - 2015-11-02 02:53:42,593 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:53:42 INFO - 2015-11-02 02:53:42,593 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:53:42 INFO - 2015-11-02 02:53:42,593 DEBUG : BROWSER_OUTPUT: __metrics 02:53:42 INFO - 2015-11-02 02:53:42,610 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:53:43 INFO - 2015-11-02 02:53:43,350 INFO : Browser initialized. 02:53:43 INFO - 2015-11-02 02:53:43,351 INFO : Running cycle 1/1 for v8_7 test... 02:53:43 INFO - 2015-11-02 02:53:43,351 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/T/tmpd0X8fW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:53:55 INFO - 2015-11-02 02:53:55,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 200237056 02:53:55 INFO - 2015-11-02 02:53:55,387 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58737/tests/v8_7/run.html (next: http://localhost:58737/tests/v8_7/run.html) 02:54:18 INFO - 2015-11-02 02:54:18,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 518742016 02:54:18 INFO - 2015-11-02 02:54:18,490 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,490 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:54:18 INFO - 2015-11-02 02:54:18,491 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:54:18 INFO - 2015-11-02 02:54:18,491 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:54:18 INFO - 2015-11-02 02:54:18,491 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:54:18 INFO - 2015-11-02 02:54:18,491 DEBUG : BROWSER_OUTPUT: |0;Richards;186.6368047779022 02:54:18 INFO - 2015-11-02 02:54:18,491 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;219.6836555360281 02:54:18 INFO - 2015-11-02 02:54:18,491 DEBUG : BROWSER_OUTPUT: |2;Encrypt;365.89828027808267 02:54:18 INFO - 2015-11-02 02:54:18,491 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6856.164383561644 02:54:18 INFO - 2015-11-02 02:54:18,492 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1179.0341578327443 02:54:18 INFO - 2015-11-02 02:54:18,492 DEBUG : BROWSER_OUTPUT: |5;Earley;799.3605115907275 02:54:18 INFO - 2015-11-02 02:54:18,492 DEBUG : BROWSER_OUTPUT: |6;Boyer;14514.285714285714 02:54:18 INFO - 2015-11-02 02:54:18,492 DEBUG : BROWSER_OUTPUT: |7;RegExp;33383.333333333336 02:54:18 INFO - 2015-11-02 02:54:18,492 DEBUG : BROWSER_OUTPUT: |8;Splay;669.5536309127249 02:54:18 INFO - 2015-11-02 02:54:18,492 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6555.555555555556 02:54:18 INFO - 2015-11-02 02:54:18,492 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:54:18 INFO - 2015-11-02 02:54:18,492 DEBUG : BROWSER_OUTPUT: __startTimestamp1446461658488__endTimestamp 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.64 Median:186.64 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: Values: 186.6 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:219.68 Median:219.68 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: Values: 219.7 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:365.90 Median:365.90 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: Values: 365.9 02:54:18 INFO - 2015-11-02 02:54:18,493 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6856.16 Median:6856.16 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: Values: 6856.2 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1179.03 Median:1179.03 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: Values: 1179.0 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: Values: 799.4 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14514.29 Median:14514.29 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,494 DEBUG : BROWSER_OUTPUT: Values: 14514.3 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33383.33 Median:33383.33 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: Values: 33383.3 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:669.55 Median:669.55 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: Values: 669.6 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6555.56 Median:6555.56 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: Values: 6555.6 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:54:18 INFO - 2015-11-02 02:54:18,495 DEBUG : BROWSER_OUTPUT: 02:54:19 INFO - 2015-11-02 02:54:19,214 INFO : Browser exited with error code: 0 02:54:19 INFO - 2015-11-02 02:54:19,238 INFO : Completed test v8_7 (00:00:39) 02:54:19 INFO - 2015-11-02 02:54:19,715 INFO : Completed test suite (00:20:15) 02:54:19 INFO - 2015-11-02 02:54:19,715 DEBUG : Working with test: dromaeo_css 02:54:19 INFO - 2015-11-02 02:54:19,715 DEBUG : Generating results file: dromaeo_css 02:54:19 INFO - 2015-11-02 02:54:19,716 DEBUG : Working with test: kraken 02:54:19 INFO - 2015-11-02 02:54:19,716 DEBUG : Generating results file: kraken 02:54:19 INFO - 2015-11-02 02:54:19,716 INFO : javascript benchmark 02:54:19 INFO - 2015-11-02 02:54:19,716 DEBUG : Working with test: v8_7 02:54:19 INFO - 2015-11-02 02:54:19,717 DEBUG : Generating results file: v8_7 02:54:19 INFO - 2015-11-02 02:54:19,717 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:19 INFO - 2015-11-02 02:54:19,769 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 02:54:19 INFO - 2015-11-02 02:54:19,769 DEBUG : process_Request line: dromaeo_css 5955.47 graph.html#tests=[[72,52,55]] 02:54:19 INFO - 2015-11-02 02:54:19,769 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:19 INFO - 2015-11-02 02:54:19,797 DEBUG : process_Request line: kraken 1719.90 graph.html#tests=[[232,52,55]] 02:54:19 INFO - 2015-11-02 02:54:19,797 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:19 INFO - 2015-11-02 02:54:19,825 DEBUG : process_Request line: v8_7 17724.27 graph.html#tests=[[230,52,55]] 02:54:19 INFO - 2015-11-02 02:54:19,826 INFO : javascript benchmark 02:54:19 INFO - 2015-11-02 02:54:19,828 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [306.86958042831805, 307.7691731201599, 312.97652676049296, 318.271159045785, 319.7761566903168, 12977.416016279267, 13440.462381504753, 15210.619734506628, 15384.000039997407, 15730.370785168594, 13370.465181392732, 15399.846001540009, 15826.683466330667, 16272.918635406835, 16491.91754041228, 4544.772761361935, 4556.20266453371, 4739.454962679284, 4758.072175925696, 4779.0, 3561.7684850484766, 3669.2661467706566, 4716.882077948062, 4730.668853180278, 4986.4514903360605, 5040.97479512602, 5086.364204474441, 5101.948980510185, 5111.846644600668, 5165.509276618734, 4996.350474438318, 5097.84706458805, 5176.482351764794, 5204.947950520522, 5257.684538927677, 4531.274996000624, 4555.293929440942, 4555.567221113989, 4556.066006468666, 4558.635309175291, 19124.5218869528, 19218.615627687508, 19550.0, 19608.0, 19839.30562430308, 1754.8069712331633, 1763.7089880169756, 1768.3810666266832, 1815.664102141108, 1829.7529833472445, 11864.169508134433, 12125.93937030318, 12348.197367171195, 12609.873901260962, 12653.30406827624, 1473.9705205895823, 1511.780791785196, 1526.1224795742492, 1557.1746974103744, 1571.2772124822595, 49137.26294105591, 51594.742026290005, 53157.73421132908, 54704.72647636737, 56595.15107273394, 5910.497607703307, 6001.969990150022, 6004.3395226525045, 6028.57799953999, 6030.366811484819, 6872.244053154149, 6872.793816185523, 6912.792616221522, 6913.481488888253, 6923.342282483156, 5121.513456221727, 5136.743162841843, 5152.639315247971, 5156.329677141947, 5185.092608793446, 5556.499915007668, 5569.526590239875, 5610.551155907518, 5647.519960803378, 5654.869026194778, 2657.8538180400265, 2685.2615530729204, 2707.1066548039494, 2715.321169707573, 2719.877605507757, 925.5511077127587, 961.9374740641836, 989.5448093876897, 1002.5839276700234, 1009.4851625670814, 355.8398720575751, 364.6790824074797, 384.73645552796427, 390.5391637867344, 392.7918203352228, 10278.0, 10482.63310784119, 10557.419341936115, 10630.30902991303, 10717.785644287227, 401.5943896664332, 403.38081045594873, 403.39289369498715, 403.8041549848321, 404.2924881457449, 5609.887802244014, 5735.684537350486, 5866.266716660418, 5993.820185394445, 5998.190244317048, 523543.0, 524379.0, 546031.0, 552648.0, 553987.0, 65901.0, 66511.66744166249, 66687.3331266681, 67132.0, 67154.32845671481, 407.8164825828389, 421.1639894808802, 423.50449973531045, 452.62884434763833, 468.96826980642044, 9485.146336829719, 9736.902630973884, 10071.446070466194, 10123.544440500047, 10148.492575371349, 31488.685113148575, 31780.523292151098, 32061.519077213394, 32095.197620059684, 32898.83550582232, 44780.77609611931, 44796.77601611971, 44933.32600010937, 45998.0, 46005.76997114993, 5494.670319780826, 5506.697131657797, 5543.8891222174525, 5548.112302031655, 5609.579281553982, 10507.737306567396, 10704.678859634223, 10835.620753273597, 11025.503852326505, 11040.171987100839, 9389.0, 9400.905990940004, 9411.152996230372, 9511.857322140311, 9528.190103840974, 8998.14517620825, 9102.544872756469, 9192.0, 9325.300602454707, 9360.438373697327, 7822.178671239665, 8872.378933474594, 9365.812683746151, 9629.374090684083, 9730.95134524323, 5299.0, 5373.5432488237375, 5509.944900551103, 5629.8592535186945, 5662.716864156858, 9005.279577633642, 9155.313351498797, 9271.67549135777, 9292.117248861347, 9303.581338839633], "dojo.html": [2790.9720902790973, 2838.332991746939, 2840.3325218573646, 2879.6256486656744, 2885.3940672458784, 4780.976095119519, 4792.7603619819, 4828.299896515012, 4837.7339246341435, 4851.68464049837, 4790.880227994293, 4807.783649735761, 4808.975955120228, 4833.202521583935, 4833.347498087757, 4485.842995495158, 4517.209488339544, 4528.298113792367, 4556.3621093047, 4618.515055919131, 4584.7936842842155, 4605.953940460603, 4612.630989520847, 4625.62994960404, 4637.397138372007, 4538.364628951949, 4576.3821884045565, 4593.586577208051, 4600.0, 4617.14582802181, 4527.3888025116685, 4624.352590637313, 4630.805311981817, 4634.096351211515, 4682.438107427113, 4613.308003799423, 4619.607333376667, 4637.559431853969, 4641.0, 4652.348671186037, 4566.725996440225, 4603.815847366135, 4658.208104622188, 4868.221084626478, 4886.755662216875, 5016.3980322361185, 5142.537171654569, 5144.0740666679985, 5154.355705536808, 5181.637285390024, 5226.5818734501145, 5299.8410047698635, 5371.919421208685, 5383.973080134613, 5384.865378365533, 4737.24204127338, 4794.9280760788615, 4797.496262892346, 4993.0263598598285, 5006.799728010911, 5246.63273570854, 5446.809361672323, 5452.073147564924, 5476.972615136899, 5504.394516603171, 5138.845834624967, 5185.507376799198, 5188.714620695898, 5199.376074871039, 5230.0, 5026.0, 5131.589472842164, 5149.45930677281, 5319.2021196820015, 5369.033573956725, 5055.115354812893, 5084.415292241366, 5137.383513978271, 5150.845474635767, 5153.742312884341, 5150.613703972217, 5155.793768249303, 5162.561182299547, 5171.456997015334, 5183.714895680699, 3924.2543916655745, 3981.5620281768984, 4034.798260086984, 4069.1658210066867, 4072.837086516506, 3564.500969864221, 3633.3823250047553, 3641.6540428659237, 3647.434647629622, 3659.14010207601, 4913.06651736169, 4923.975380123076, 4926.064047830901, 4933.802647894044, 4954.281629163751, 4948.05986862495, 5049.57078648319, 5254.15933450646, 5274.103402421598, 5283.181106928432, 4809.5430934061205, 4842.7336496493035, 4871.537203965689, 4944.653874228769, 4993.275974983607, 4608.585227329557, 4620.907581848344, 4634.86095417138, 4642.46611639659, 4653.441587009581, 5329.413764485904, 5343.064963631271, 5344.144936810092, 5347.572194224453, 5347.679139251657, 5048.495150484922, 5097.311862898609, 5129.692218466904, 5182.844514664566, 5266.605004624592, 5337.119375303187, 5356.089464790917, 5357.249985002025, 5388.946110538845, 5391.86520336979, 5213.191955246943, 5230.398504171917, 5237.057329680694, 5240.082985477602, 5270.920936185884, 4904.558589726942, 5015.2978582997675, 5036.597072234285, 5143.0999575073465, 5321.9467805323, 4989.600831933364, 5138.254953031864, 5201.869953251199, 5203.947960520346, 5223.5559977402345, 5206.0368831766245, 5228.816991405282, 5236.293100431545, 5257.185136303879, 5257.5005374489365, 4851.054044461296, 4973.577245934136, 5105.285260063668, 5125.564327032244, 5129.358830146231, 4901.803927842989, 4993.700377977333, 4997.3253610762085, 5000.2499625056535, 5061.063703214917, 5026.798928042837, 5039.118154323052, 5072.492750724898, 5081.5426611605135, 5090.847274581768], "mootools.html": [1166.2128063557097, 1497.8726808221302, 1584.7068292365914, 1609.0667412900516, 1626.6258760485089, 6351.2060992375955, 6735.966320168399, 6861.0, 6866.82832929177, 6876.484263680219, 6638.203415590124, 6665.600063996151, 6808.353206445379, 6851.314868513146, 6897.862042759142, 1975.7727861295955, 1990.64168449679, 1991.8605697601174, 2002.6595478768572, 2006.839452843769, 1961.9215231390726, 1979.703044543323, 1986.165810359645, 1994.4216177308563, 1996.820286174244, 1886.1795119123158, 1894.4316704988448, 1895.7251198576198, 1898.8765730227492, 1899.4681489183051, 1859.907004649762, 1864.459306801026, 1896.3078476356031, 1897.8291953724163, 1898.686716691744, 1913.2920819296949, 1917.0, 1937.8546609004381, 1939.6702560564597, 1956.4032969944162, 5999.520038396918, 6256.655883926383, 6755.39201471865, 6801.0, 6813.488988325846, 4004.699647526418, 4112.0, 4112.321466957948, 4143.399207114981, 4150.667946564267, 2451.82837201396, 2490.8380955237853, 2491.202815099169, 2504.8371855829496, 2525.5201511712717, 714.9821254468628, 721.9458540609476, 754.110952065079, 754.2080815144132, 756.6065645864174, 8985.0, 9111.908880911173, 9126.543672816333, 9132.771680707969, 9150.86273705895, 3651.0689774107964, 3705.4627079073384, 3762.4168253920684, 3777.660010599059, 3781.243751249706, 7486.288802563748, 7501.699932002768, 7501.737439189602, 7505.399568034544, 7544.660490277951, 4165.687573432005, 4222.4299719538085, 4229.323308270662, 4229.725067870579, 4235.0, 3924.3132451820816, 3930.037140900498, 3930.1353702185475, 3947.0527073502153, 3954.367301231847, 2858.0711268837713, 2873.8994135205166, 2877.510823160068, 2897.0729366602905, 2916.2709322669334, 908.4912449028565, 916.3219217778795, 918.6371383303558, 925.0518218825757, 925.8055808280202, 1149.5286932357694, 1166.1894982986744, 1195.2888031621171, 1197.3534291482501, 1197.874223206568, 6219.564630475914, 6267.65527895961, 6272.278687950853, 6515.51133664977, 6576.934230657728, 437.2304743651197, 438.4344195987141, 441.34680672604725, 447.5569186505401, 447.75149791865175, 4933.654644174945, 4954.281629163751, 4969.577585905166, 4980.551750342486, 4989.55094041538, 8015.879761803461, 8093.919060809434, 8229.876551851727, 8235.21765432283, 8310.70912518071, 7468.663910123949, 7619.657115429708, 7731.7680469586, 7849.097353804272, 7869.724559640385, 6455.354464553507, 6519.087327774116, 6529.2817790043055, 6563.1796025496815, 6603.834904127435, 6414.61512309263, 6476.352364763486, 6577.80266592003, 6578.111954886221, 6597.967010164918, 7029.929700702927, 7398.2231865655485, 7400.370968467741, 7424.517406368569, 7432.405407567274, 7416.8887466686965, 7549.358304544176, 7569.772906812805, 7620.885686714593, 7684.039495063117, 6122.448979591858, 6201.627902325875, 6223.657698826608, 6240.812775616739, 6247.5939063960695, 6685.832854178684, 6699.76550820719, 6731.1922569292, 6738.427233685192, 6742.831429214309, 6256.311805701278, 6289.622622642473, 6332.778352757631, 6343.714532845941, 6348.079528468254, 6197.5351848610635, 6224.097505861715, 6244.313125556276, 6278.780242691484, 6346.7143978522, 6265.27949285838, 6299.149614802126, 6308.27454842699, 6321.241451025906, 6384.553081284265, 5719.542436605145, 5721.456461636138, 5762.135679648086, 5806.6806325650805, 5814.94185058144, 5721.57088218377, 5756.251687280626, 5841.620294680833, 5842.7662893485485, 5861.062230043343], "ext.html": [504.5055845271636, 505.7825135191868, 513.9588832893369, 517.1570340345238, 525.485024675818, 28886.277843053907, 32116.67883321166, 32794.18014549634, 32820.507692384635, 33334.0, 36846.447303290406, 37599.0, 37614.0596485088, 37694.8115259424, 38319.61680383195, 7502.099748030244, 7640.388768898502, 8051.235132662402, 8223.383246256524, 8299.83400331993, 9694.418334899894, 9717.271204659644, 9920.206383489303, 9951.701448956543, 9970.65102721405, 9588.0, 9657.661981830637, 9699.0, 9714.854277185848, 9719.0, 7727.922720772833, 7878.72424465141, 9560.713178604654, 9691.0, 9772.21822254218, 9449.196818270455, 9608.903910960871, 9617.182539484082, 9654.90345096547, 9705.223582113415, 34507.6549234507, 34820.65179348225, 34853.82573087118, 34952.82523587366, 35520.64479355225, 2793.2458236276293, 2824.237455886899, 2838.233676907244, 2923.6053132827224, 3132.9216769580944, 24516.0, 24820.0, 25076.874615626988, 25804.0, 25842.224733258034, 2186.6610675345346, 2189.0587047569697, 2189.168116115866, 2195.7145571075816, 2199.0104452996216, 235878.0, 236089.99999999828, 236415.0, 237791.0, 238000.0, 52015.73992130015, 52424.73787631038, 52432.47567524352, 52769.736151319, 52884.0, 52699.736501317246, 53006.204906926425, 53752.19371709428, 54115.45884541104, 54209.457905420444, 14999.32503037344, 15519.0, 15573.454929077428, 15708.528744137695, 15755.212239388215, 12051.276923384625, 12088.75822483563, 12200.816987745191, 12201.694957625952, 12229.816552751716, 16616.6676666466, 16855.157242137844, 16915.57711057209, 16923.492295231164, 16936.745948810778, 6795.864082718318, 6877.759278425231, 6918.377346038881, 6920.30796920314, 6929.861402771916, 808.7129069180356, 873.2271939333735, 882.188386684252, 886.1802832380023, 900.2707806676613, 25481.87259063693, 25695.100671476408, 25887.0939517116, 25947.22158335253, 25995.090171843894, 849.6983570832389, 938.5166639180827, 1002.8144793213279, 1044.4099084017657, 1076.445630500293, 9876.0, 12762.17045892014, 12787.680307992374, 12809.935950320189, 12948.223106613634, 279037.0, 283336.0, 290665.0, 378551.0, 382523.0, 40010.59989400127, 40213.798931005746, 40602.79698601488, 40613.79693101515, 41261.58738412578, 1084.3981590217504, 1160.7504386556761, 1181.285322379965, 1248.7440074784647, 1282.615215435347, 23583.52832943297, 23703.762962370845, 25137.24588262355, 25201.621975670747, 25285.494290114464, 38501.22997540089, 38705.41941870818, 38722.80638596789, 38724.612753873225, 38895.222095557365, 210009.0, 210194.0, 210839.0, 213246.0, 213590.0, 27215.0, 27567.862160689067, 27887.860560697067, 27942.0, 28054.0, 35210.47184292186, 35841.641583584875, 36170.819145904105, 36486.0, 36498.635013650586, 29856.402871942006, 30400.239994000327, 30471.0, 30496.847515762278, 30543.0, 30397.392052159274, 30529.23676908095, 30554.388912221188, 30612.84693576607, 30705.232369190948, 29898.252543686584, 30000.849995750756, 30523.38953220879, 30649.693503064686, 31145.0, 25372.873135634203, 26768.59847102334, 26922.0, 26932.730672693022, 27239.72760272372, 21044.0, 21278.680819787405, 21343.78656213418, 21351.67972480445, 21564.0], "prototype.html": [258.4972229014566, 268.8010871954753, 268.8118516158579, 273.1763732346973, 276.40572768547634, 5276.182191760274, 5377.059014672436, 5387.865303367413, 5403.135498320269, 5409.9459005409935, 5218.634695571312, 5290.92063619046, 5299.125644268701, 5330.760115794789, 5345.278387417698, 4132.999999999993, 4145.481814773153, 4170.145120250357, 4180.937285940713, 4198.601132892386, 4024.154927465221, 4083.612056854594, 4094.8362065517344, 4158.480189976253, 4168.083021735229, 4107.979460102695, 4117.114820313632, 4120.464339635843, 4138.875833724993, 4143.792810359485, 4075.8369665213504, 4100.712950093494, 4117.1765646870745, 4136.400221967798, 4155.10665206979, 3471.392506311385, 3531.9117022074397, 3537.2925414916863, 3558.87543935961, 3569.446735755962, 5078.97460512695, 5161.329027226437, 5174.586033117342, 5189.195674670432, 5266.710330931797, 4597.885052873671, 4635.490096089427, 4647.18674232008, 4650.837220697294, 4655.534446555317, 5612.7754889804355, 5619.466150715675, 5633.943660563383, 5649.322081350223, 5650.039493286151, 3687.704983601332, 3751.662350388478, 3769.830357633913, 3793.2982398256413, 3815.561210460805, 5812.505936995361, 5858.824235272906, 5872.765089396419, 5899.203607512974, 5975.014122669711, 3852.0, 3852.056246219638, 3852.8651497197466, 3877.2245550889934, 3912.2371137628456, 3900.687944964396, 3907.4529565860234, 3915.882523524299, 3920.2747491713553, 3958.802059896994, 4468.597826195658, 4599.517050709695, 4616.792244349012, 4622.214223581999, 4685.9765701171955, 5615.298087739033, 5660.745266463019, 5665.5184309333345, 5705.22979397776, 5705.942940570624, 1407.8099456573232, 1417.5534706567605, 1419.09887221615, 1420.4673247532176, 1423.679672073775, 900.7252787899622, 918.1323649151622, 919.3610440743753, 928.9349745517749, 930.1628534319032, 5464.28964234647, 5468.699221542774, 5473.452654734495, 5488.313960754906, 5493.176023596492, 5886.852828679317, 5904.1734157218025, 5912.615679980788, 5940.287165540163, 5950.940490595125, 5481.314835645544, 5488.368837583649, 5503.036968530491, 5522.088855338824, 5535.972320138373, 3178.7139157475476, 3235.8382080895863, 3252.9674703252663, 3255.137388592025, 3289.7697161198485, 5929.703514824241, 5929.822105336847, 5930.525557955353, 5935.347111817697, 6020.969895150496, 6014.879702405928, 6017.368176341509, 6021.096835474714, 6055.091736239599, 6081.726322315418, 5817.70911454434, 5889.764409423575, 5895.970520147372, 5918.082697181943, 5961.880762384815, 5852.94147058524, 5945.791897283574, 5953.166556681981, 5973.104034394875, 6032.517398608188, 5560.082586373203, 5662.745176467151, 5665.801696940587, 5855.063189889597, 5877.970610146922, 5844.26946631671, 5906.055031194988, 5937.495312898452, 5957.136215248678, 5983.670898100472, 3646.8358923849023, 3688.428293614494, 3691.57546882112, 3692.9815350923072, 3697.500837386918, 5856.092305692625, 5897.911531326948, 5898.469137777621, 5948.315943666534, 5956.225690660186, 5569.721513924206, 5682.488576028178, 5695.7436915338085, 5716.942830571641, 5737.512311453574, 5636.379998200113, 5667.773289068391, 5687.033204355187, 5720.885582288414, 5736.397678243724, 5537.861553461195, 5559.8888022240135, 5563.332400112013, 5569.693666848362, 5580.38615752275, 5519.254900588369, 5684.232628595252, 5690.402507736628, 5770.365259821332, 5783.710814459344, 5637.943620563742, 5645.548356131418, 5654.378018417889, 5659.660420374791, 5763.423657634203], "yui.html": [667.14838607501, 671.4024518178821, 677.8169894128586, 678.2810221165565, 690.9136357955259, 12189.634310970663, 12549.372531373429, 12694.555690550833, 12704.682382940407, 12713.809292860615, 11807.0, 11824.349660768676, 12372.752544949095, 12389.442475088621, 12398.690032749186, 650.3756393861898, 663.151166506872, 791.1692722641233, 810.2383759266271, 822.6832669422286, 795.4749865089043, 796.3271035974592, 804.6379129391768, 812.9552874591895, 815.5269943432795, 828.4283844147549, 845.5434065604566, 846.5597889097666, 848.8429640516524, 850.5492089192707, 665.6372277108987, 676.9898451523231, 822.8436597046542, 840.1556435782061, 849.6856163219618, 615.8829822333787, 620.2092332276338, 624.0265186309326, 624.8094331228973, 626.7712285015982, 12415.379231038502, 12549.937250313782, 12572.119951603392, 12573.685657858627, 12598.559050433283, 10402.47987600617, 10622.840657390145, 10952.28810127347, 11134.665960021212, 11284.097272218203, 8331.458455200393, 8589.785255368666, 8610.268127209132, 8753.44770932698, 8864.601092950832, 2943.543750718642, 2966.8813247470075, 3006.4137493188837, 3023.8034527755626, 3051.0999255219763, 44722.77638611819, 44776.3283550747, 44885.77557112226, 44912.77543612294, 46520.30219546743, 8265.504069755834, 8405.117462666332, 8480.15198480147, 8507.447015943944, 8532.317414606816, 17753.289868405118, 17762.733558996624, 17798.288068477374, 17882.91058544699, 17950.461486155436, 6188.1027251048345, 6441.3880681335195, 6441.742330306735, 6563.671816409161, 6759.425448836806, 3465.376232278214, 3498.772579782306, 3523.8061906595385, 3551.4317709166926, 3605.594170014815, 2634.670666166729, 2687.0460986349954, 2690.2198362475056, 2690.367763575558, 2715.809893307489, 424.4079509084809, 436.3934131557138, 446.4196544492147, 446.7141029740968, 449.4875841540646, 409.33483089978785, 417.9310413781692, 421.2396624093541, 438.10844930566145, 548.5611510791351, 7212.963935180291, 7235.2402997684485, 7306.634668266565, 7354.595497247703, 7455.739049133254, 378.3454623501358, 411.8949667834743, 460.29344955493156, 526.5103453788014, 532.4196625678029, 3349.43059679855, 3362.2939182771893, 3639.1811842335264, 3720.3861362875364, 3747.6627103560263, 49938.98870050846, 50359.24461133086, 50594.49405505972, 50692.49307506878, 50871.745641271555, 45155.0, 45612.543874561496, 45888.3116753249, 45953.0, 46153.07693846104, 42885.999999999374, 42979.140417191484, 43194.0, 43392.3491147633, 43828.0, 7286.162091359562, 7335.816604584928, 7377.668004939684, 7390.482666213314, 7648.311651951351, 32772.672273277916, 32781.344373111926, 33763.32473350568, 33807.49288760621, 34016.97949061532, 38507.80746096252, 40475.1904961905, 40699.79650101731, 42684.78657606692, 43202.35196471993, 7182.317679820409, 7311.159216689936, 7342.164458885279, 7357.742479013209, 7430.517016393917, 8147.75556733299, 9048.185663290336, 9916.099920547264, 9953.973794356667, 10130.13893819004, 9466.0, 9472.28957828152, 9490.0, 9575.138237558374, 9629.181519570915, 9380.718578442658, 9399.671011514563, 9465.905340946503, 9495.38280011797, 9513.571889265138, 9339.626414943326, 9372.250219982521, 9395.671151509938, 9422.340436169403, 9506.0, 8339.916600833914, 8443.620037098222, 8598.61306241233, 8625.784355391166, 9110.180083792491, 8164.959175204086, 8546.401751877558, 8559.186877246651, 8735.781605459915, 8868.778280543038]}, "summary": {"suite": 5955.472752532907, "subtests": {"jquery.html": {"filtered": 6382.6133322941705, "value": 6382.6133322941705}, "dojo.html": {"filtered": 4830.779888026466, "value": 4830.779888026466}, "mootools.html": {"filtered": 3819.2056245726862, "value": 3819.2056245726862}, "ext.html": {"filtered": 16312.207210313381, "value": 16312.207210313381}, "prototype.html": {"filtered": 4238.779705062865, "value": 4238.779705062865}, "yui.html": {"filtered": 5479.14258169073, "value": 5479.14258169073}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0064"}, "testrun": {"date": 1446460444, "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": "20151102014533", "branch": "Mozilla-Aurora", "revision": "7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679"}}, {"talos_counters": {}, "results": {"audio-dft": [183.0, 187.0, 189.0, 182.0, 182.0, 181.0, 190.0, 190.0, 189.0, 181.0], "ai-astar": [118.0, 125.0, 120.0, 130.0, 131.0, 126.0, 107.0, 121.0, 126.0, 120.0], "imaging-gaussian-blur": [136.0, 141.0, 135.0, 135.0, 140.0, 130.0, 141.0, 135.0, 141.0, 139.0], "audio-beat-detection": [171.0, 149.0, 188.0, 179.0, 148.0, 169.0, 147.0, 185.0, 173.0, 147.0], "json-stringify-tinderbox": [73.0, 75.0, 78.0, 78.0, 78.0, 81.0, 81.0, 77.0, 76.0, 76.0], "stanford-crypto-pbkdf2": [162.0, 168.0, 168.0, 168.0, 167.0, 169.0, 166.0, 162.0, 165.0, 168.0], "json-parse-financial": [60.0, 69.0, 70.0, 71.0, 73.0, 71.0, 73.0, 81.0, 66.0, 68.0], "stanford-crypto-sha256-iterative": [73.0, 76.0, 80.0, 79.0, 81.0, 81.0, 80.0, 80.0, 81.0, 80.0], "audio-fft": [85.0, 85.0, 98.0, 140.0, 77.0, 81.0, 81.0, 82.0, 129.0, 77.0], "imaging-darkroom": [147.0, 147.0, 147.0, 145.0, 141.0, 147.0, 146.0, 147.0, 146.0, 140.0], "stanford-crypto-ccm": [147.0, 140.0, 145.0, 146.0, 149.0, 140.0, 144.0, 141.0, 149.0, 143.0], "audio-oscillator": [109.0, 113.0, 155.0, 102.0, 105.0, 103.0, 149.0, 101.0, 102.0, 142.0], "stanford-crypto-aes": [91.0, 96.0, 101.0, 97.0, 96.0, 97.0, 97.0, 97.0, 98.0, 98.0], "imaging-desaturate": [119.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0]}, "summary": {"suite": 1719.8999999999999, "subtests": {"audio-fft": {"filtered": 93.5, "value": 93.5}, "stanford-crypto-pbkdf2": {"filtered": 166.3, "value": 166.3}, "audio-beat-detection": {"filtered": 165.6, "value": 165.6}, "stanford-crypto-ccm": {"filtered": 144.4, "value": 144.4}, "imaging-darkroom": {"filtered": 145.3, "value": 145.3}, "json-parse-financial": {"filtered": 70.2, "value": 70.2}, "audio-oscillator": {"filtered": 118.1, "value": 118.1}, "ai-astar": {"filtered": 122.4, "value": 122.4}, "audio-dft": {"filtered": 185.4, "value": 185.4}, "stanford-crypto-sha256-iterative": {"filtered": 79.1, "value": 79.1}, "json-stringify-tinderbox": {"filtered": 77.3, "value": 77.3}, "imaging-gaussian-blur": {"filtered": 137.3, "value": 137.3}, "stanford-crypto-aes": {"filtered": 96.8, "value": 96.8}, "imaging-desaturate": {"filtered": 118.2, "value": 118.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0064"}, "testrun": {"date": 1446460444, "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": "20151102014533", "branch": "Mozilla-Aurora", "revision": "7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679"}}, {"talos_counters": {}, "results": {"DeltaBlue": [219.6836555360281], "Encrypt": [365.89828027808267], "NavierStokes": [6555.555555555556], "Decrypt": [6856.164383561644], "Splay": [669.5536309127249], "Richards": [186.6368047779022], "RegExp": [33383.333333333336], "Earley": [799.3605115907275], "Boyer": [14514.285714285714], "RayTrace": [1179.0341578327443]}, "summary": {"suite": 17724.271755104794, "subtests": {"DeltaBlue": {"filtered": 300.9691360000001, "value": 300.9691360000001}, "Encrypt": {"filtered": 727.4726729999999, "value": 727.4726729999999}, "NavierStokes": {"filtered": 226.372881355932, "value": 226.372881355932}, "Decrypt": {"filtered": 38.823602397602365, "value": 38.823602397602365}, "Splay": {"filtered": 121.70944378109456, "value": 121.70944378109456}, "RegExp": {"filtered": 27.28861707438841, "value": 27.28861707438841}, "Richards": {"filtered": 189.148116, "value": 189.148116}, "Earley": {"filtered": 833.7452129999997, "value": 833.7452129999997}, "Boyer": {"filtered": 45.917726377952725, "value": 45.917726377952725}, "RayTrace": {"filtered": 627.6230379620382, "value": 627.6230379620382}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0064"}, "testrun": {"date": 1446460444, "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": "20151102014533", "branch": "Mozilla-Aurora", "revision": "7dae432ad7a994916ddfc7f7f1e2ae9ca1bec679"}}] 02:54:19 INFO - RETURN: dromaeo_css: 5955.47 02:54:19 INFO - RETURN: kraken: 1719.90 02:54:19 INFO - RETURN: v8_7: 17724.27 02:54:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17724.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1719.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5955.47"}}} 02:54:19 INFO - Return code: 0 02:54:19 INFO - # TBPL SUCCESS # 02:54:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:19 INFO - 2015-11-02 02:54:19.920 screenresolution[3432:36257] starting screenresolution argv=screenresolution get 02:54:19 INFO - 2015-11-02 02:54:19.923 screenresolution[3432:36257] Display 0: 1600x1200x32@60 02:54:19 INFO - 2015-11-02 02:54:19.930 screenresolution[3433:36260] starting screenresolution argv=screenresolution list 02:54:19 INFO - Available Modes on Display 0 02:54:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:20 INFO - Intel HD Graphics 3000: 02:54:20 INFO - Chipset Model: Intel HD Graphics 3000 02:54:20 INFO - Type: GPU 02:54:20 INFO - Bus: Built-In 02:54:20 INFO - VRAM (Total): 512 MB 02:54:20 INFO - VRAM (Dynamic, Max): 10 02:54:20 INFO - Vendor: Intel (0x8086) 02:54:20 INFO - Device ID: 0x0116 02:54:20 INFO - Revision ID: 0x0009 02:54:20 INFO - Displays: 02:54:20 INFO - Display: 02:54:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:20 INFO - Display Serial Number: 1600x1200 60 02:54:20 INFO - Main Display: Yes 02:54:20 INFO - Mirror: Off 02:54:20 INFO - Online: Yes 02:54:20 INFO - Rotation: Supported 02:54:20 INFO - Return code: 0 02:54:20 INFO - Running post-action listener: _resource_record_post_action 02:54:20 INFO - Running post-run listener: _resource_record_post_run 02:54:21 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 94208; Write bytes: 686225408; Read time: 56; Write time: 61055 02:54:21 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 337521152; Write bytes: 333842432; Read time: 35345; Write time: 7564 02:54:21 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 94208; Write bytes: 339744768; Read time: 56; Write time: 51367 02:54:21 INFO - Running post-run listener: _upload_blobber_files 02:54:21 INFO - Blob upload gear active. 02:54:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:54:21 INFO - Copying logs to upload dir... 02:54:21 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1319.081620 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-02 02:54:21.361314) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 02:54:21.365968) ========= 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.mLOqz8ZiVs/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.22cSfvKsig/Listeners TMPDIR=/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/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/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010624 build_url: 'https://queue.taskcluster.net/v1/task/IK5lYIXCSb-XUBIQ_ZDUjA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 02:54:21.399534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:54:21.399957) ========= 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.mLOqz8ZiVs/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.22cSfvKsig/Listeners TMPDIR=/var/folders/wl/fkvn1tcd101bj10h9d3mmcb400000w/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.005575 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 02:54:21.452946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 02:54:21.453427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 02:54:21.454004) ========= ========= Total master_lag: 0.25 =========