builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0026 starttime: 1445703423.1 results: success (0) buildid: 20151024081135 builduid: 512d94fc4eae4624b6b34cb2583e4c98 revision: 41913aea0fb03d236ecff025467b2e64e263842f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:03.096564) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:03.097158) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:03.097509) ========= 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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.005845 basedir: '/builds/slave/test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:03.557979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2015-10-24 09:17:03.558711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2015-10-24 09:17:05.999779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.000098) ========= 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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.012904 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.092271) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.092661) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.093116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.093459) ========= 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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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-10-24 09:17:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, :: Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.13M=0.001s 2015-10-24 09:17:06 (9.13 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157362 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.338548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.338892) ========= 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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.041678 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.484693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:06.485068) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 41913aea0fb03d236ecff025467b2e64e263842f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 41913aea0fb03d236ecff025467b2e64e263842f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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-10-24 09:17:06,572 truncating revision to first 12 chars 2015-10-24 09:17:06,572 Setting DEBUG logging. 2015-10-24 09:17:06,572 attempt 1/10 2015-10-24 09:17:06,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/41913aea0fb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-24 09:17:06,824 unpacking tar archive at: mozilla-inbound-41913aea0fb0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520772 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:07.205190) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2015-10-24 09:17:07.205516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2015-10-24 09:17:08.656914) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:08.657217) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 09:17:08.657672) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-10-24 09:17:08.657992) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 09:17:08 INFO - MultiFileLogger online at 20151024 09:17:08 in /builds/slave/test 09:17:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:17:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:08 INFO - {'append_to_log': False, 09:17:08 INFO - 'base_work_dir': '/builds/slave/test', 09:17:08 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:17:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:08 INFO - 'branch': 'Mozilla-Inbound', 09:17:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:08 INFO - 'config_files': ('talos/mac_config.py',), 09:17:08 INFO - 'default_actions': ('clobber', 09:17:08 INFO - 'read-buildbot-config', 09:17:08 INFO - 'download-and-extract', 09:17:08 INFO - 'populate-webroot', 09:17:08 INFO - 'create-virtualenv', 09:17:08 INFO - 'install', 09:17:08 INFO - 'run-tests'), 09:17:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:08 INFO - 'download_minidump_stackwalk': True, 09:17:08 INFO - 'download_symbols': 'ondemand', 09:17:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:08 INFO - 'installer_path': 'installer.exe', 09:17:08 INFO - 'log_level': 'info', 09:17:08 INFO - 'log_name': 'talos', 09:17:08 INFO - 'log_to_console': True, 09:17:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:17:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:17:08 INFO - 'opt_config_files': (), 09:17:08 INFO - 'pip_index': False, 09:17:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:08 INFO - 'cmd': ('bash', 09:17:08 INFO - '-c', 09:17:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:08 INFO - 'enabled': True, 09:17:08 INFO - 'halt_on_failure': False, 09:17:08 INFO - 'name': 'check_screen_resolution'},), 09:17:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:08 INFO - 'cmd': ('bash', 09:17:08 INFO - '-c', 09:17:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:08 INFO - 'enabled': True, 09:17:08 INFO - 'halt_on_failure': False, 09:17:08 INFO - 'name': 'check_screen_resolution'},), 09:17:08 INFO - 'run_cmd_checks_enabled': True, 09:17:08 INFO - 'sps_profile': False, 09:17:08 INFO - 'sps_profile_interval': 0, 09:17:08 INFO - 'suite': 'dromaeojs', 09:17:08 INFO - 'system_bits': '64', 09:17:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:08 INFO - 'title': 't-yosemite-r5-0026', 09:17:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:08 INFO - 'use_talos_json': True, 09:17:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:08 INFO - 'work_dir': 'build'} 09:17:08 INFO - ##### 09:17:08 INFO - ##### Running clobber step. 09:17:08 INFO - ##### 09:17:08 INFO - Running pre-action listener: _resource_record_pre_action 09:17:08 INFO - Running main action method: clobber 09:17:08 INFO - rmtree: /builds/slave/test/build 09:17:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:11 INFO - Running post-action listener: _resource_record_post_action 09:17:11 INFO - ##### 09:17:11 INFO - ##### Running read-buildbot-config step. 09:17:11 INFO - ##### 09:17:11 INFO - Running pre-action listener: _resource_record_pre_action 09:17:11 INFO - Running main action method: read_buildbot_config 09:17:11 INFO - Using buildbot properties: 09:17:11 INFO - { 09:17:11 INFO - "properties": { 09:17:11 INFO - "buildnumber": 3161, 09:17:11 INFO - "product": "firefox", 09:17:11 INFO - "script_repo_revision": "production", 09:17:11 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 09:17:11 INFO - "repository": "", 09:17:11 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 09:17:11 INFO - "buildid": "20151024081135", 09:17:11 INFO - "slavename": "t-yosemite-r5-0026", 09:17:11 INFO - "pgo_build": "False", 09:17:11 INFO - "basedir": "/builds/slave/test", 09:17:11 INFO - "project": "", 09:17:11 INFO - "platform": "yosemite", 09:17:11 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:17:11 INFO - "slavebuilddir": "test", 09:17:11 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 09:17:11 INFO - "branch": "mozilla-inbound", 09:17:11 INFO - "repo_path": "integration/mozilla-inbound", 09:17:11 INFO - "stage_platform": "macosx64", 09:17:11 INFO - "builduid": "512d94fc4eae4624b6b34cb2583e4c98", 09:17:11 INFO - "revision": "41913aea0fb03d236ecff025467b2e64e263842f" 09:17:11 INFO - }, 09:17:11 INFO - "sourcestamp": { 09:17:11 INFO - "repository": "", 09:17:11 INFO - "hasPatch": false, 09:17:11 INFO - "project": "", 09:17:11 INFO - "branch": "mozilla-inbound-macosx64-talos", 09:17:11 INFO - "changes": [ 09:17:11 INFO - { 09:17:11 INFO - "category": null, 09:17:11 INFO - "files": [ 09:17:11 INFO - { 09:17:11 INFO - "url": null, 09:17:11 INFO - "name": "https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg" 09:17:11 INFO - } 09:17:11 INFO - ], 09:17:11 INFO - "repository": "", 09:17:11 INFO - "rev": "41913aea0fb03d236ecff025467b2e64e263842f", 09:17:11 INFO - "who": "nfroyd@mozilla.com", 09:17:11 INFO - "when": 1445703373, 09:17:11 INFO - "number": 6570428, 09:17:11 INFO - "comments": "Bug 1215526 - part 4 - make preprocess-tab-svgs.py report extra dependencies; r=glandium\n\nBuilding on the preprocessor.py changes, we can now return the set of\nincluded files from the preprocessed tab SVGs.", 09:17:11 INFO - "project": "", 09:17:11 INFO - "at": "Sat 24 Oct 2015 09:16:13", 09:17:11 INFO - "branch": "mozilla-inbound-macosx64-talos", 09:17:11 INFO - "revlink": "", 09:17:11 INFO - "properties": [ 09:17:11 INFO - [ 09:17:11 INFO - "buildid", 09:17:11 INFO - "20151024081135", 09:17:11 INFO - "Change" 09:17:11 INFO - ], 09:17:11 INFO - [ 09:17:11 INFO - "builduid", 09:17:11 INFO - "512d94fc4eae4624b6b34cb2583e4c98", 09:17:11 INFO - "Change" 09:17:11 INFO - ], 09:17:11 INFO - [ 09:17:11 INFO - "pgo_build", 09:17:11 INFO - "False", 09:17:11 INFO - "Change" 09:17:11 INFO - ] 09:17:11 INFO - ], 09:17:11 INFO - "revision": "41913aea0fb03d236ecff025467b2e64e263842f" 09:17:11 INFO - } 09:17:11 INFO - ], 09:17:11 INFO - "revision": "41913aea0fb03d236ecff025467b2e64e263842f" 09:17:11 INFO - } 09:17:11 INFO - } 09:17:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg. 09:17:11 INFO - Running post-action listener: _resource_record_post_action 09:17:11 INFO - ##### 09:17:11 INFO - ##### Running download-and-extract step. 09:17:11 INFO - ##### 09:17:11 INFO - Running pre-action listener: _resource_record_pre_action 09:17:11 INFO - Running main action method: download_and_extract 09:17:11 INFO - mkdir: /builds/slave/test/build/tests 09:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:11 INFO - https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/test_packages.json 09:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/test_packages.json 09:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:17:12 INFO - Downloaded 1149 bytes. 09:17:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:17:12 INFO - Using the following test package requirements: 09:17:12 INFO - {u'common': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 09:17:12 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 09:17:12 INFO - u'firefox-44.0a1.en-US.mac.cppunittest.tests.zip'], 09:17:12 INFO - u'jittest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 09:17:12 INFO - u'jsshell-mac.zip'], 09:17:12 INFO - u'mochitest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 09:17:12 INFO - u'firefox-44.0a1.en-US.mac.mochitest.tests.zip'], 09:17:12 INFO - u'mozbase': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 09:17:12 INFO - u'reftest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 09:17:12 INFO - u'firefox-44.0a1.en-US.mac.reftest.tests.zip'], 09:17:12 INFO - u'talos': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 09:17:12 INFO - u'firefox-44.0a1.en-US.mac.talos.tests.zip'], 09:17:12 INFO - u'web-platform': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 09:17:12 INFO - u'firefox-44.0a1.en-US.mac.web-platform.tests.zip'], 09:17:12 INFO - u'webapprt': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 09:17:12 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 09:17:12 INFO - u'firefox-44.0a1.en-US.mac.xpcshell.tests.zip']} 09:17:12 INFO - Downloading packages: [u'firefox-44.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:12 INFO - https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:17:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 09:17:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 09:17:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 09:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:17:13 INFO - Downloaded 17454383 bytes. 09:17:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:17:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 09:17:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:17:18 INFO - Return code: 0 09:17:18 INFO - Downloading packages: [u'firefox-44.0a1.en-US.mac.common.tests.zip', u'firefox-44.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:18 INFO - https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 09:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 09:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 09:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:17:23 INFO - Downloaded 17454383 bytes. 09:17:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:17:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 09:17:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:17:29 INFO - Return code: 0 09:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:29 INFO - https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:17:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip 09:17:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip 09:17:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip 09:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:17:30 INFO - Downloaded 11131307 bytes. 09:17:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 09:17:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip 09:17:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:17:30 INFO - Return code: 0 09:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:30 INFO - https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 09:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 09:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg 09:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg'}, attempt #1 09:17:34 INFO - Downloaded 108370982 bytes. 09:17:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 09:17:34 INFO - mkdir: /builds/slave/test/properties 09:17:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:17:34 INFO - Writing to file /builds/slave/test/properties/build_url 09:17:34 INFO - Contents: 09:17:34 INFO - build_url:https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 09:17:34 INFO - Running post-action listener: _resource_record_post_action 09:17:34 INFO - Running post-action listener: set_extra_try_arguments 09:17:34 INFO - ##### 09:17:34 INFO - ##### Running populate-webroot step. 09:17:34 INFO - ##### 09:17:34 INFO - Running pre-action listener: _resource_record_pre_action 09:17:34 INFO - Running main action method: populate_webroot 09:17:34 INFO - Guessing talos json url... 09:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:34 INFO - https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.txt matches https://queue.taskcluster.net 09:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.txt 09:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.txt 09:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a1.en-US.mac.txt 09:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.mac.txt'}, attempt #1 09:17:35 INFO - Downloaded 111 bytes. 09:17:35 INFO - Reading from file /builds/slave/test/build/firefox-44.0a1.en-US.mac.txt 09:17:35 INFO - Contents: 09:17:35 INFO - 20151024081135 09:17:35 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/41913aea0fb03d236ecff025467b2e64e263842f 09:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:35 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/41913aea0f/testing/talos/talos.json 09:17:35 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/41913aea0f/testing/talos/talos.json to /builds/slave/test/build/talos.json 09:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/41913aea0f/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 09:17:36 INFO - Downloaded 4264 bytes. 09:17:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:36 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:17:36 INFO - '../fennec_ids.txt'], 09:17:36 INFO - 'tests': ['tcheck2']}, 09:17:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:36 INFO - '--tppagecycles', 09:17:36 INFO - '7'], 09:17:36 INFO - 'tests': ['tsvgm']}}, 09:17:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:17:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:17:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:17:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:36 INFO - 'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:36 INFO - 'tests': ['damp', 'tps']}, 09:17:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:36 INFO - 'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['damp', 'tps']}, 09:17:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:17:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:36 INFO - 'other': {'tests': ['a11yr', 09:17:36 INFO - 'ts_paint', 09:17:36 INFO - 'tpaint', 09:17:36 INFO - 'sessionrestore', 09:17:36 INFO - 'sessionrestore_no_auto_restore']}, 09:17:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['a11yr', 09:17:36 INFO - 'ts_paint', 09:17:36 INFO - 'tpaint', 09:17:36 INFO - 'sessionrestore', 09:17:36 INFO - 'sessionrestore_no_auto_restore']}, 09:17:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['a11yr', 09:17:36 INFO - 'ts_paint', 09:17:36 INFO - 'tpaint', 09:17:36 INFO - 'sessionrestore', 09:17:36 INFO - 'sessionrestore_no_auto_restore']}, 09:17:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['a11yr', 09:17:36 INFO - 'ts_paint', 09:17:36 INFO - 'tpaint', 09:17:36 INFO - 'sessionrestore', 09:17:36 INFO - 'sessionrestore_no_auto_restore']}, 09:17:36 INFO - 'other_l64': {'tests': ['a11yr', 09:17:36 INFO - 'ts_paint', 09:17:36 INFO - 'tpaint', 09:17:36 INFO - 'sessionrestore', 09:17:36 INFO - 'sessionrestore_no_auto_restore']}, 09:17:36 INFO - 'other_nol64': {'tests': ['a11yr', 09:17:36 INFO - 'ts_paint', 09:17:36 INFO - 'tpaint', 09:17:36 INFO - 'sessionrestore', 09:17:36 INFO - 'sessionrestore_no_auto_restore']}, 09:17:36 INFO - 'svgr': {'tests': ['tsvgx', 09:17:36 INFO - 'tsvgr_opacity', 09:17:36 INFO - 'tart', 09:17:36 INFO - 'tscrollx', 09:17:36 INFO - 'cart']}, 09:17:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['tsvgx', 09:17:36 INFO - 'tsvgr_opacity', 09:17:36 INFO - 'tart', 09:17:36 INFO - 'tscrollx', 09:17:36 INFO - 'cart']}, 09:17:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:36 INFO - 'tests': ['tp5o']}, 09:17:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:36 INFO - 'talos_options': ['--e10s'], 09:17:36 INFO - 'tests': ['tp5o']}, 09:17:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:36 INFO - 'talos_options': ['--xperf_path', 09:17:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:36 INFO - 'tests': ['tp5n']}, 09:17:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:36 INFO - 'talos_options': ['--e10s', 09:17:36 INFO - '--xperf_path', 09:17:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 09:17:36 INFO - 'C:/slave/talos-data/talos/xperf.config'], 09:17:36 INFO - 'tests': ['tp5n']}}, 09:17:36 INFO - 'talos.zip': {'path': '', 09:17:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:36 INFO - Running post-action listener: _resource_record_post_action 09:17:36 INFO - ##### 09:17:36 INFO - ##### Running create-virtualenv step. 09:17:36 INFO - ##### 09:17:36 INFO - Running pre-action listener: _resource_record_pre_action 09:17:36 INFO - Running main action method: create_virtualenv 09:17:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:17:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:17:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:17:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:36 INFO - Using real prefix '/tools/python27' 09:17:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:17:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:40 INFO - Installing pip.................done. 09:17:40 INFO - Return code: 0 09:17:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:40 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 0x100b08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2ebd7beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100abd9f0>, '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 0x10081ccd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a87990>, '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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkzUAGyM3m/Render', 09:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:40 INFO - 'HOME': '/Users/cltbld', 09:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:40 INFO - 'LOGNAME': 'cltbld', 09:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:40 INFO - 'MOZ_NO_REMOTE': '1', 09:17:40 INFO - 'NO_EM_RESTART': '1', 09:17:40 INFO - 'PAGER': '/bin/cat', 09:17:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:40 INFO - 'PWD': '/builds/slave/test', 09:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:40 INFO - 'SHELL': '/bin/bash', 09:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Q1SjQ5oFf/Listeners', 09:17:40 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 09:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:40 INFO - 'USER': 'cltbld', 09:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:40 INFO - 'XPC_FLAGS': '0x0', 09:17:40 INFO - 'XPC_SERVICE_NAME': '0', 09:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:17:41 INFO - Cleaning up... 09:17:41 INFO - Return code: 0 09:17:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:17: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')]} 09:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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')]} 09:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:41 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 0x100b08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2ebd7beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100abd9f0>, '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 0x10081ccd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a87990>, '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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkzUAGyM3m/Render', 09:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:41 INFO - 'HOME': '/Users/cltbld', 09:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:41 INFO - 'LOGNAME': 'cltbld', 09:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:41 INFO - 'MOZ_NO_REMOTE': '1', 09:17:41 INFO - 'NO_EM_RESTART': '1', 09:17:41 INFO - 'PAGER': '/bin/cat', 09:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:41 INFO - 'PWD': '/builds/slave/test', 09:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:41 INFO - 'SHELL': '/bin/bash', 09:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Q1SjQ5oFf/Listeners', 09:17:41 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 09:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:41 INFO - 'USER': 'cltbld', 09:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:41 INFO - 'XPC_FLAGS': '0x0', 09:17:41 INFO - 'XPC_SERVICE_NAME': '0', 09:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:41 INFO - Downloading/unpacking psutil>=0.7.1 09:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:17:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:44 INFO - Installing collected packages: psutil 09:17:44 INFO - Running setup.py install for psutil 09:17:44 INFO - building 'psutil._psutil_osx' extension 09:17:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:17:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:17:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:17:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:17:47 INFO - building 'psutil._psutil_posix' extension 09:17:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:17:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:17:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:17:47 INFO - ^ 09:17:47 INFO - 1 warning generated. 09:17:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:17:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:47 INFO - Successfully installed psutil 09:17:47 INFO - Cleaning up... 09:17:47 INFO - Return code: 0 09:17:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:47 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 0x100b08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2ebd7beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100abd9f0>, '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 0x10081ccd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a87990>, '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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkzUAGyM3m/Render', 09:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:47 INFO - 'HOME': '/Users/cltbld', 09:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:47 INFO - 'LOGNAME': 'cltbld', 09:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:47 INFO - 'MOZ_NO_REMOTE': '1', 09:17:47 INFO - 'NO_EM_RESTART': '1', 09:17:47 INFO - 'PAGER': '/bin/cat', 09:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:47 INFO - 'PWD': '/builds/slave/test', 09:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:47 INFO - 'SHELL': '/bin/bash', 09:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Q1SjQ5oFf/Listeners', 09:17:47 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 09:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:47 INFO - 'USER': 'cltbld', 09:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:47 INFO - 'XPC_FLAGS': '0x0', 09:17:47 INFO - 'XPC_SERVICE_NAME': '0', 09:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:17:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:17:50 INFO - Installing collected packages: mozsystemmonitor 09:17:50 INFO - Running setup.py install for mozsystemmonitor 09:17:50 INFO - Successfully installed mozsystemmonitor 09:17:50 INFO - Cleaning up... 09:17:50 INFO - Return code: 0 09:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:50 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 0x100b08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2ebd7beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100abd9f0>, '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 0x10081ccd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a87990>, '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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkzUAGyM3m/Render', 09:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:50 INFO - 'HOME': '/Users/cltbld', 09:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:50 INFO - 'LOGNAME': 'cltbld', 09:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:50 INFO - 'MOZ_NO_REMOTE': '1', 09:17:50 INFO - 'NO_EM_RESTART': '1', 09:17:50 INFO - 'PAGER': '/bin/cat', 09:17:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:50 INFO - 'PWD': '/builds/slave/test', 09:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:50 INFO - 'SHELL': '/bin/bash', 09:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Q1SjQ5oFf/Listeners', 09:17:50 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 09:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:50 INFO - 'USER': 'cltbld', 09:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:50 INFO - 'XPC_FLAGS': '0x0', 09:17:50 INFO - 'XPC_SERVICE_NAME': '0', 09:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:50 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:17:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:54 INFO - Downloading docopt-0.6.1.tar.gz 09:17:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:54 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:54 INFO - Running setup.py install for blobuploader 09:17:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:17:54 INFO - Running setup.py install for requests 09:17:55 INFO - Running setup.py install for docopt 09:17:55 INFO - Successfully installed blobuploader requests docopt 09:17:55 INFO - Cleaning up... 09:17:55 INFO - Return code: 0 09:17:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:55 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 0x100b08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2ebd7beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100abd9f0>, '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 0x10081ccd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a87990>, '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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:17:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkzUAGyM3m/Render', 09:17:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:55 INFO - 'HOME': '/Users/cltbld', 09:17:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:55 INFO - 'LOGNAME': 'cltbld', 09:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:55 INFO - 'MOZ_NO_REMOTE': '1', 09:17:55 INFO - 'NO_EM_RESTART': '1', 09:17:55 INFO - 'PAGER': '/bin/cat', 09:17:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:55 INFO - 'PWD': '/builds/slave/test', 09:17:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:55 INFO - 'SHELL': '/bin/bash', 09:17:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Q1SjQ5oFf/Listeners', 09:17:55 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 09:17:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:55 INFO - 'USER': 'cltbld', 09:17:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:55 INFO - 'XPC_FLAGS': '0x0', 09:17:55 INFO - 'XPC_SERVICE_NAME': '0', 09:17:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-57z13s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-FH7VX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-S8gAat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-onCldD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-5VTnOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-fex5ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-ljNu9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-1NybO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:56 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-UyZubq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:57 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-O42HuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:57 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-c6XRX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:57 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-QINzC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:57 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-v3l7UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:57 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-cJzD6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:57 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-kdmsJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:57 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-xjY5Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:57 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-C62VXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:58 INFO - Running setup.py install for manifestparser 09:17:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:17:58 INFO - Running setup.py install for mozcrash 09:17:58 INFO - Running setup.py install for mozdebug 09:17:58 INFO - Running setup.py install for mozdevice 09:17:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:17:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:17:58 INFO - Running setup.py install for mozfile 09:17:58 INFO - Running setup.py install for mozhttpd 09:17:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:17:59 INFO - Running setup.py install for mozinfo 09:17:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:17:59 INFO - Running setup.py install for mozInstall 09:17:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:17:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:17:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:17:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:17:59 INFO - Running setup.py install for mozleak 09:17:59 INFO - Running setup.py install for mozlog 09:17:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:17:59 INFO - Running setup.py install for moznetwork 09:18:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:00 INFO - Running setup.py install for mozprocess 09:18:00 INFO - Running setup.py install for mozprofile 09:18:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:00 INFO - Running setup.py install for mozrunner 09:18:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:00 INFO - Running setup.py install for mozscreenshot 09:18:00 INFO - Running setup.py install for moztest 09:18:00 INFO - Running setup.py install for mozversion 09:18:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:01 INFO - Cleaning up... 09:18:01 INFO - Return code: 0 09:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:01 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 0x100b08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2ebd7beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100abd9f0>, '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 0x10081ccd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a87990>, '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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:18:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkzUAGyM3m/Render', 09:18:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:01 INFO - 'HOME': '/Users/cltbld', 09:18:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:01 INFO - 'LOGNAME': 'cltbld', 09:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:01 INFO - 'MOZ_NO_REMOTE': '1', 09:18:01 INFO - 'NO_EM_RESTART': '1', 09:18:01 INFO - 'PAGER': '/bin/cat', 09:18:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:01 INFO - 'PWD': '/builds/slave/test', 09:18:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:01 INFO - 'SHELL': '/bin/bash', 09:18:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Q1SjQ5oFf/Listeners', 09:18:01 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 09:18:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:01 INFO - 'USER': 'cltbld', 09:18:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:01 INFO - 'XPC_FLAGS': '0x0', 09:18:01 INFO - 'XPC_SERVICE_NAME': '0', 09:18:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:01 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-ljx1bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:01 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-QS8WaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:01 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-01hTXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:01 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-vN1xg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:02 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-F3WGXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:02 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-Nj64Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:02 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-kFyBTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:02 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-Juohbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:02 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-OHHpA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:02 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-6vEXZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:02 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-UKSDyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:02 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-MTZ7SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:03 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-v36_u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:03 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-mHR90z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:03 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-ZrQvgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:03 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-4ikWo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:03 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-YIRei5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:06 INFO - Downloading blessings-1.5.1.tar.gz 09:18:06 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:06 INFO - Installing collected packages: blessings 09:18:06 INFO - Running setup.py install for blessings 09:18:06 INFO - Successfully installed blessings 09:18:06 INFO - Cleaning up... 09:18:06 INFO - Return code: 0 09:18:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:06 INFO - Reading from file tmpfile_stdout 09:18:06 INFO - Current package versions: 09:18:06 INFO - blessings == 1.5.1 09:18:06 INFO - blobuploader == 1.2.4 09:18:06 INFO - docopt == 0.6.1 09:18:06 INFO - manifestparser == 1.1 09:18:06 INFO - mozInstall == 1.12 09:18:06 INFO - mozcrash == 0.16 09:18:06 INFO - mozdebug == 0.1 09:18:06 INFO - mozdevice == 0.46 09:18:06 INFO - mozfile == 1.2 09:18:06 INFO - mozhttpd == 0.7 09:18:06 INFO - mozinfo == 0.8 09:18:06 INFO - mozleak == 0.1 09:18:06 INFO - mozlog == 3.0 09:18:06 INFO - moznetwork == 0.27 09:18:06 INFO - mozprocess == 0.22 09:18:06 INFO - mozprofile == 0.27 09:18:06 INFO - mozrunner == 6.11 09:18:06 INFO - mozscreenshot == 0.1 09:18:06 INFO - mozsystemmonitor == 0.0 09:18:06 INFO - moztest == 0.7 09:18:06 INFO - mozversion == 1.4 09:18:06 INFO - psutil == 3.1.1 09:18:06 INFO - requests == 1.2.3 09:18:06 INFO - wsgiref == 0.1.2 09:18:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:06 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 0x100b08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2ebd7beb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100abd9f0>, '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 0x10081ccd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a87990>, '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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:18:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkzUAGyM3m/Render', 09:18:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:06 INFO - 'HOME': '/Users/cltbld', 09:18:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:06 INFO - 'LOGNAME': 'cltbld', 09:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:06 INFO - 'MOZ_NO_REMOTE': '1', 09:18:06 INFO - 'NO_EM_RESTART': '1', 09:18:06 INFO - 'PAGER': '/bin/cat', 09:18:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:06 INFO - 'PWD': '/builds/slave/test', 09:18:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:06 INFO - 'SHELL': '/bin/bash', 09:18:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Q1SjQ5oFf/Listeners', 09:18:06 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 09:18:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:06 INFO - 'USER': 'cltbld', 09:18:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:06 INFO - 'XPC_FLAGS': '0x0', 09:18:06 INFO - 'XPC_SERVICE_NAME': '0', 09:18:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:18:07 INFO - Cleaning up... 09:18:07 INFO - Return code: 0 09:18:07 INFO - Running post-action listener: _resource_record_post_action 09:18:07 INFO - Running post-action listener: _start_resource_monitoring 09:18:07 INFO - Starting resource monitoring. 09:18:07 INFO - ##### 09:18:07 INFO - ##### Running install step. 09:18:07 INFO - ##### 09:18:07 INFO - Running pre-action listener: _resource_record_pre_action 09:18:07 INFO - Running main action method: install 09:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:07 INFO - Reading from file tmpfile_stdout 09:18:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:07 INFO - Reading from file tmpfile_stdout 09:18:07 INFO - Output received: 09:18:07 INFO - Usage: mozinstall [options] installer 09:18:07 INFO - Options: 09:18:07 INFO - -h, --help show this help message and exit 09:18:07 INFO - -d DEST, --destination=DEST 09:18:07 INFO - Directory to install application into. [default: 09:18:07 INFO - "/builds/slave/test"] 09:18:07 INFO - --app=APP Application being installed. [default: firefox] 09:18:07 INFO - mkdir: /builds/slave/test/build/application 09:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:18:47 INFO - Reading from file tmpfile_stdout 09:18:47 INFO - Output received: 09:18:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:18:47 INFO - Running post-action listener: _resource_record_post_action 09:18:47 INFO - ##### 09:18:47 INFO - ##### Running run-tests step. 09:18:47 INFO - ##### 09:18:47 INFO - Running pre-action listener: _resource_record_pre_action 09:18:47 INFO - Running main action method: run_tests 09:18:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:18:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:18:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:18:47 INFO - 2015-10-24 09:18:47.256 screenresolution[1634:7739] starting screenresolution argv=screenresolution get 09:18:47 INFO - 2015-10-24 09:18:47.260 screenresolution[1634:7739] Display 0: 1600x1200x32@60 09:18:47 INFO - 2015-10-24 09:18:47.266 screenresolution[1635:7741] starting screenresolution argv=screenresolution list 09:18:47 INFO - Available Modes on Display 0 09:18:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:18:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:18:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:18:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:18:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:18:47 INFO - Intel HD Graphics 3000: 09:18:47 INFO - Chipset Model: Intel HD Graphics 3000 09:18:47 INFO - Type: GPU 09:18:47 INFO - Bus: Built-In 09:18:47 INFO - VRAM (Total): 512 MB 09:18:47 INFO - VRAM (Dynamic, Max): 10 09:18:47 INFO - Vendor: Intel (0x8086) 09:18:47 INFO - Device ID: 0x0116 09:18:47 INFO - Revision ID: 0x0009 09:18:47 INFO - Displays: 09:18:47 INFO - Display: 09:18:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:18:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:18:47 INFO - Display Serial Number: 1600x1200 60 09:18:47 INFO - Main Display: Yes 09:18:47 INFO - Mirror: Off 09:18:47 INFO - Online: Yes 09:18:47 INFO - Rotation: Supported 09:18:47 INFO - Return code: 0 09:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:18:47 INFO - Python 2.7.3 09:18:47 INFO - Return code: 0 09:18:47 INFO - grabbing minidump binary from tooltool 09:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:47 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 0x100abd9f0>, '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 0x10081ccd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a87990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:18:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:18:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:18:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:18:47 INFO - Return code: 0 09:18:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:18:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:18:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:18:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:18:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0026', '--webServer', 'localhost'] in /builds/slave/test/build 09:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0026 --webServer localhost 09:18:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkzUAGyM3m/Render', 09:18:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:47 INFO - 'HOME': '/Users/cltbld', 09:18:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:47 INFO - 'LOGNAME': 'cltbld', 09:18:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:18:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:47 INFO - 'MOZ_NO_REMOTE': '1', 09:18:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:18:47 INFO - 'NO_EM_RESTART': '1', 09:18:47 INFO - 'PAGER': '/bin/cat', 09:18:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:47 INFO - 'PWD': '/builds/slave/test', 09:18:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:18:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:47 INFO - 'SHELL': '/bin/bash', 09:18:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9Q1SjQ5oFf/Listeners', 09:18:47 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 09:18:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:47 INFO - 'USER': 'cltbld', 09:18:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:47 INFO - 'XPC_FLAGS': '0x0', 09:18:47 INFO - 'XPC_SERVICE_NAME': '0', 09:18:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:18:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0026', '--webServer', 'localhost'] with output_timeout 3600 09:18:47 INFO - mozversion INFO | application_buildid: 20151024081135 09:18:47 INFO - mozversion INFO | application_changeset: 41913aea0fb03d236ecff025467b2e64e263842f 09:18:47 INFO - mozversion INFO | application_display_name: Nightly 09:18:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:18:47 INFO - mozversion INFO | application_name: Firefox 09:18:47 INFO - mozversion INFO | application_remotingname: firefox 09:18:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:18:47 INFO - mozversion INFO | application_vendor: Mozilla 09:18:47 INFO - mozversion INFO | application_version: 44.0a1 09:18:47 INFO - mozversion INFO | platform_buildid: 20151024081135 09:18:47 INFO - mozversion INFO | platform_changeset: 41913aea0fb03d236ecff025467b2e64e263842f 09:18:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:18:47 INFO - mozversion INFO | platform_version: 44.0a1 09:18:47 INFO - 2015-10-24 09:18:47,971 DEBUG : using testdate: 1445703527 09:18:47 INFO - 2015-10-24 09:18:47,971 DEBUG : actual date: 1445703527 09:18:49 INFO - 2015-10-24 09:18:49,003 INFO : starting webserver on 'localhost:49268' 09:18:49 INFO - 2015-10-24 09:18:49,004 INFO : Starting test suite t-yosemite-r5-0026 09:18:49 INFO - 2015-10-24 09:18:49,004 INFO : Starting test dromaeo_css 09:18:49 INFO - 2015-10-24 09:18:49,005 DEBUG : operating with platform_type : mac_ 09:18:49 INFO - 2015-10-24 09:18:49,006 INFO : Initialising browser for dromaeo_css test... 09:18:49 INFO - 2015-10-24 09:18:49,032 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpRatk6G/profile http://localhost:49268/getInfo.html 09:18:51 INFO - 2015-10-24 09:18:51,987 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:18:51 INFO - 2015-10-24 09:18:51,988 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:18:51 INFO - 2015-10-24 09:18:51,988 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:18:51 INFO - 2015-10-24 09:18:51,988 DEBUG : BROWSER_OUTPUT: __metrics 09:18:52 INFO - 2015-10-24 09:18:52,006 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:18:52 INFO - 2015-10-24 09:18:52,762 INFO : Browser initialized. 09:18:52 INFO - 2015-10-24 09:18:52,763 INFO : Running cycle 1/1 for dromaeo_css test... 09:18:52 INFO - 2015-10-24 09:18:52,763 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpRatk6G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:19:04 INFO - 2015-10-24 09:19:04,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 226054144 09:19:04 INFO - 2015-10-24 09:19:04,783 DEBUG : BROWSER_OUTPUT: 09:19:55 INFO - 2015-10-24 09:19:55,840 DEBUG : BROWSER_OUTPUT: 1445703595836 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:22:07 INFO - 2015-10-24 09:22:07,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 09:22:08 INFO - 2015-10-24 09:22:08,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 334495744 09:22:08 INFO - 2015-10-24 09:22:08,279 DEBUG : BROWSER_OUTPUT: 09:25:10 INFO - 2015-10-24 09:25:10,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 09:25:11 INFO - 2015-10-24 09:25:11,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 359743488 09:25:11 INFO - 2015-10-24 09:25:11,538 DEBUG : BROWSER_OUTPUT: 09:28:13 INFO - 2015-10-24 09:28:13,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 09:28:14 INFO - 2015-10-24 09:28:14,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 325824512 09:28:14 INFO - 2015-10-24 09:28:14,521 DEBUG : BROWSER_OUTPUT: 09:31:16 INFO - 2015-10-24 09:31:16,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 09:31:17 INFO - 2015-10-24 09:31:17,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 309956608 09:31:17 INFO - 2015-10-24 09:31:17,318 DEBUG : BROWSER_OUTPUT: 09:34:20 INFO - 2015-10-24 09:34:20,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 09:34:21 INFO - 2015-10-24 09:34:21,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 321093632 09:34:21 INFO - 2015-10-24 09:34:21,133 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 09:37:24 INFO - 2015-10-24 09:37:24,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 360411136 09:37:24 INFO - 2015-10-24 09:37:24,327 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,327 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:37:24 INFO - 2015-10-24 09:37:24,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:37:24 INFO - 2015-10-24 09:37:24,328 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:37:24 INFO - 2015-10-24 09:37:24,328 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:37:24 INFO - 2015-10-24 09:37:24,330 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2902.8838846446138;2922.5470052141927;2934.80923739957;2968.940621187576;2982.8210307381555;4900.117978763821;4986.5761410280165;5044.635546667595;5076.64463487556;5120.820771273002;4947.554720075193;4955.826546070879;4968.2795994580765;5049.520295571924;5105.566026887719;4588.541145885401;4669.509701481346;4679.391679081715;4687.484376718576;4749.525047495257;4611.423572053493;4649.697769644979;4712.882177945545;4718.669693121483;4797.760111994404;4479.126570318789;4609.7695115244105;4662.883427914296;4668.9766551167195;4711.175544279771;4614.423197100363;4621.37611422457;4665.2768820832825;4665.650076244261;4695.084458530588;4629.467611224719;4667.089917466095;4678.812847486097;4700.271457924027;4700.271457924027;4817.060673168733;4916.0905232532095;4979.4771548987555;4983.352164218664;5040.269160971675;5014.52362025607;5095.388553373582;5142.305788718512;5221.556167725748;5235.476452354734;5238.633295669305;5254.028004819121;5297.417284098746;5307.442718514539;5372.328458942632;4674.135284972223;4895.779689913927;4912.214045752662;4924.138275801721;4981.12830254704;5197.7141257231215;5335.86660333487;5346.1713434417725;5347.732613369394;5436.510714035756;5086.415062267886;5153.252778347119;5154.304168937146;5157.355330583677;5202.2456743771945;5086.109930762102;5248.317718696545;5260.92108618371;5281.656692314988;5358.3837858645975;4924.507549245119;4975.104481193348;5016.949830501721;5196.090684130262;5219;5192.662476938987;5201.245819356172;5214.296070030573;5248.553872920768;5251.238570407269;3982.5021872265966;4084.4690190275073;4102.487189101363;4102.938455923164;4135.276326642826;3474.722022238215;3563.5367402237544;3614.8373323200517;3629.8366573503727;3637.727170462226;4907.3620429343955;4908.4846091160625;4942.950570494321;4949.975250123798;4964.826231081967;5163.664361816545;5260.263563101169;5304.787808487695;5308.840734777963;5331.5201631853315;4832.492588278251;4854.199057155601;4867.3915760529935;4879.072976134523;4952.851414457572;4636.142313671981;4637.304404339376;4691.7654117294;4709.552592503706;4714.6464015199;5174.6119041071315;5330.680159190383;5360.249565060816;5381.354237491526;5439.619226654097;5222.608304377263;5256.526912577886;5264.289320941777;5266.131088370376;5270.973645131903;5347.331583552056;5365.865853353697;5369.3556773187465;5374.596905232202;5388.164834450667;5030.773615187252;5158.2004789256225;5175.637705360588;5228.477152284741;5268;5235.136202526541;5236.266922630911;5247.685138891678;5304.814331498379;5438.75525601341;5047.722375269395;5156.381234251914;5166.612504062286;5172.017316709813;5213.270142180022;4981.676191047571;5154.355705536808;5156.226566014978;5163.3545806774155;5175.301334319819;5001.299818025552;5059.342285502861;5070.569001634754;5119.769610367468;5131.179011358165;5215.113430716863;5216.321878155815;5226.059309324358;5227.451117632594;5296.523312901857;4855.1988921828915;5107.310513080686;5119.462456442169;5123.718195499283;5126.359205099363 09:37:24 INFO - 2015-10-24 09:37:24,333 DEBUG : BROWSER_OUTPUT: |1;ext.html;473.0727773563815;474.6795912758888;479.73854249434055;479.9880002999922;501.4459022779826;29195.83216671333;29756.256093597673;36091.819540902325;36567.81716091422;36606.8169659152;38525.61474385255;39003.60996390035;39076.21847563047;39090.60909390905;39092.41361379575;7539.283768042027;7672.769816905502;8226.629801658924;8448.281896038814;8457.57712114395;10045.146162576153;10264.384136951769;10289.073983341497;10291.691249262534;10297.227707921898;10063.04401081896;10179.796404071914;10198.184145268398;10208.387496750182;10211.897881021207;7671.654775535114;7883.408744344197;9993.850092248622;10000.299979001473;10331.32846364984;9870.407775533418;10048.145907597864;10051.69844904654;10068.345557538736;10119.848202276971;35900;36287.18564071786;36384.818075909716;36401.45397819035;36457.45313820268;2537.7335379785227;2702.2433718558837;2959.2601849537614;3257.5602293690285;3274.918127046819;24821.62767558488;25349.493010139693;25455.61816572753;25504.36239094019;25572.872135639387;2120.809127178546;2135.1993002624017;2152.7739587343417;2156.7304086989125;2236.8434209605334;232201;235023.99999999828;235501;235999;236576;49882.50117498779;50999.7450012755;53694;58255.70872145612;59538.53460990443;54326.728366357915;54442.18336724952;55098.17352739712;55252.44747552473;55376.44623553794;14622.318433380085;14681.41274349014;14833.480828170963;14923.253837308092;15080.170590617621;11154.776904462027;11306.265092768943;11309.321440713584;11324;11444.313341199555;16950.745738813926;16957.067361295;16959.660806784043;16982.830171698126;16990.490285291213;7274.636268186676;7486.700531978769;7498.962505187548;7503;7539.698412063456;751.9060117485315;774.0711146623961;790.920907909216;807.8707406814881;862.8058686795421;23875.522489550112;23962.40093997664;24025.399365015666;25054.248372548853;25090.749092508842;878.8198419324024;931.6413180925257;946.6071580294239;1034.425893629043;1040.3965699894043;13166.934165329303;13229.536966206137;13360.93319533396;14150.64623384403;14647.707045859022;304746;308389;308508;308938;312033;50318.748406257735;50343.74828125909;50347;50495.74752126216;50628.74685626548;1221.0597839663587;1222.602654137409;1249.7063190150125;1251.2429979862234;1255.3033066647915;25452.872735636945;25845.612315814902;26071.478570428866;26081.869590651924;26090.86954565215;43482.782586088135;43845.71157163162;43848;43924.780376097915;43956;279968;280102;280917;281094;281291;26729.732702672725;28553.571696424984;29160;29231.46912228608;29232.853835730686;35041.29917401587;35256.29487410289;35918.8204058978;36053.09867253339;36176.63823361838;30124.3975120492;31964.68035319617;32134.357312853146;32380.676193237767;32398.19004524906;31220.531692024182;31556.842215789693;32011.559479822998;32070.67929320677;32092.518612220367;30747;31099.533506997865;31159.376812464077;31369.686303136677;31458.528122078646;26077.869610651825;28285.858570707016;28639.427211455237;29977;30088;21629.459263518536;21692;21807.78192218121;21882.45293867666;22073.779262207172 09:37:24 INFO - 2015-10-24 09:37:24,333 DEBUG : BROWSER_OUTPUT: |2;jquery.html;303.43560976583564;325.18216685037135;325.18541054658095;328.2712378519685;330.80978437398494;12838.101332906688;13243.536476223335;15884.52346429606;15911.761323580156;16409.671806563863;15885.285162167702;16035.118068506228;16357.83642163581;16368.181590920465;16401.83598164018;3614;3730.7388482806214;3849.6727778138893;4990.525900039509;5004.924926126111;3703.6481534254203;5418.674879507243;5573.331200255975;5599.41206173352;5603.663780173202;5351.197320401932;5464.3442786865435;5510.8071217507395;5536.169574563827;5540.445955404468;5002.124628190052;5007;5016.29771831942;5041.017001684673;5042;4399.38408622793;4423.292273236299;4432.445944256968;4443.844465443694;4584.885377865547;19147;19285.614287714307;19456;19646.214151433924;19718.309859155004;1755.1662960093981;1788.150628451475;1802.774653168354;1881;1951.7853036166011;8034.959825200836;8485.915140848574;12354.75290494185;12580;12709.491620335175;1344.589900080475;1382.910110842792;1392.526540976073;1401.222321611505;1430.4921752777823;50359;52493.21260181101;52824.73587632076;55521.72239138778;55966;5741.626794258444;5839.386864379179;5840.795572155039;5842.912356314659;5882.205902203234;6753.729850805913;6790.8641827164165;6802.591844489347;6833.555818871758;6872.793816185523;4628.745419001987;4667.719936803803;4696.647751418589;4783.354247176656;4896.804127834918;5108.591312694975;5169.793208271627;5180.818671346485;5204.869878252998;5218.191180367049;2485.3538080099306;2527.7093134289794;2595.935101622437;2614.058938782075;2651.9602205966926;925.2366797392044;925.2644147902433;938.5166639180827;942.5522876633544;984.9608662860751;369.680226603991;386.5419477918619;394.70199999000573;396.11665984853937;427.15636617680457;8586;10140;10600.575976960989;10695.358278503314;10738.926107389354;407.74515927545286;408.84259560069586;413.9172165566899;431.4046615670355;447.5032713687804;5496.697681627469;5571.804986825442;5706.315242170883;5744.080947048452;5771.278590176228;448293;456678;458474;460558;465075;65083;65303;65372.67313663401;66909;67550.3244967544;418.1469801604753;433.72891942535915;452.2537812609221;466.20279322359147;466.9929951050737;9656.758581035248;9691.370060946016;9744.902550974399;9905.653302134391;9920.603175873173;29232.123036308945;30427.39145217039;30602.387952240384;32507.674923250466;33001.66998329986;43783.34324985192;44226;44666.3300050506;44777.77611111924;45204.54795452135;5656.038473459439;5673.375928647928;5684.488396044376;5711.914321285267;5724.542036636975;10528.894711052792;10582.788344233226;10609.575616975235;10698.8930110701;10736.677899663022;9037.634328022641;9144.131307525775;9241.075892410705;9260.629574816932;9270;8818.647254109765;8838.646454141763;8859.335549833917;8972.955135224282;9136.95431522838;9269.67556135559;9339.719808405758;9402.858957115786;9468.195203407788;9509.762255943657;5583.525400341016;5589.524890384363;5600.831975040755;5621.550275977994;5633.0705433603;8950.552472376225;9045.728628141167;9141.725748227564;9256.72229833106;9262.675806346746 09:37:24 INFO - 2015-10-24 09:37:24,337 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1268.2200446725267;1329.5878277733902;1496.9072577018776;1504.3907217576877;1757.4376199616129;7307.707691692332;8012.719554815582;8322.958385208081;8625.309975201984;8657.913420865789;8105.675772969089;8224.383171262149;8306;8335.583220838964;8336.95831520843;1924.2110734598816;1981.2570286142698;2185.595664802013;2219.9223027194053;2227.9888600556974;2254.0758289101473;2286.222684287342;2292.151903795598;2306.1813056365;2312;2213.7896899794496;2237.8881055947218;2255.5263394687136;2257.2325409360815;2264.2075273654173;1897.5635603811063;1990.2735501541977;2183.4759657682202;2232.693874083663;2244.3379203135114;2216.645336746129;2219.5449932763745;2229.3869185973826;2236.7539570647214;2249.2352600116037;8534.57327133647;8612.09572994839;8637.438566493158;8643.611037503328;8679.739607811713;5042.84871453857;5134.2812006319145;5140.177571588565;5148.613853960968;5151.459096794858;2836.773058155343;2856.4144350408324;2907.0406765767248;2911.9708802912123;2939.6472423309124;836.4897412578322;837.2590257621988;846.6824940647257;850.1073872433982;862.3489265604428;12006;12060.939695301555;12064.939675301568;12068.456919438646;12090.939545302304;4486.3494793254795;4650.627949764011;4669.34629151919;4702.95297047032;4710.3405523226775;10345.741356465998;10350.585976561004;10351.06840384354;10352.689419317432;10362.067413932631;5104.642675012714;5156.845294641167;5159.819406320761;5166.173412254097;5175.637705360664;4590.724556526619;4596.2416201326405;4600.884977875513;4611.123886461562;4618.122556714281;3758;3761.1161377076364;3832.061145019488;3852.7303088783515;3860.2665493556133;1213.5509861351356;1226.6565361698738;1231.9137660363867;1233.0382301804607;1235.8393408856791;865.4720620421538;867.2628265973872;1185.5080141741253;1230.7169351049308;1246.2833870524485;7574.280443357872;7829.177936316719;8019.478733882279;8224.218699223564;8245.546494942715;604.5345084285076;605.1618508365857;621.6922623301405;624.3475568031328;632.7975047984601;6027;6136.23297087864;6159.5072394208355;6161.229846269216;6185.721642526097;10270.691879243635;10426.113780328606;10439.686809395731;10462.319949203278;10494.527746251437;10054.396736195851;10321.896781032243;10354.689359319233;10359.533820978075;10368.274220804622;7730.072391313079;7855.999999999885;7860.567668778158;7865.174156713577;7877.645505952131;7500.212477689982;7553.811154721176;7590.203028681909;7625.809354766176;7637.389008879165;8832.735017949472;8921.955390223007;9041.457512549268;9060.592273347584;9103.408278461879;8983.146601072887;9316.20812230968;9335.579898904702;9391.29565282593;9410.435373877315;7344.926550734638;7383.234956225479;7404.888926665996;7407.148177959388;7436.256374362737;7961.363090952826;8172.509649421054;8175.918240817754;8184.427090103635;8185.4270201085355;7444.181140074479;7531.849363012819;7563.319301262913;7625.809354766176;7688.154303026551;7360.521566098187;7390.29792169743;7453.403727701662;7502.624868756649;7546.735864244944;6830.658467076726;7163.6060016699585;7484.850302994018;7717.2668596483245;7732.458727888994;6668.799936001928;6753.425958793558;6797;6799.2520822708475;6810.659467026728;6783.152105986752;6934.479914006369;7053.964730176316;7057.5651400266825;7074.292570742885 09:37:24 INFO - 2015-10-24 09:37:24,338 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.4799470912676;304.3972933591489;307.30702266389295;315.1286692295801;316.17005360927567;5542.944570554293;5549.084401073823;5564.777408903649;5565.053940830064;5579.107342825148;5426.348838139429;5464.672119672822;5487.64330318529;5490.286262785832;5490.423505531911;4321.956780432202;4348.391225228463;4359.324304732756;4370.737755734666;4402.031553058338;4173.791310434466;4229.407882896397;4342.652587792984;4375.278079116942;4394.450693663292;4179.226843034048;4210.915781684364;4262.9147417051645;4267.103908179271;4298.419713338706;4306.569343065668;4318.913621727548;4322.7190232634775;4326.351047342908;4369.825206991716;3777.1501412182315;3782.3569993101237;3782.6973842092566;3784.678302344304;3785.167263202091;5157.381114266312;5277.815276465343;5280.471952804727;5367.114426119686;5382.219578161144;4656.185167595657;4660.440747110369;4673.415823022122;4691.272852707836;4701.647376446746;5565.888682226333;5577.581681373913;5579.525740312038;5582.106862901916;5606.131049687305;3840.807959602009;3946.842126314944;3950.881473555798;3958.940615890764;3964.0486283291802;5938.138969849391;5966.731497082642;5968.492678122365;5976.342602313742;6006.759729610767;4064.6138616831354;4083.97958010214;4090.631843134073;4098.3852422136915;4117.732347397409;3923.7841918694744;4000.899977500586;4057.087155390014;4183.414321994923;4190.811413486401;4642.837500687459;4677.602403795716;4681.157391669464;4690.061987602493;4722.6221902247735;5590.636608620427;5599.356074051455;5606;5608;5633.070543360382;1474.395497845878;1486.829014663306;1488.2038109611306;1491.6494623763406;1495.0879963222426;981.788915383196;990.4601991914279;1017.3844823881593;1022.9641962531275;1027.1936529824052;5415.972920135453;5418.2685337479725;5420.756065977041;5423.484768946943;5429.511343979061;5887.941120588825;5889.0283103287475;5890.823275301748;5892.793752218652;5899.852503687356;5404.945950540523;5417.106177480671;5427.402985671573;5430.945690543044;5439.728013599304;3138.3723255348564;3217.6621454747383;3236.757243206769;3243.8378081095852;3265.2489927316374;5946.524278057745;5958.553108516879;5981.192539007266;5984.281886173687;5990;5982.760689572456;5982.999999999913;6002;6005.789797357159;6007.309159446632;5718.771249149988;5938.970305148447;5976.402359763989;5978.461938425476;5988.550858685703;5865.824025279248;5872.794452194324;5877.265341832271;5894.440028197314;5908.05471124618;5743.971280143573;5752.71236438168;5757.596968212185;5760.596758226884;5764.221830052889;5969.4627483524955;5975;5987.161797348462;5989.431004054608;6006.699665016819;3921.254961557295;3971.285168669667;3977.065389633376;3979.343408337708;3984.621460961204;5683.7442315095095;5743.310802703535;5803.709814509342;5811.476967072984;5841.853953651193;5609.214709940693;5610.7194640268635;5656.179853921076;5659.179418984307;5662.094064949588;5617.943820561742;5635.830925072254;5659.462351076641;5673;5694.629849059798;5352.4915133062295;5522.061249587499;5548.056830338772;5569.081101618188;5575.107982722745;5626;5631.7184140793615;5672.546196304368;5691.174779657009;5735.8852822944145;5594.216809646734;5607.887842243051;5609.635373700697;5622.465865742748;5640.971795141162 09:37:24 INFO - 2015-10-24 09:37:24,340 DEBUG : BROWSER_OUTPUT: |5;yui.html;590.5187272373016;660.4023358860234;670.9194896612407;678.9728410863565;687.3401534526854;11597.188196826226;11861.466234019468;11869.465874035668;11881.227720198181;11925.224860384069;11056.336619802798;12086.879131208685;12300.876991230085;12305.323207223622;12314.5074197032;698.2145086777375;701.2881924846286;804.4650307545476;835.8244768598602;852.4203541591716;823.567626995829;824.406427372291;839.236294971576;840.2437805974611;846.9110743371949;887.8224355128967;894.2041582991143;895.4940458640847;898.3890954151175;898.8876390451194;714.7105422303976;717.6985666020284;878.6090189865513;884.9823003539957;900.3922352412096;661.5567569728294;669.4109183918121;669.4410167510135;670.9630970296631;672.2672287206968;11567.652970410902;11697.122715796264;11817.35004574748;11826.763464730744;11880.227785193934;9526;9531.428114313094;9747.853782193273;9844.80310393788;9854.458004809732;7576.393888488908;7699.037620297463;7701.961490192569;7921.96039019807;8483.575821208915;2867.2688464441644;2932.0910517739358;2956.2904902823166;3034.013945467732;3047.1924939890946;36861.07847303812;37318.25363492715;37367.25265494702;37434.62565374339;37469.437958430644;7396.630168491554;7419.703211871465;7648.34989025939;7745.070591529053;7760.650770715331;16361;16371.672566548603;16408.015519068893;16410.26153823057;16453.177341133134;5988.101784732325;6039.124326972565;6102.237220347457;6115.694215289218;6162.198914141133;3242.302904875416;3274.721648659843;3314.2708604107056;3346.447836107015;3347.548081009081;2763.157237042681;2771.8198317109727;2792.2042217968187;2796.4407118576364;2801.9299517512227;392.0727479510936;395.9782211978369;409.5904095904096;411.3623882981367;411.8043929133697;484.8933234688363;487.4954422173034;515.4845154845154;538.2598926476095;549.9147632117028;6372.203474565679;6640.136782218281;6677.198736151693;6827.48793840464;6870.862582748417;430.10108872456715;437.40294498009985;472.2679846238317;521.4785214785214;542.3193891665934;3292.8208731357386;3325.700686938187;3328.424007101203;3329;3348.732101431928;42215.57784422117;42534.361984570256;42588;42674.359884601756;43187.56812431898;33545.496817547755;35641.10897227538;35786.64213357833;36071.4589281161;36241.093972650895;31451.52822707661;31646.208844778605;31733;31997.520037198996;32000;6664.500162487736;6825.078614386995;6971.477139214478;7021.087258656342;7166.2475440080125;21919.561608768054;22264.109435622395;22301.219457318915;22309.77690223077;22689.432764181027;30634.84682576662;31164.844175779883;31406;31546.684533154374;31682;6434.131392262172;6475.125858009297;6602.84450221219;6622.337766223339;6709.127813384229;9500.049995000722;9504.23966082698;9615.2307815376;9637.325387222827;9872.40765554069;8380.120087390736;8832.779180520538;8889.19997200255;9047.366684332297;9180.311476639412;8838.07200243965;9136.360454768102;9150.954245228997;9175.77060573491;9219.907800922174;9084;9154.954225228832;9163.129502697233;9244.399114057565;9277.489738064201;7358.167105664251;7475.102987641518;7619.047619047619;7830.647620856961;7870.5671188082915;7274.709011639687;7718.459707820399;7803.804904877424;7832.255935686101;7905.644246008828 09:37:24 INFO - 2015-10-24 09:37:24,340 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:37:24 INFO - 2015-10-24 09:37:24,340 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:37:24 INFO - 2015-10-24 09:37:24,340 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,996 09:37:24 INFO - 2015-10-24 09:37:24,340 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:37:24 INFO - 2015-10-24 09:37:24,340 DEBUG : BROWSER_OUTPUT: __startTimestamp1445704644326__endTimestamp 09:37:24 INFO - 2015-10-24 09:37:24,340 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,340 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:37:24 INFO - 2015-10-24 09:37:24,341 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:37:24 INFO - 2015-10-24 09:37:24,341 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,341 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4911.89 Median:5070.57 stddev:513.04 (10.1%) stddev-sans-first:489.81 09:37:24 INFO - 2015-10-24 09:37:24,342 DEBUG : BROWSER_OUTPUT: Values: 2902.9 2922.5 2934.8 2968.9 2982.8 4900.1 4986.6 5044.6 5076.6 5120.8 4947.6 4955.8 4968.3 5049.5 5105.6 4588.5 4669.5 4679.4 4687.5 4749.5 4611.4 4649.7 4712.9 4718.7 4797.8 4479.1 4609.8 4662.9 4669.0 4711.2 4614.4 4621.4 4665.3 4665.7 4695.1 4629.5 4667.1 4678.8 4700.3 4700.3 4817.1 4916.1 4979.5 4983.4 5040.3 5014.5 5095.4 5142.3 5221.6 5235.5 5238.6 5254.0 5297.4 5307.4 5372.3 4674.1 4895.8 4912.2 4924.1 4981.1 5197.7 5335.9 5346.2 5347.7 5436.5 5086.4 5153.3 5154.3 5157.4 5202.2 5086.1 5248.3 5260.9 5281.7 5358.4 4924.5 4975.1 5016.9 5196.1 5219.0 5192.7 5201.2 5214.3 5248.6 5251.2 3982.5 4084.5 4102.5 4102.9 4135.3 3474.7 3563.5 3614.8 3629.8 3637.7 4907.4 4908.5 4943.0 4950.0 4964.8 5163.7 5260.3 5304.8 5308.8 5331.5 4832.5 4854.2 4867.4 4879.1 4952.9 4636.1 4637.3 4691.8 4709.6 4714.6 5174.6 5330.7 5360.2 5381.4 5439.6 5222.6 5256.5 5264.3 5266.1 5271.0 5347.3 5365.9 5369.4 5374.6 5388.2 5030.8 5158.2 5175.6 5228.5 5268.0 5235.1 5236.3 5247.7 5304.8 5438.8 5047.7 5156.4 5166.6 5172.0 5213.3 4981.7 5154.4 5156.2 5163.4 5175.3 5001.3 5059.3 5070.6 5119.8 5131.2 5215.1 5216.3 5226.1 5227.5 5296.5 4855.2 5107.3 5119.5 5123.7 5126.4 09:37:24 INFO - 2015-10-24 09:37:24,342 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,342 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42845.04 Median:29866.63 stddev:72317.10 (242.1%) stddev-sans-first:72449.99 09:37:24 INFO - 2015-10-24 09:37:24,344 DEBUG : BROWSER_OUTPUT: Values: 473.1 474.7 479.7 480.0 501.4 29195.8 29756.3 36091.8 36567.8 36606.8 38525.6 39003.6 39076.2 39090.6 39092.4 7539.3 7672.8 8226.6 8448.3 8457.6 10045.1 10264.4 10289.1 10291.7 10297.2 10063.0 10179.8 10198.2 10208.4 10211.9 7671.7 7883.4 9993.9 10000.3 10331.3 9870.4 10048.1 10051.7 10068.3 10119.8 35900.0 36287.2 36384.8 36401.5 36457.5 2537.7 2702.2 2959.3 3257.6 3274.9 24821.6 25349.5 25455.6 25504.4 25572.9 2120.8 2135.2 2152.8 2156.7 2236.8 232201.0 235024.0 235501.0 235999.0 236576.0 49882.5 50999.7 53694.0 58255.7 59538.5 54326.7 54442.2 55098.2 55252.4 55376.4 14622.3 14681.4 14833.5 14923.3 15080.2 11154.8 11306.3 11309.3 11324.0 11444.3 16950.7 16957.1 16959.7 16982.8 16990.5 7274.6 7486.7 7499.0 7503.0 7539.7 751.9 774.1 790.9 807.9 862.8 23875.5 23962.4 24025.4 25054.2 25090.7 878.8 931.6 946.6 1034.4 1040.4 13166.9 13229.5 13360.9 14150.6 14647.7 304746.0 308389.0 308508.0 308938.0 312033.0 50318.7 50343.7 50347.0 50495.7 50628.7 1221.1 1222.6 1249.7 1251.2 1255.3 25452.9 25845.6 26071.5 26081.9 26090.9 43482.8 43845.7 43848.0 43924.8 43956.0 279968.0 280102.0 280917.0 281094.0 281291.0 26729.7 28553.6 29160.0 29231.5 29232.9 35041.3 35256.3 35918.8 36053.1 36176.6 30124.4 31964.7 32134.4 32380.7 32398.2 31220.5 31556.8 32011.6 32070.7 32092.5 30747.0 31099.5 31159.4 31369.7 31458.5 26077.9 28285.9 28639.4 29977.0 30088.0 21629.5 21692.0 21807.8 21882.5 22073.8 09:37:24 INFO - 2015-10-24 09:37:24,344 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,344 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23715.41 Median:4943.67 stddev:75032.69 (1517.8%) stddev-sans-first:75222.58 09:37:24 INFO - 2015-10-24 09:37:24,345 DEBUG : BROWSER_OUTPUT: Values: 303.4 325.2 325.2 328.3 330.8 12838.1 13243.5 15884.5 15911.8 16409.7 15885.3 16035.1 16357.8 16368.2 16401.8 3614.0 3730.7 3849.7 4990.5 5004.9 3703.6 5418.7 5573.3 5599.4 5603.7 5351.2 5464.3 5510.8 5536.2 5540.4 5002.1 5007.0 5016.3 5041.0 5042.0 4399.4 4423.3 4432.4 4443.8 4584.9 19147.0 19285.6 19456.0 19646.2 19718.3 1755.2 1788.2 1802.8 1881.0 1951.8 8035.0 8485.9 12354.8 12580.0 12709.5 1344.6 1382.9 1392.5 1401.2 1430.5 50359.0 52493.2 52824.7 55521.7 55966.0 5741.6 5839.4 5840.8 5842.9 5882.2 6753.7 6790.9 6802.6 6833.6 6872.8 4628.7 4667.7 4696.6 4783.4 4896.8 5108.6 5169.8 5180.8 5204.9 5218.2 2485.4 2527.7 2595.9 2614.1 2652.0 925.2 925.3 938.5 942.6 985.0 369.7 386.5 394.7 396.1 427.2 8586.0 10140.0 10600.6 10695.4 10738.9 407.7 408.8 413.9 431.4 447.5 5496.7 5571.8 5706.3 5744.1 5771.3 448293.0 456678.0 458474.0 460558.0 465075.0 65083.0 65303.0 65372.7 66909.0 67550.3 418.1 433.7 452.3 466.2 467.0 9656.8 9691.4 9744.9 9905.7 9920.6 29232.1 30427.4 30602.4 32507.7 33001.7 43783.3 44226.0 44666.3 44777.8 45204.5 5656.0 5673.4 5684.5 5711.9 5724.5 10528.9 10582.8 10609.6 10698.9 10736.7 9037.6 9144.1 9241.1 9260.6 9270.0 8818.6 8838.6 8859.3 8973.0 9137.0 9269.7 9339.7 9402.9 9468.2 9509.8 5583.5 5589.5 5600.8 5621.6 5633.1 8950.6 9045.7 9141.7 9256.7 9262.7 09:37:24 INFO - 2015-10-24 09:37:24,345 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,345 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5837.19 Median:3370.70 stddev:3211.67 (95.3%) stddev-sans-first:3202.32 09:37:24 INFO - 2015-10-24 09:37:24,347 DEBUG : BROWSER_OUTPUT: Values: 1268.2 1329.6 1496.9 1504.4 1757.4 7307.7 8012.7 8323.0 8625.3 8657.9 8105.7 8224.4 8306.0 8335.6 8337.0 1924.2 1981.3 2185.6 2219.9 2228.0 2254.1 2286.2 2292.2 2306.2 2312.0 2213.8 2237.9 2255.5 2257.2 2264.2 1897.6 1990.3 2183.5 2232.7 2244.3 2216.6 2219.5 2229.4 2236.8 2249.2 8534.6 8612.1 8637.4 8643.6 8679.7 5042.8 5134.3 5140.2 5148.6 5151.5 2836.8 2856.4 2907.0 2912.0 2939.6 836.5 837.3 846.7 850.1 862.3 12006.0 12060.9 12064.9 12068.5 12090.9 4486.3 4650.6 4669.3 4703.0 4710.3 10345.7 10350.6 10351.1 10352.7 10362.1 5104.6 5156.8 5159.8 5166.2 5175.6 4590.7 4596.2 4600.9 4611.1 4618.1 3758.0 3761.1 3832.1 3852.7 3860.3 1213.6 1226.7 1231.9 1233.0 1235.8 865.5 867.3 1185.5 1230.7 1246.3 7574.3 7829.2 8019.5 8224.2 8245.5 604.5 605.2 621.7 624.3 632.8 6027.0 6136.2 6159.5 6161.2 6185.7 10270.7 10426.1 10439.7 10462.3 10494.5 10054.4 10321.9 10354.7 10359.5 10368.3 7730.1 7856.0 7860.6 7865.2 7877.6 7500.2 7553.8 7590.2 7625.8 7637.4 8832.7 8922.0 9041.5 9060.6 9103.4 8983.1 9316.2 9335.6 9391.3 9410.4 7344.9 7383.2 7404.9 7407.1 7436.3 7961.4 8172.5 8175.9 8184.4 8185.4 7444.2 7531.8 7563.3 7625.8 7688.2 7360.5 7390.3 7453.4 7502.6 7546.7 6830.7 7163.6 7484.9 7717.3 7732.5 6668.8 6753.4 6797.0 6799.3 6810.7 6783.2 6934.5 7054.0 7057.6 7074.3 09:37:24 INFO - 2015-10-24 09:37:24,347 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,347 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4779.82 Median:5476.16 stddev:1401.67 (25.6%) stddev-sans-first:1364.71 09:37:24 INFO - 2015-10-24 09:37:24,347 DEBUG : BROWSER_OUTPUT: Values: 301.5 304.4 307.3 315.1 316.2 5542.9 5549.1 5564.8 5565.1 5579.1 5426.3 5464.7 5487.6 5490.3 5490.4 4322.0 4348.4 4359.3 4370.7 4402.0 4173.8 4229.4 4342.7 4375.3 4394.5 4179.2 4210.9 4262.9 4267.1 4298.4 4306.6 4318.9 4322.7 4326.4 4369.8 3777.2 3782.4 3782.7 3784.7 3785.2 5157.4 5277.8 5280.5 5367.1 5382.2 4656.2 4660.4 4673.4 4691.3 4701.6 5565.9 5577.6 5579.5 5582.1 5606.1 3840.8 3946.8 3950.9 3958.9 3964.0 5938.1 5966.7 5968.5 5976.3 6006.8 4064.6 4084.0 4090.6 4098.4 4117.7 3923.8 4000.9 4057.1 4183.4 4190.8 4642.8 4677.6 4681.2 4690.1 4722.6 5590.6 5599.4 5606.0 5608.0 5633.1 1474.4 1486.8 1488.2 1491.6 1495.1 981.8 990.5 1017.4 1023.0 1027.2 5416.0 5418.3 5420.8 5423.5 5429.5 5887.9 5889.0 5890.8 5892.8 5899.9 5404.9 5417.1 5427.4 5430.9 5439.7 3138.4 3217.7 3236.8 3243.8 3265.2 5946.5 5958.6 5981.2 5984.3 5990.0 5982.8 5983.0 6002.0 6005.8 6007.3 5718.8 5939.0 5976.4 5978.5 5988.6 5865.8 5872.8 5877.3 5894.4 5908.1 5744.0 5752.7 5757.6 5760.6 5764.2 5969.5 5975.0 5987.2 5989.4 6006.7 3921.3 3971.3 3977.1 3979.3 3984.6 5683.7 5743.3 5803.7 5811.5 5841.9 5609.2 5610.7 5656.2 5659.2 5662.1 5617.9 5635.8 5659.5 5673.0 5694.6 5352.5 5522.1 5548.1 5569.1 5575.1 5626.0 5631.7 5672.5 5691.2 5735.9 5594.2 5607.9 5609.6 5622.5 5641.0 09:37:24 INFO - 2015-10-24 09:37:24,347 DEBUG : BROWSER_OUTPUT: 09:37:24 INFO - 2015-10-24 09:37:24,349 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10408.86 Median:6267.20 stddev:11371.87 (181.5%) stddev-sans-first:11379.87 09:37:24 INFO - 2015-10-24 09:37:24,349 DEBUG : BROWSER_OUTPUT: Values: 590.5 660.4 670.9 679.0 687.3 11597.2 11861.5 11869.5 11881.2 11925.2 11056.3 12086.9 12300.9 12305.3 12314.5 698.2 701.3 804.5 835.8 852.4 823.6 824.4 839.2 840.2 846.9 887.8 894.2 895.5 898.4 898.9 714.7 717.7 878.6 885.0 900.4 661.6 669.4 669.4 671.0 672.3 11567.7 11697.1 11817.4 11826.8 11880.2 9526.0 9531.4 9747.9 9844.8 9854.5 7576.4 7699.0 7702.0 7922.0 8483.6 2867.3 2932.1 2956.3 3034.0 3047.2 36861.1 37318.3 37367.3 37434.6 37469.4 7396.6 7419.7 7648.3 7745.1 7760.7 16361.0 16371.7 16408.0 16410.3 16453.2 5988.1 6039.1 6102.2 6115.7 6162.2 3242.3 3274.7 3314.3 3346.4 3347.5 2763.2 2771.8 2792.2 2796.4 2801.9 392.1 396.0 409.6 411.4 411.8 484.9 487.5 515.5 538.3 549.9 6372.2 6640.1 6677.2 6827.5 6870.9 430.1 437.4 472.3 521.5 542.3 3292.8 3325.7 3328.4 3329.0 3348.7 42215.6 42534.4 42588.0 42674.4 43187.6 33545.5 35641.1 35786.6 36071.5 36241.1 31451.5 31646.2 31733.0 31997.5 32000.0 6664.5 6825.1 6971.5 7021.1 7166.2 21919.6 22264.1 22301.2 22309.8 22689.4 30634.8 31164.8 31406.0 31546.7 31682.0 6434.1 6475.1 6602.8 6622.3 6709.1 9500.0 9504.2 9615.2 9637.3 9872.4 8380.1 8832.8 8889.2 9047.4 9180.3 8838.1 9136.4 9151.0 9175.8 9219.9 9084.0 9155.0 9163.1 9244.4 9277.5 7358.2 7475.1 7619.0 7830.6 7870.6 7274.7 7718.5 7803.8 7832.3 7905.6 09:37:24 INFO - 2015-10-24 09:37:24,349 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:37:24 INFO - 2015-10-24 09:37:24,349 DEBUG : BROWSER_OUTPUT: 09:37:25 INFO - 2015-10-24 09:37:25,021 INFO : Browser exited with error code: 0 09:37:25 INFO - 2015-10-24 09:37:25,052 INFO : Completed test dromaeo_css (00:18:36) 09:37:25 INFO - 2015-10-24 09:37:25,052 INFO : Starting test kraken 09:37:25 INFO - 2015-10-24 09:37:25,052 DEBUG : operating with platform_type : mac_ 09:37:25 INFO - 2015-10-24 09:37:25,052 INFO : Initialising browser for kraken test... 09:37:25 INFO - 2015-10-24 09:37:25,066 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpCbCC1Q/profile http://localhost:49268/getInfo.html 09:37:27 INFO - 2015-10-24 09:37:27,451 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:37:27 INFO - 2015-10-24 09:37:27,453 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:37:27 INFO - 2015-10-24 09:37:27,453 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:37:27 INFO - 2015-10-24 09:37:27,453 DEBUG : BROWSER_OUTPUT: __metrics 09:37:27 INFO - 2015-10-24 09:37:27,473 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:28 INFO - 2015-10-24 09:37:28,246 INFO : Browser initialized. 09:37:28 INFO - 2015-10-24 09:37:28,246 INFO : Running cycle 1/1 for kraken test... 09:37:28 INFO - 2015-10-24 09:37:28,246 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpCbCC1Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:37:40 INFO - 2015-10-24 09:37:40,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 222404608 09:37:40 INFO - 2015-10-24 09:37:40,215 DEBUG : BROWSER_OUTPUT: 09:37:42 INFO - 2015-10-24 09:37:42,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 09:37:43 INFO - 2015-10-24 09:37:43,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 272171008 09:37:43 INFO - 2015-10-24 09:37:43,449 DEBUG : BROWSER_OUTPUT: 09:37:46 INFO - 2015-10-24 09:37:46,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 09:37:46 INFO - 2015-10-24 09:37:46,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 271990784 09:37:46 INFO - 2015-10-24 09:37:46,932 DEBUG : BROWSER_OUTPUT: 09:37:50 INFO - 2015-10-24 09:37:50,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 09:37:50 INFO - 2015-10-24 09:37:50,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 258613248 09:37:50 INFO - 2015-10-24 09:37:50,723 DEBUG : BROWSER_OUTPUT: 09:37:52 INFO - 2015-10-24 09:37:52,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 09:37:53 INFO - 2015-10-24 09:37:53,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 262000640 09:37:53 INFO - 2015-10-24 09:37:53,473 DEBUG : BROWSER_OUTPUT: 09:37:55 INFO - 2015-10-24 09:37:55,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:37:56 INFO - 2015-10-24 09:37:56,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 265875456 09:37:56 INFO - 2015-10-24 09:37:56,494 DEBUG : BROWSER_OUTPUT: 09:37:59 INFO - 2015-10-24 09:37:59,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:00 INFO - 2015-10-24 09:38:00,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 263352320 09:38:00 INFO - 2015-10-24 09:38:00,407 DEBUG : BROWSER_OUTPUT: 09:38:03 INFO - 2015-10-24 09:38:03,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:04 INFO - 2015-10-24 09:38:04,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 263917568 09:38:04 INFO - 2015-10-24 09:38:04,417 DEBUG : BROWSER_OUTPUT: 09:38:07 INFO - 2015-10-24 09:38:07,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 09:38:08 INFO - 2015-10-24 09:38:08,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 262987776 09:38:08 INFO - 2015-10-24 09:38:08,129 DEBUG : BROWSER_OUTPUT: 09:38:09 INFO - 2015-10-24 09:38:09,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:10 INFO - 2015-10-24 09:38:10,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 294871040 09:38:10 INFO - 2015-10-24 09:38:10,391 DEBUG : BROWSER_OUTPUT: 09:38:12 INFO - 2015-10-24 09:38:12,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:12 INFO - 2015-10-24 09:38:12,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 300556288 09:38:12 INFO - 2015-10-24 09:38:12,839 DEBUG : BROWSER_OUTPUT: 09:38:15 INFO - 2015-10-24 09:38:15,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:15 INFO - 2015-10-24 09:38:15,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 310181888 09:38:15 INFO - 2015-10-24 09:38:15,663 DEBUG : BROWSER_OUTPUT: 09:38:18 INFO - 2015-10-24 09:38:18,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:19 INFO - 2015-10-24 09:38:19,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 311324672 09:38:19 INFO - 2015-10-24 09:38:19,037 DEBUG : BROWSER_OUTPUT: 09:38:21 INFO - 2015-10-24 09:38:21,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:22 INFO - 2015-10-24 09:38:22,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 308146176 09:38:22 INFO - 2015-10-24 09:38:22,398 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 09:38:24 INFO - 2015-10-24 09:38:24,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 362602496 09:38:24 INFO - 2015-10-24 09:38:24,499 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,499 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;108;112;115;111;107;107;120;117 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;158;170;182;160;157;158;160;182;157 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: |2;audio-dft;172;178;211;184;178;178;177;172;180;179 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;90;92;95;86;90;89;91;94;89 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;111;117;156;115;118;119;143;116;118;136 09:38:24 INFO - 2015-10-24 09:38:24,500 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;131;130;136;135;130;139;142;136;135 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;142;141;141;142;142;142;141;147;141 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;113;119;116;114;114;114;118;117;113;114 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;64;67;69;68;69;72;78;67;68 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;68;72;72;69;72;72;71;72;72 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;96;95;97;102;99;98;94;97;96 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;142;141;146;142;148;138;152;143;148;138 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;171;167;158;169;168;169;165;167;157 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;79;81;81;81;81;81;81;81;81 09:38:24 INFO - 2015-10-24 09:38:24,501 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,885 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: __startTimestamp1445704704491__endTimestamp 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.37 (3.9%) stddev-sans-first:4.59 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 108.0 112.0 115.0 111.0 107.0 107.0 120.0 117.0 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:163.30 Median:160.00 stddev:11.09 (6.9%) stddev-sans-first:10.48 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: Values: 149.0 158.0 170.0 182.0 160.0 157.0 158.0 160.0 182.0 157.0 09:38:24 INFO - 2015-10-24 09:38:24,502 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:180.90 Median:178.50 stddev:11.15 (6.2%) stddev-sans-first:11.35 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: Values: 172.0 178.0 211.0 184.0 178.0 178.0 177.0 172.0 180.0 179.0 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.10 Median:90.50 stddev:3.14 (3.5%) stddev-sans-first:2.74 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: Values: 85.0 90.0 92.0 95.0 86.0 90.0 89.0 91.0 94.0 89.0 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:124.90 Median:118.50 stddev:14.84 (12.5%) stddev-sans-first:14.86 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: Values: 111.0 117.0 156.0 115.0 118.0 119.0 143.0 116.0 118.0 136.0 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:135.00 Median:136.00 stddev:3.86 (2.8%) stddev-sans-first:4.08 09:38:24 INFO - 2015-10-24 09:38:24,503 DEBUG : BROWSER_OUTPUT: Values: 136.0 131.0 130.0 136.0 135.0 130.0 139.0 142.0 136.0 135.0 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:142.00 Median:142.00 stddev:1.83 (1.3%) stddev-sans-first:1.90 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: Values: 141.0 142.0 141.0 141.0 142.0 142.0 142.0 141.0 147.0 141.0 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:115.20 Median:115.00 stddev:2.15 (1.9%) stddev-sans-first:2.13 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: Values: 113.0 119.0 116.0 114.0 114.0 114.0 118.0 117.0 113.0 114.0 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.40 Median:68.50 stddev:4.35 (6.4%) stddev-sans-first:3.95 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: Values: 62.0 64.0 67.0 69.0 68.0 69.0 72.0 78.0 67.0 68.0 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:72.00 stddev:2.17 (3.0%) stddev-sans-first:1.54 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 72.0 72.0 69.0 72.0 72.0 71.0 72.0 72.0 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.60 Median:96.50 stddev:2.76 (2.9%) stddev-sans-first:2.37 09:38:24 INFO - 2015-10-24 09:38:24,504 DEBUG : BROWSER_OUTPUT: Values: 92.0 96.0 95.0 97.0 102.0 99.0 98.0 94.0 97.0 96.0 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:144.50 stddev:4.59 (3.2%) stddev-sans-first:4.82 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 146.0 142.0 148.0 138.0 152.0 143.0 148.0 138.0 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:167.50 stddev:7.51 (4.5%) stddev-sans-first:4.92 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: Values: 147.0 171.0 167.0 158.0 169.0 168.0 169.0 165.0 167.0 157.0 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.20 Median:81.00 stddev:1.93 (2.4%) stddev-sans-first:0.67 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: Values: 75.0 79.0 81.0 81.0 81.0 81.0 81.0 81.0 81.0 81.0 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:38:24 INFO - 2015-10-24 09:38:24,505 DEBUG : BROWSER_OUTPUT: 09:38:25 INFO - 2015-10-24 09:38:25,211 INFO : Browser exited with error code: 0 09:38:25 INFO - 2015-10-24 09:38:25,262 INFO : Completed test kraken (00:01:00) 09:38:25 INFO - 2015-10-24 09:38:25,262 INFO : Starting test v8_7 09:38:25 INFO - 2015-10-24 09:38:25,262 DEBUG : operating with platform_type : mac_ 09:38:25 INFO - 2015-10-24 09:38:25,263 INFO : Initialising browser for v8_7 test... 09:38:25 INFO - 2015-10-24 09:38:25,276 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpiV5Ble/profile http://localhost:49268/getInfo.html 09:38:27 INFO - 2015-10-24 09:38:27,601 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:38:27 INFO - 2015-10-24 09:38:27,602 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:38:27 INFO - 2015-10-24 09:38:27,602 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:38:27 INFO - 2015-10-24 09:38:27,602 DEBUG : BROWSER_OUTPUT: __metrics 09:38:27 INFO - 2015-10-24 09:38:27,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] 09:38:28 INFO - 2015-10-24 09:38:28,352 INFO : Browser initialized. 09:38:28 INFO - 2015-10-24 09:38:28,352 INFO : Running cycle 1/1 for v8_7 test... 09:38:28 INFO - 2015-10-24 09:38:28,352 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpiV5Ble/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:38:40 INFO - 2015-10-24 09:38:40,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 222445568 09:38:40 INFO - 2015-10-24 09:38:40,313 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/v8_7/run.html (next: http://localhost:49268/tests/v8_7/run.html) 09:39:03 INFO - 2015-10-24 09:39:03,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 673476608 09:39:03 INFO - 2015-10-24 09:39:03,399 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,399 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:39:03 INFO - 2015-10-24 09:39:03,399 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:39:03 INFO - 2015-10-24 09:39:03,399 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:39:03 INFO - 2015-10-24 09:39:03,399 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:39:03 INFO - 2015-10-24 09:39:03,399 DEBUG : BROWSER_OUTPUT: |0;Richards;176.18040873854827 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;214.36227224008576 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |2;Encrypt;354.98757543485976 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6493.506493506494 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2280.1822323462416 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |5;Earley;1002.0040080160321 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |6;Boyer;14013.888888888889 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |7;RegExp;33016.39344262295 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |8;Splay;856.1643835616438 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6375.796178343949 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: __startTimestamp1445704743390__endTimestamp 09:39:03 INFO - 2015-10-24 09:39:03,400 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:176.18 Median:176.18 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: Values: 176.2 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:214.36 Median:214.36 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: Values: 214.4 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:354.99 Median:354.99 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: Values: 355.0 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6493.51 Median:6493.51 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: Values: 6493.5 09:39:03 INFO - 2015-10-24 09:39:03,401 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2280.18 Median:2280.18 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: Values: 2280.2 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1002.00 Median:1002.00 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: Values: 1002.0 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14013.89 Median:14013.89 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: Values: 14013.9 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33016.39 Median:33016.39 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: Values: 33016.4 09:39:03 INFO - 2015-10-24 09:39:03,402 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,403 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:856.16 Median:856.16 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,403 DEBUG : BROWSER_OUTPUT: Values: 856.2 09:39:03 INFO - 2015-10-24 09:39:03,403 DEBUG : BROWSER_OUTPUT: 09:39:03 INFO - 2015-10-24 09:39:03,403 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6375.80 Median:6375.80 stddev:0.00 (0.0%) 09:39:03 INFO - 2015-10-24 09:39:03,403 DEBUG : BROWSER_OUTPUT: Values: 6375.8 09:39:03 INFO - 2015-10-24 09:39:03,403 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:39:03 INFO - 2015-10-24 09:39:03,403 DEBUG : BROWSER_OUTPUT: 09:39:04 INFO - 2015-10-24 09:39:04,110 INFO : Browser exited with error code: 0 09:39:04 INFO - 2015-10-24 09:39:04,133 INFO : Completed test v8_7 (00:00:38) 09:39:04 INFO - 2015-10-24 09:39:04,195 INFO : Completed test suite (00:20:15) 09:39:04 INFO - 2015-10-24 09:39:04,196 DEBUG : Working with test: dromaeo_css 09:39:04 INFO - 2015-10-24 09:39:04,196 DEBUG : Generating results file: dromaeo_css 09:39:04 INFO - 2015-10-24 09:39:04,196 DEBUG : Working with test: kraken 09:39:04 INFO - 2015-10-24 09:39:04,196 DEBUG : Generating results file: kraken 09:39:04 INFO - 2015-10-24 09:39:04,197 INFO : javascript benchmark 09:39:04 INFO - 2015-10-24 09:39:04,197 DEBUG : Working with test: v8_7 09:39:04 INFO - 2015-10-24 09:39:04,197 DEBUG : Generating results file: v8_7 09:39:04 INFO - 2015-10-24 09:39:04,197 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:39:04 INFO - 2015-10-24 09:39:04,248 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 09:39:04 INFO - 2015-10-24 09:39:04,248 DEBUG : process_Request line: dromaeo_css 6120.04 graph.html#tests=[[72,63,55]] 09:39:04 INFO - 2015-10-24 09:39:04,248 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:39:04 INFO - 2015-10-24 09:39:04,279 DEBUG : process_Request line: kraken 1686.50 graph.html#tests=[[232,63,55]] 09:39:04 INFO - 2015-10-24 09:39:04,279 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:39:04 INFO - 2015-10-24 09:39:04,309 DEBUG : process_Request line: v8_7 16207.19 graph.html#tests=[[230,63,55]] 09:39:04 INFO - 2015-10-24 09:39:04,310 INFO : javascript benchmark 09:39:04 INFO - 2015-10-24 09:39:04,312 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [303.43560976583564, 325.18216685037135, 325.18541054658095, 328.2712378519685, 330.80978437398494, 12838.101332906688, 13243.536476223335, 15884.52346429606, 15911.761323580156, 16409.671806563863, 15885.285162167702, 16035.118068506228, 16357.83642163581, 16368.181590920465, 16401.83598164018, 3614.0, 3730.7388482806214, 3849.6727778138893, 4990.525900039509, 5004.924926126111, 3703.6481534254203, 5418.674879507243, 5573.331200255975, 5599.41206173352, 5603.663780173202, 5351.197320401932, 5464.3442786865435, 5510.8071217507395, 5536.169574563827, 5540.445955404468, 5002.124628190052, 5007.0, 5016.29771831942, 5041.017001684673, 5042.0, 4399.38408622793, 4423.292273236299, 4432.445944256968, 4443.844465443694, 4584.885377865547, 19147.0, 19285.614287714307, 19456.0, 19646.214151433924, 19718.309859155004, 1755.1662960093981, 1788.150628451475, 1802.774653168354, 1881.0, 1951.7853036166011, 8034.959825200836, 8485.915140848574, 12354.75290494185, 12580.0, 12709.491620335175, 1344.589900080475, 1382.910110842792, 1392.526540976073, 1401.222321611505, 1430.4921752777823, 50359.0, 52493.21260181101, 52824.73587632076, 55521.72239138778, 55966.0, 5741.626794258444, 5839.386864379179, 5840.795572155039, 5842.912356314659, 5882.205902203234, 6753.729850805913, 6790.8641827164165, 6802.591844489347, 6833.555818871758, 6872.793816185523, 4628.745419001987, 4667.719936803803, 4696.647751418589, 4783.354247176656, 4896.804127834918, 5108.591312694975, 5169.793208271627, 5180.818671346485, 5204.869878252998, 5218.191180367049, 2485.3538080099306, 2527.7093134289794, 2595.935101622437, 2614.058938782075, 2651.9602205966926, 925.2366797392044, 925.2644147902433, 938.5166639180827, 942.5522876633544, 984.9608662860751, 369.680226603991, 386.5419477918619, 394.70199999000573, 396.11665984853937, 427.15636617680457, 8586.0, 10140.0, 10600.575976960989, 10695.358278503314, 10738.926107389354, 407.74515927545286, 408.84259560069586, 413.9172165566899, 431.4046615670355, 447.5032713687804, 5496.697681627469, 5571.804986825442, 5706.315242170883, 5744.080947048452, 5771.278590176228, 448293.0, 456678.0, 458474.0, 460558.0, 465075.0, 65083.0, 65303.0, 65372.67313663401, 66909.0, 67550.3244967544, 418.1469801604753, 433.72891942535915, 452.2537812609221, 466.20279322359147, 466.9929951050737, 9656.758581035248, 9691.370060946016, 9744.902550974399, 9905.653302134391, 9920.603175873173, 29232.123036308945, 30427.39145217039, 30602.387952240384, 32507.674923250466, 33001.66998329986, 43783.34324985192, 44226.0, 44666.3300050506, 44777.77611111924, 45204.54795452135, 5656.038473459439, 5673.375928647928, 5684.488396044376, 5711.914321285267, 5724.542036636975, 10528.894711052792, 10582.788344233226, 10609.575616975235, 10698.8930110701, 10736.677899663022, 9037.634328022641, 9144.131307525775, 9241.075892410705, 9260.629574816932, 9270.0, 8818.647254109765, 8838.646454141763, 8859.335549833917, 8972.955135224282, 9136.95431522838, 9269.67556135559, 9339.719808405758, 9402.858957115786, 9468.195203407788, 9509.762255943657, 5583.525400341016, 5589.524890384363, 5600.831975040755, 5621.550275977994, 5633.0705433603, 8950.552472376225, 9045.728628141167, 9141.725748227564, 9256.72229833106, 9262.675806346746], "dojo.html": [2902.8838846446138, 2922.5470052141927, 2934.80923739957, 2968.940621187576, 2982.8210307381555, 4900.117978763821, 4986.5761410280165, 5044.635546667595, 5076.64463487556, 5120.820771273002, 4947.554720075193, 4955.826546070879, 4968.2795994580765, 5049.520295571924, 5105.566026887719, 4588.541145885401, 4669.509701481346, 4679.391679081715, 4687.484376718576, 4749.525047495257, 4611.423572053493, 4649.697769644979, 4712.882177945545, 4718.669693121483, 4797.760111994404, 4479.126570318789, 4609.7695115244105, 4662.883427914296, 4668.9766551167195, 4711.175544279771, 4614.423197100363, 4621.37611422457, 4665.2768820832825, 4665.650076244261, 4695.084458530588, 4629.467611224719, 4667.089917466095, 4678.812847486097, 4700.271457924027, 4700.271457924027, 4817.060673168733, 4916.0905232532095, 4979.4771548987555, 4983.352164218664, 5040.269160971675, 5014.52362025607, 5095.388553373582, 5142.305788718512, 5221.556167725748, 5235.476452354734, 5238.633295669305, 5254.028004819121, 5297.417284098746, 5307.442718514539, 5372.328458942632, 4674.135284972223, 4895.779689913927, 4912.214045752662, 4924.138275801721, 4981.12830254704, 5197.7141257231215, 5335.86660333487, 5346.1713434417725, 5347.732613369394, 5436.510714035756, 5086.415062267886, 5153.252778347119, 5154.304168937146, 5157.355330583677, 5202.2456743771945, 5086.109930762102, 5248.317718696545, 5260.92108618371, 5281.656692314988, 5358.3837858645975, 4924.507549245119, 4975.104481193348, 5016.949830501721, 5196.090684130262, 5219.0, 5192.662476938987, 5201.245819356172, 5214.296070030573, 5248.553872920768, 5251.238570407269, 3982.5021872265966, 4084.4690190275073, 4102.487189101363, 4102.938455923164, 4135.276326642826, 3474.722022238215, 3563.5367402237544, 3614.8373323200517, 3629.8366573503727, 3637.727170462226, 4907.3620429343955, 4908.4846091160625, 4942.950570494321, 4949.975250123798, 4964.826231081967, 5163.664361816545, 5260.263563101169, 5304.787808487695, 5308.840734777963, 5331.5201631853315, 4832.492588278251, 4854.199057155601, 4867.3915760529935, 4879.072976134523, 4952.851414457572, 4636.142313671981, 4637.304404339376, 4691.7654117294, 4709.552592503706, 4714.6464015199, 5174.6119041071315, 5330.680159190383, 5360.249565060816, 5381.354237491526, 5439.619226654097, 5222.608304377263, 5256.526912577886, 5264.289320941777, 5266.131088370376, 5270.973645131903, 5347.331583552056, 5365.865853353697, 5369.3556773187465, 5374.596905232202, 5388.164834450667, 5030.773615187252, 5158.2004789256225, 5175.637705360588, 5228.477152284741, 5268.0, 5235.136202526541, 5236.266922630911, 5247.685138891678, 5304.814331498379, 5438.75525601341, 5047.722375269395, 5156.381234251914, 5166.612504062286, 5172.017316709813, 5213.270142180022, 4981.676191047571, 5154.355705536808, 5156.226566014978, 5163.3545806774155, 5175.301334319819, 5001.299818025552, 5059.342285502861, 5070.569001634754, 5119.769610367468, 5131.179011358165, 5215.113430716863, 5216.321878155815, 5226.059309324358, 5227.451117632594, 5296.523312901857, 4855.1988921828915, 5107.310513080686, 5119.462456442169, 5123.718195499283, 5126.359205099363], "mootools.html": [1268.2200446725267, 1329.5878277733902, 1496.9072577018776, 1504.3907217576877, 1757.4376199616129, 7307.707691692332, 8012.719554815582, 8322.958385208081, 8625.309975201984, 8657.913420865789, 8105.675772969089, 8224.383171262149, 8306.0, 8335.583220838964, 8336.95831520843, 1924.2110734598816, 1981.2570286142698, 2185.595664802013, 2219.9223027194053, 2227.9888600556974, 2254.0758289101473, 2286.222684287342, 2292.151903795598, 2306.1813056365, 2312.0, 2213.7896899794496, 2237.8881055947218, 2255.5263394687136, 2257.2325409360815, 2264.2075273654173, 1897.5635603811063, 1990.2735501541977, 2183.4759657682202, 2232.693874083663, 2244.3379203135114, 2216.645336746129, 2219.5449932763745, 2229.3869185973826, 2236.7539570647214, 2249.2352600116037, 8534.57327133647, 8612.09572994839, 8637.438566493158, 8643.611037503328, 8679.739607811713, 5042.84871453857, 5134.2812006319145, 5140.177571588565, 5148.613853960968, 5151.459096794858, 2836.773058155343, 2856.4144350408324, 2907.0406765767248, 2911.9708802912123, 2939.6472423309124, 836.4897412578322, 837.2590257621988, 846.6824940647257, 850.1073872433982, 862.3489265604428, 12006.0, 12060.939695301555, 12064.939675301568, 12068.456919438646, 12090.939545302304, 4486.3494793254795, 4650.627949764011, 4669.34629151919, 4702.95297047032, 4710.3405523226775, 10345.741356465998, 10350.585976561004, 10351.06840384354, 10352.689419317432, 10362.067413932631, 5104.642675012714, 5156.845294641167, 5159.819406320761, 5166.173412254097, 5175.637705360664, 4590.724556526619, 4596.2416201326405, 4600.884977875513, 4611.123886461562, 4618.122556714281, 3758.0, 3761.1161377076364, 3832.061145019488, 3852.7303088783515, 3860.2665493556133, 1213.5509861351356, 1226.6565361698738, 1231.9137660363867, 1233.0382301804607, 1235.8393408856791, 865.4720620421538, 867.2628265973872, 1185.5080141741253, 1230.7169351049308, 1246.2833870524485, 7574.280443357872, 7829.177936316719, 8019.478733882279, 8224.218699223564, 8245.546494942715, 604.5345084285076, 605.1618508365857, 621.6922623301405, 624.3475568031328, 632.7975047984601, 6027.0, 6136.23297087864, 6159.5072394208355, 6161.229846269216, 6185.721642526097, 10270.691879243635, 10426.113780328606, 10439.686809395731, 10462.319949203278, 10494.527746251437, 10054.396736195851, 10321.896781032243, 10354.689359319233, 10359.533820978075, 10368.274220804622, 7730.072391313079, 7855.999999999885, 7860.567668778158, 7865.174156713577, 7877.645505952131, 7500.212477689982, 7553.811154721176, 7590.203028681909, 7625.809354766176, 7637.389008879165, 8832.735017949472, 8921.955390223007, 9041.457512549268, 9060.592273347584, 9103.408278461879, 8983.146601072887, 9316.20812230968, 9335.579898904702, 9391.29565282593, 9410.435373877315, 7344.926550734638, 7383.234956225479, 7404.888926665996, 7407.148177959388, 7436.256374362737, 7961.363090952826, 8172.509649421054, 8175.918240817754, 8184.427090103635, 8185.4270201085355, 7444.181140074479, 7531.849363012819, 7563.319301262913, 7625.809354766176, 7688.154303026551, 7360.521566098187, 7390.29792169743, 7453.403727701662, 7502.624868756649, 7546.735864244944, 6830.658467076726, 7163.6060016699585, 7484.850302994018, 7717.2668596483245, 7732.458727888994, 6668.799936001928, 6753.425958793558, 6797.0, 6799.2520822708475, 6810.659467026728, 6783.152105986752, 6934.479914006369, 7053.964730176316, 7057.5651400266825, 7074.292570742885], "ext.html": [473.0727773563815, 474.6795912758888, 479.73854249434055, 479.9880002999922, 501.4459022779826, 29195.83216671333, 29756.256093597673, 36091.819540902325, 36567.81716091422, 36606.8169659152, 38525.61474385255, 39003.60996390035, 39076.21847563047, 39090.60909390905, 39092.41361379575, 7539.283768042027, 7672.769816905502, 8226.629801658924, 8448.281896038814, 8457.57712114395, 10045.146162576153, 10264.384136951769, 10289.073983341497, 10291.691249262534, 10297.227707921898, 10063.04401081896, 10179.796404071914, 10198.184145268398, 10208.387496750182, 10211.897881021207, 7671.654775535114, 7883.408744344197, 9993.850092248622, 10000.299979001473, 10331.32846364984, 9870.407775533418, 10048.145907597864, 10051.69844904654, 10068.345557538736, 10119.848202276971, 35900.0, 36287.18564071786, 36384.818075909716, 36401.45397819035, 36457.45313820268, 2537.7335379785227, 2702.2433718558837, 2959.2601849537614, 3257.5602293690285, 3274.918127046819, 24821.62767558488, 25349.493010139693, 25455.61816572753, 25504.36239094019, 25572.872135639387, 2120.809127178546, 2135.1993002624017, 2152.7739587343417, 2156.7304086989125, 2236.8434209605334, 232201.0, 235023.99999999828, 235501.0, 235999.0, 236576.0, 49882.50117498779, 50999.7450012755, 53694.0, 58255.70872145612, 59538.53460990443, 54326.728366357915, 54442.18336724952, 55098.17352739712, 55252.44747552473, 55376.44623553794, 14622.318433380085, 14681.41274349014, 14833.480828170963, 14923.253837308092, 15080.170590617621, 11154.776904462027, 11306.265092768943, 11309.321440713584, 11324.0, 11444.313341199555, 16950.745738813926, 16957.067361295, 16959.660806784043, 16982.830171698126, 16990.490285291213, 7274.636268186676, 7486.700531978769, 7498.962505187548, 7503.0, 7539.698412063456, 751.9060117485315, 774.0711146623961, 790.920907909216, 807.8707406814881, 862.8058686795421, 23875.522489550112, 23962.40093997664, 24025.399365015666, 25054.248372548853, 25090.749092508842, 878.8198419324024, 931.6413180925257, 946.6071580294239, 1034.425893629043, 1040.3965699894043, 13166.934165329303, 13229.536966206137, 13360.93319533396, 14150.64623384403, 14647.707045859022, 304746.0, 308389.0, 308508.0, 308938.0, 312033.0, 50318.748406257735, 50343.74828125909, 50347.0, 50495.74752126216, 50628.74685626548, 1221.0597839663587, 1222.602654137409, 1249.7063190150125, 1251.2429979862234, 1255.3033066647915, 25452.872735636945, 25845.612315814902, 26071.478570428866, 26081.869590651924, 26090.86954565215, 43482.782586088135, 43845.71157163162, 43848.0, 43924.780376097915, 43956.0, 279968.0, 280102.0, 280917.0, 281094.0, 281291.0, 26729.732702672725, 28553.571696424984, 29160.0, 29231.46912228608, 29232.853835730686, 35041.29917401587, 35256.29487410289, 35918.8204058978, 36053.09867253339, 36176.63823361838, 30124.3975120492, 31964.68035319617, 32134.357312853146, 32380.676193237767, 32398.19004524906, 31220.531692024182, 31556.842215789693, 32011.559479822998, 32070.67929320677, 32092.518612220367, 30747.0, 31099.533506997865, 31159.376812464077, 31369.686303136677, 31458.528122078646, 26077.869610651825, 28285.858570707016, 28639.427211455237, 29977.0, 30088.0, 21629.459263518536, 21692.0, 21807.78192218121, 21882.45293867666, 22073.779262207172], "prototype.html": [301.4799470912676, 304.3972933591489, 307.30702266389295, 315.1286692295801, 316.17005360927567, 5542.944570554293, 5549.084401073823, 5564.777408903649, 5565.053940830064, 5579.107342825148, 5426.348838139429, 5464.672119672822, 5487.64330318529, 5490.286262785832, 5490.423505531911, 4321.956780432202, 4348.391225228463, 4359.324304732756, 4370.737755734666, 4402.031553058338, 4173.791310434466, 4229.407882896397, 4342.652587792984, 4375.278079116942, 4394.450693663292, 4179.226843034048, 4210.915781684364, 4262.9147417051645, 4267.103908179271, 4298.419713338706, 4306.569343065668, 4318.913621727548, 4322.7190232634775, 4326.351047342908, 4369.825206991716, 3777.1501412182315, 3782.3569993101237, 3782.6973842092566, 3784.678302344304, 3785.167263202091, 5157.381114266312, 5277.815276465343, 5280.471952804727, 5367.114426119686, 5382.219578161144, 4656.185167595657, 4660.440747110369, 4673.415823022122, 4691.272852707836, 4701.647376446746, 5565.888682226333, 5577.581681373913, 5579.525740312038, 5582.106862901916, 5606.131049687305, 3840.807959602009, 3946.842126314944, 3950.881473555798, 3958.940615890764, 3964.0486283291802, 5938.138969849391, 5966.731497082642, 5968.492678122365, 5976.342602313742, 6006.759729610767, 4064.6138616831354, 4083.97958010214, 4090.631843134073, 4098.3852422136915, 4117.732347397409, 3923.7841918694744, 4000.899977500586, 4057.087155390014, 4183.414321994923, 4190.811413486401, 4642.837500687459, 4677.602403795716, 4681.157391669464, 4690.061987602493, 4722.6221902247735, 5590.636608620427, 5599.356074051455, 5606.0, 5608.0, 5633.070543360382, 1474.395497845878, 1486.829014663306, 1488.2038109611306, 1491.6494623763406, 1495.0879963222426, 981.788915383196, 990.4601991914279, 1017.3844823881593, 1022.9641962531275, 1027.1936529824052, 5415.972920135453, 5418.2685337479725, 5420.756065977041, 5423.484768946943, 5429.511343979061, 5887.941120588825, 5889.0283103287475, 5890.823275301748, 5892.793752218652, 5899.852503687356, 5404.945950540523, 5417.106177480671, 5427.402985671573, 5430.945690543044, 5439.728013599304, 3138.3723255348564, 3217.6621454747383, 3236.757243206769, 3243.8378081095852, 3265.2489927316374, 5946.524278057745, 5958.553108516879, 5981.192539007266, 5984.281886173687, 5990.0, 5982.760689572456, 5982.999999999913, 6002.0, 6005.789797357159, 6007.309159446632, 5718.771249149988, 5938.970305148447, 5976.402359763989, 5978.461938425476, 5988.550858685703, 5865.824025279248, 5872.794452194324, 5877.265341832271, 5894.440028197314, 5908.05471124618, 5743.971280143573, 5752.71236438168, 5757.596968212185, 5760.596758226884, 5764.221830052889, 5969.4627483524955, 5975.0, 5987.161797348462, 5989.431004054608, 6006.699665016819, 3921.254961557295, 3971.285168669667, 3977.065389633376, 3979.343408337708, 3984.621460961204, 5683.7442315095095, 5743.310802703535, 5803.709814509342, 5811.476967072984, 5841.853953651193, 5609.214709940693, 5610.7194640268635, 5656.179853921076, 5659.179418984307, 5662.094064949588, 5617.943820561742, 5635.830925072254, 5659.462351076641, 5673.0, 5694.629849059798, 5352.4915133062295, 5522.061249587499, 5548.056830338772, 5569.081101618188, 5575.107982722745, 5626.0, 5631.7184140793615, 5672.546196304368, 5691.174779657009, 5735.8852822944145, 5594.216809646734, 5607.887842243051, 5609.635373700697, 5622.465865742748, 5640.971795141162], "yui.html": [590.5187272373016, 660.4023358860234, 670.9194896612407, 678.9728410863565, 687.3401534526854, 11597.188196826226, 11861.466234019468, 11869.465874035668, 11881.227720198181, 11925.224860384069, 11056.336619802798, 12086.879131208685, 12300.876991230085, 12305.323207223622, 12314.5074197032, 698.2145086777375, 701.2881924846286, 804.4650307545476, 835.8244768598602, 852.4203541591716, 823.567626995829, 824.406427372291, 839.236294971576, 840.2437805974611, 846.9110743371949, 887.8224355128967, 894.2041582991143, 895.4940458640847, 898.3890954151175, 898.8876390451194, 714.7105422303976, 717.6985666020284, 878.6090189865513, 884.9823003539957, 900.3922352412096, 661.5567569728294, 669.4109183918121, 669.4410167510135, 670.9630970296631, 672.2672287206968, 11567.652970410902, 11697.122715796264, 11817.35004574748, 11826.763464730744, 11880.227785193934, 9526.0, 9531.428114313094, 9747.853782193273, 9844.80310393788, 9854.458004809732, 7576.393888488908, 7699.037620297463, 7701.961490192569, 7921.96039019807, 8483.575821208915, 2867.2688464441644, 2932.0910517739358, 2956.2904902823166, 3034.013945467732, 3047.1924939890946, 36861.07847303812, 37318.25363492715, 37367.25265494702, 37434.62565374339, 37469.437958430644, 7396.630168491554, 7419.703211871465, 7648.34989025939, 7745.070591529053, 7760.650770715331, 16361.0, 16371.672566548603, 16408.015519068893, 16410.26153823057, 16453.177341133134, 5988.101784732325, 6039.124326972565, 6102.237220347457, 6115.694215289218, 6162.198914141133, 3242.302904875416, 3274.721648659843, 3314.2708604107056, 3346.447836107015, 3347.548081009081, 2763.157237042681, 2771.8198317109727, 2792.2042217968187, 2796.4407118576364, 2801.9299517512227, 392.0727479510936, 395.9782211978369, 409.5904095904096, 411.3623882981367, 411.8043929133697, 484.8933234688363, 487.4954422173034, 515.4845154845154, 538.2598926476095, 549.9147632117028, 6372.203474565679, 6640.136782218281, 6677.198736151693, 6827.48793840464, 6870.862582748417, 430.10108872456715, 437.40294498009985, 472.2679846238317, 521.4785214785214, 542.3193891665934, 3292.8208731357386, 3325.700686938187, 3328.424007101203, 3329.0, 3348.732101431928, 42215.57784422117, 42534.361984570256, 42588.0, 42674.359884601756, 43187.56812431898, 33545.496817547755, 35641.10897227538, 35786.64213357833, 36071.4589281161, 36241.093972650895, 31451.52822707661, 31646.208844778605, 31733.0, 31997.520037198996, 32000.0, 6664.500162487736, 6825.078614386995, 6971.477139214478, 7021.087258656342, 7166.2475440080125, 21919.561608768054, 22264.109435622395, 22301.219457318915, 22309.77690223077, 22689.432764181027, 30634.84682576662, 31164.844175779883, 31406.0, 31546.684533154374, 31682.0, 6434.131392262172, 6475.125858009297, 6602.84450221219, 6622.337766223339, 6709.127813384229, 9500.049995000722, 9504.23966082698, 9615.2307815376, 9637.325387222827, 9872.40765554069, 8380.120087390736, 8832.779180520538, 8889.19997200255, 9047.366684332297, 9180.311476639412, 8838.07200243965, 9136.360454768102, 9150.954245228997, 9175.77060573491, 9219.907800922174, 9084.0, 9154.954225228832, 9163.129502697233, 9244.399114057565, 9277.489738064201, 7358.167105664251, 7475.102987641518, 7619.047619047619, 7830.647620856961, 7870.5671188082915, 7274.709011639687, 7718.459707820399, 7803.804904877424, 7832.255935686101, 7905.644246008828]}, "summary": {"suite": 6120.041494614563, "subtests": {"jquery.html": {"filtered": 6301.436757716766, "value": 6301.436757716766}, "dojo.html": {"filtered": 4879.876289901285, "value": 4879.876289901285}, "mootools.html": {"filtered": 4600.912314980453, "value": 4600.912314980453}, "ext.html": {"filtered": 16825.348655570036, "value": 16825.348655570036}, "prototype.html": {"filtered": 4327.79949096609, "value": 4327.79949096609}, "yui.html": {"filtered": 5099.936910813961, "value": 5099.936910813961}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0026"}, "testrun": {"date": 1445703527, "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.0a1", "id": "20151024081135", "branch": "Mozilla-Inbound", "revision": "41913aea0fb03d236ecff025467b2e64e263842f"}}, {"talos_counters": {}, "results": {"audio-dft": [172.0, 178.0, 211.0, 184.0, 178.0, 178.0, 177.0, 172.0, 180.0, 179.0], "ai-astar": [110.0, 110.0, 108.0, 112.0, 115.0, 111.0, 107.0, 107.0, 120.0, 117.0], "imaging-gaussian-blur": [136.0, 131.0, 130.0, 136.0, 135.0, 130.0, 139.0, 142.0, 136.0, 135.0], "audio-beat-detection": [149.0, 158.0, 170.0, 182.0, 160.0, 157.0, 158.0, 160.0, 182.0, 157.0], "json-stringify-tinderbox": [66.0, 68.0, 72.0, 72.0, 69.0, 72.0, 72.0, 71.0, 72.0, 72.0], "stanford-crypto-pbkdf2": [147.0, 171.0, 167.0, 158.0, 169.0, 168.0, 169.0, 165.0, 167.0, 157.0], "json-parse-financial": [62.0, 64.0, 67.0, 69.0, 68.0, 69.0, 72.0, 78.0, 67.0, 68.0], "stanford-crypto-sha256-iterative": [75.0, 79.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0], "audio-fft": [85.0, 90.0, 92.0, 95.0, 86.0, 90.0, 89.0, 91.0, 94.0, 89.0], "imaging-darkroom": [141.0, 142.0, 141.0, 141.0, 142.0, 142.0, 142.0, 141.0, 147.0, 141.0], "stanford-crypto-ccm": [142.0, 141.0, 146.0, 142.0, 148.0, 138.0, 152.0, 143.0, 148.0, 138.0], "audio-oscillator": [111.0, 117.0, 156.0, 115.0, 118.0, 119.0, 143.0, 116.0, 118.0, 136.0], "stanford-crypto-aes": [92.0, 96.0, 95.0, 97.0, 102.0, 99.0, 98.0, 94.0, 97.0, 96.0], "imaging-desaturate": [113.0, 119.0, 116.0, 114.0, 114.0, 114.0, 118.0, 117.0, 113.0, 114.0]}, "summary": {"suite": 1686.4999999999998, "subtests": {"audio-fft": {"filtered": 90.1, "value": 90.1}, "stanford-crypto-pbkdf2": {"filtered": 163.8, "value": 163.8}, "audio-beat-detection": {"filtered": 163.3, "value": 163.3}, "stanford-crypto-ccm": {"filtered": 143.8, "value": 143.8}, "imaging-darkroom": {"filtered": 142.0, "value": 142.0}, "json-parse-financial": {"filtered": 68.4, "value": 68.4}, "audio-oscillator": {"filtered": 124.9, "value": 124.9}, "ai-astar": {"filtered": 111.7, "value": 111.7}, "audio-dft": {"filtered": 180.9, "value": 180.9}, "stanford-crypto-sha256-iterative": {"filtered": 80.2, "value": 80.2}, "json-stringify-tinderbox": {"filtered": 70.6, "value": 70.6}, "imaging-gaussian-blur": {"filtered": 135.0, "value": 135.0}, "stanford-crypto-aes": {"filtered": 96.6, "value": 96.6}, "imaging-desaturate": {"filtered": 115.2, "value": 115.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0026"}, "testrun": {"date": 1445703527, "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.0a1", "id": "20151024081135", "branch": "Mozilla-Inbound", "revision": "41913aea0fb03d236ecff025467b2e64e263842f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [214.36227224008576], "Encrypt": [354.98757543485976], "NavierStokes": [6375.796178343949], "Decrypt": [6493.506493506494], "Splay": [856.1643835616438], "Richards": [176.18040873854827], "RegExp": [33016.39344262295], "Earley": [1002.0040080160321], "Boyer": [14013.888888888889], "RayTrace": [2280.1822323462416]}, "summary": {"suite": 16207.186117862057, "subtests": {"DeltaBlue": {"filtered": 308.4404699999999, "value": 308.4404699999999}, "Encrypt": {"filtered": 749.8318770000002, "value": 749.8318770000002}, "NavierStokes": {"filtered": 232.75524475524475, "value": 232.75524475524475}, "Decrypt": {"filtered": 40.991874, "value": 40.991874}, "Splay": {"filtered": 95.18148800000003, "value": 95.18148800000003}, "RegExp": {"filtered": 27.591899205561063, "value": 27.591899205561063}, "Richards": {"filtered": 200.37415199999995, "value": 200.37415199999995}, "Earley": {"filtered": 665.1300739999999, "value": 665.1300739999999}, "Boyer": {"filtered": 47.557320118929674, "value": 47.557320118929674}, "RayTrace": {"filtered": 324.53064035964036, "value": 324.53064035964036}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0026"}, "testrun": {"date": 1445703527, "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.0a1", "id": "20151024081135", "branch": "Mozilla-Inbound", "revision": "41913aea0fb03d236ecff025467b2e64e263842f"}}] 09:39:04 INFO - RETURN: dromaeo_css: 6120.04 09:39:04 INFO - RETURN: kraken: 1686.50 09:39:04 INFO - RETURN: v8_7: 16207.19 09:39:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "16207.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1686.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "6120.04"}}} 09:39:04 INFO - Return code: 0 09:39:04 INFO - # TBPL SUCCESS # 09:39:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:04 INFO - 2015-10-24 09:39:04.446 screenresolution[1662:9999] starting screenresolution argv=screenresolution get 09:39:04 INFO - 2015-10-24 09:39:04.450 screenresolution[1662:9999] Display 0: 1600x1200x32@60 09:39:04 INFO - 2015-10-24 09:39:04.456 screenresolution[1663:10002] starting screenresolution argv=screenresolution list 09:39:04 INFO - Available Modes on Display 0 09:39:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:04 INFO - Intel HD Graphics 3000: 09:39:04 INFO - Chipset Model: Intel HD Graphics 3000 09:39:04 INFO - Type: GPU 09:39:04 INFO - Bus: Built-In 09:39:04 INFO - VRAM (Total): 512 MB 09:39:04 INFO - VRAM (Dynamic, Max): 10 09:39:04 INFO - Vendor: Intel (0x8086) 09:39:04 INFO - Device ID: 0x0116 09:39:04 INFO - Revision ID: 0x0009 09:39:04 INFO - Displays: 09:39:04 INFO - Display: 09:39:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:04 INFO - Display Serial Number: 1600x1200 60 09:39:04 INFO - Main Display: Yes 09:39:04 INFO - Mirror: Off 09:39:04 INFO - Online: Yes 09:39:04 INFO - Rotation: Supported 09:39:04 INFO - Return code: 0 09:39:04 INFO - Running post-action listener: _resource_record_post_action 09:39:04 INFO - Running post-run listener: _resource_record_post_run 09:39:05 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 38671360; Write bytes: 686976000; Read time: 4977; Write time: 44867 09:39:05 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 333564416; Write bytes: 334194688; Read time: 34407; Write time: 6072 09:39:05 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 37786624; Write bytes: 341306368; Read time: 4370; Write time: 38279 09:39:05 INFO - Running post-run listener: _upload_blobber_files 09:39:05 INFO - Blob upload gear active. 09:39:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:39:05 INFO - Copying logs to upload dir... 09:39:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.188271 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-10-24 09:39:08.074090) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-24 09:39:08.077708) ========= 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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010341 build_url: 'https://queue.taskcluster.net/v1/task/k-TpuHEmQ26IlE26xwRq6g/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-24 09:39:08.108440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:39:08.108807) ========= 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.NkzUAGyM3m/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.9Q1SjQ5oFf/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.005447 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:39:08.158228) ========= ========= Started reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-24 09:39:08.158569) ========= ========= Finished reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-24 09:39:10.088494) =========